builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0199 starttime: 1493723608.77 results: success (0) buildid: 20170502020321 builduid: 39e11a909a6f4ff98df74d0e75f5e9f4 revision: a812a96caba20dea7bc3815b71b4784afc6b864b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.768435) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.769179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.769674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.797895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.798636) ========= 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.CsWSHSMy78/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.SWdq3rh3xq/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-02 04:13:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.8M=0.001s 2017-05-02 04:13:28 (11.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142219 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.966492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:28.966822) ========= 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.CsWSHSMy78/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.SWdq3rh3xq/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.029163 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:29.018962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 04:13:29.019313) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a812a96caba20dea7bc3815b71b4784afc6b864b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a812a96caba20dea7bc3815b71b4784afc6b864b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CsWSHSMy78/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.SWdq3rh3xq/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-02 04:13:29,114 truncating revision to first 12 chars 2017-05-02 04:13:29,114 Setting DEBUG logging. 2017-05-02 04:13:29,114 attempt 1/10 2017-05-02 04:13:29,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a812a96caba2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 04:13:30,244 unpacking tar archive at: mozilla-central-a812a96caba2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.408546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 04:13:30.452328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:30.452642) ========= script_repo_revision: a812a96caba20dea7bc3815b71b4784afc6b864b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:30.453025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:30.453334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:30.474848) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-02 04:13:30.475329) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CsWSHSMy78/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.SWdq3rh3xq/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:13:30 INFO - MultiFileLogger online at 20170502 04:13:30 in /builds/slave/test 04:13:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:13:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:30 INFO - {'append_to_log': False, 04:13:30 INFO - 'base_work_dir': '/builds/slave/test', 04:13:30 INFO - 'blob_upload_branch': 'Firefox', 04:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:30 INFO - 'branch': 'Firefox', 04:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:30 INFO - 'config_files': ('talos/mac_config.py',), 04:13:30 INFO - 'default_actions': ('clobber', 04:13:30 INFO - 'read-buildbot-config', 04:13:30 INFO - 'download-and-extract', 04:13:30 INFO - 'populate-webroot', 04:13:30 INFO - 'create-virtualenv', 04:13:30 INFO - 'install', 04:13:30 INFO - 'run-tests'), 04:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:30 INFO - 'download_minidump_stackwalk': True, 04:13:30 INFO - 'download_symbols': 'ondemand', 04:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:30 INFO - 'gecko_profile': False, 04:13:30 INFO - 'gecko_profile_interval': 0, 04:13:30 INFO - 'installer_path': 'installer.exe', 04:13:30 INFO - 'log_level': 'info', 04:13:30 INFO - 'log_name': 'talos', 04:13:30 INFO - 'log_to_console': True, 04:13:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:13:30 INFO - 'opt_config_files': (), 04:13:30 INFO - 'pip_index': False, 04:13:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:30 INFO - 'cmd': ('bash', 04:13:30 INFO - '-c', 04:13:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:30 INFO - 'enabled': True, 04:13:30 INFO - 'halt_on_failure': False, 04:13:30 INFO - 'name': 'check_screen_resolution'},), 04:13:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:30 INFO - 'cmd': ('bash', 04:13:30 INFO - '-c', 04:13:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:30 INFO - 'enabled': True, 04:13:30 INFO - 'halt_on_failure': False, 04:13:30 INFO - 'name': 'check_screen_resolution'},), 04:13:30 INFO - 'run_cmd_checks_enabled': True, 04:13:30 INFO - 'suite': 'dromaeojs-e10s', 04:13:30 INFO - 'system_bits': '32', 04:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:30 INFO - 'title': 't-yosemite-r7-0199', 04:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:30 INFO - 'use_talos_json': True, 04:13:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:30 INFO - 'work_dir': 'build'} 04:13:30 INFO - [mozharness: 2017-05-02 11:13:30.686510Z] Running clobber step. 04:13:30 INFO - Running pre-action listener: _resource_record_pre_action 04:13:30 INFO - Running main action method: clobber 04:13:30 INFO - rmtree: /builds/slave/test/build 04:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:33 INFO - Running post-action listener: _resource_record_post_action 04:13:33 INFO - [mozharness: 2017-05-02 11:13:33.223583Z] Finished clobber step (success) 04:13:33 INFO - [mozharness: 2017-05-02 11:13:33.223722Z] Running read-buildbot-config step. 04:13:33 INFO - Running pre-action listener: _resource_record_pre_action 04:13:33 INFO - Running main action method: read_buildbot_config 04:13:33 INFO - Using buildbot properties: 04:13:33 INFO - { 04:13:33 INFO - "project": "", 04:13:33 INFO - "product": "firefox", 04:13:33 INFO - "script_repo_revision": "production", 04:13:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:13:33 INFO - "repository": "", 04:13:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:13:33 INFO - "buildid": "20170502020321", 04:13:33 INFO - "pgo_build": "False", 04:13:33 INFO - "basedir": "/builds/slave/test", 04:13:33 INFO - "buildnumber": 57, 04:13:33 INFO - "slavename": "t-yosemite-r7-0199", 04:13:33 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:13:33 INFO - "platform": "yosemite_r7", 04:13:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:13:33 INFO - "branch": "mozilla-central", 04:13:33 INFO - "repo_path": "mozilla-central", 04:13:33 INFO - "revision": "a812a96caba20dea7bc3815b71b4784afc6b864b", 04:13:33 INFO - "stage_platform": "macosx64", 04:13:33 INFO - "builduid": "39e11a909a6f4ff98df74d0e75f5e9f4", 04:13:33 INFO - "slavebuilddir": "test" 04:13:33 INFO - } 04:13:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:13:33 INFO - Running post-action listener: _resource_record_post_action 04:13:33 INFO - [mozharness: 2017-05-02 11:13:33.227010Z] Finished read-buildbot-config step (success) 04:13:33 INFO - [mozharness: 2017-05-02 11:13:33.227100Z] Running download-and-extract step. 04:13:33 INFO - Running pre-action listener: _resource_record_pre_action 04:13:33 INFO - Running main action method: download_and_extract 04:13:33 INFO - mkdir: /builds/slave/test/build/tests 04:13:33 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')]} 04:13:33 INFO - trying https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:13:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:13:34 INFO - Downloaded 1325 bytes. 04:13:34 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:13:34 INFO - Using the following test package requirements: 04:13:34 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:13:34 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:13:34 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:13:34 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:13:34 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'jsshell-mac.zip'], 04:13:34 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:13:34 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:13:34 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:13:34 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:13:34 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:13:34 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:34 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:13:34 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:13:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:13:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:13:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:13:36 INFO - Content-Length response header: 52699764 04:13:36 INFO - Bytes received: 52699764 04:13:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:13:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:13:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:13:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:13:54 INFO - Content-Length response header: 52699764 04:13:54 INFO - Bytes received: 52699764 04:14:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:14:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:14:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:14:10 INFO - Content-Length response header: 14408811 04:14:10 INFO - Bytes received: 14408811 04:14:11 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')]} 04:14:11 INFO - trying https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:14:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:14:15 INFO - Downloaded 71248184 bytes. 04:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:14:15 INFO - mkdir: /builds/slave/test/properties 04:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:15 INFO - Contents: 04:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:14:16 INFO - Running post-action listener: _resource_record_post_action 04:14:16 INFO - Running post-action listener: set_extra_try_arguments 04:14:16 INFO - [mozharness: 2017-05-02 11:14:16.375014Z] Finished download-and-extract step (success) 04:14:16 INFO - [mozharness: 2017-05-02 11:14:16.375152Z] Running populate-webroot step. 04:14:16 INFO - Running pre-action listener: _resource_record_pre_action 04:14:16 INFO - Running main action method: populate_webroot 04:14:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:16 INFO - '--tppagecycles', 04:14:16 INFO - '7'], 04:14:16 INFO - 'tests': ['tsvgm']}}, 04:14:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['damp', 'tps']}, 04:14:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'tests': ['damp', 'tps']}, 04:14:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['dromaeo_dom']}, 04:14:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:14:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:14:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['a11yr', 04:14:16 INFO - 'ts_paint', 04:14:16 INFO - 'tpaint', 04:14:16 INFO - 'sessionrestore', 04:14:16 INFO - 'sessionrestore_no_auto_restore', 04:14:16 INFO - 'tabpaint']}, 04:14:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:16 INFO - 'ts_paint', 04:14:16 INFO - 'tpaint', 04:14:16 INFO - 'sessionrestore', 04:14:16 INFO - 'sessionrestore_no_auto_restore', 04:14:16 INFO - 'tabpaint']}, 04:14:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:14:16 INFO - 'ts_paint', 04:14:16 INFO - 'tpaint', 04:14:16 INFO - 'sessionrestore', 04:14:16 INFO - 'sessionrestore_no_auto_restore', 04:14:16 INFO - 'tabpaint']}, 04:14:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:14:16 INFO - 'ts_paint', 04:14:16 INFO - 'tpaint', 04:14:16 INFO - 'sessionrestore', 04:14:16 INFO - 'sessionrestore_no_auto_restore', 04:14:16 INFO - 'tabpaint']}, 04:14:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['a11yr', 04:14:16 INFO - 'ts_paint', 04:14:16 INFO - 'tpaint', 04:14:16 INFO - 'sessionrestore', 04:14:16 INFO - 'sessionrestore_no_auto_restore', 04:14:16 INFO - 'tabpaint']}, 04:14:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['a11yr', 04:14:16 INFO - 'ts_paint', 04:14:16 INFO - 'tpaint', 04:14:16 INFO - 'sessionrestore', 04:14:16 INFO - 'sessionrestore_no_auto_restore', 04:14:16 INFO - 'tabpaint']}, 04:14:16 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:14:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:14:16 INFO - 'bloom_basic_ref']}, 04:14:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['tsvgx', 04:14:16 INFO - 'tsvgr_opacity', 04:14:16 INFO - 'tart', 04:14:16 INFO - 'tscrollx', 04:14:16 INFO - 'cart', 04:14:16 INFO - 'tsvg_static']}, 04:14:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:16 INFO - 'tsvgr_opacity', 04:14:16 INFO - 'tart', 04:14:16 INFO - 'tscrollx', 04:14:16 INFO - 'cart', 04:14:16 INFO - 'tsvg_static']}, 04:14:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'talos_options': ['--disable-e10s'], 04:14:16 INFO - 'tests': ['tp5o']}, 04:14:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:14:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'talos_options': ['--disable-e10s', 04:14:16 INFO - '--xperf_path', 04:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:16 INFO - 'tests': ['tp5n']}, 04:14:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:14:16 INFO - 'talos_options': ['--xperf_path', 04:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:16 INFO - 'tests': ['tp5n']}}, 04:14:16 INFO - 'talos.zip': {'path': '', 04:14:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:16 INFO - Running post-action listener: _resource_record_post_action 04:14:16 INFO - [mozharness: 2017-05-02 11:14:16.393762Z] Finished populate-webroot step (success) 04:14:16 INFO - [mozharness: 2017-05-02 11:14:16.393875Z] Running create-virtualenv step. 04:14:16 INFO - Running pre-action listener: _resource_record_pre_action 04:14:16 INFO - Running main action method: create_virtualenv 04:14:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:14:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:16 INFO - Using real prefix '/tools/python27' 04:14:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:20 INFO - Installing pip.................done. 04:14:20 INFO - Return code: 0 04:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:14:20 INFO - Reading from file tmpfile_stdout 04:14:20 INFO - Output received: 04:14:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:14:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:20 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')]} 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:20 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')]} 04:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:20 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:20 INFO - 'HOME': '/Users/cltbld', 04:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:20 INFO - 'LOGNAME': 'cltbld', 04:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:20 INFO - 'MOZ_NO_REMOTE': '1', 04:14:20 INFO - 'NO_EM_RESTART': '1', 04:14:20 INFO - 'PAGER': '/bin/cat', 04:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:20 INFO - 'PWD': '/builds/slave/test', 04:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:20 INFO - 'SHELL': '/bin/bash', 04:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:20 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:20 INFO - 'USER': 'cltbld', 04:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:20 INFO - 'XPC_FLAGS': '0x0', 04:14:20 INFO - 'XPC_SERVICE_NAME': '0', 04:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:14:20 INFO - Cleaning up... 04:14:20 INFO - Return code: 0 04:14:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:20 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')]} 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:20 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')]} 04:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:20 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:20 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 04:14:20 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 04:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:20 INFO - 'HOME': '/Users/cltbld', 04:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:20 INFO - 'LOGNAME': 'cltbld', 04:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:20 INFO - 'MOZ_NO_REMOTE': '1', 04:14:20 INFO - 'NO_EM_RESTART': '1', 04:14:20 INFO - 'PAGER': '/bin/cat', 04:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:20 INFO - 'PWD': '/builds/slave/test', 04:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:20 INFO - 'SHELL': '/bin/bash', 04:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:20 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:20 INFO - 'USER': 'cltbld', 04:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:20 INFO - 'XPC_FLAGS': '0x0', 04:14:20 INFO - 'XPC_SERVICE_NAME': '0', 04:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:20 INFO - Downloading/unpacking psutil>=3.1.1 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:24 INFO - Installing collected packages: psutil 04:14:24 INFO - Running setup.py install for psutil 04:14:24 INFO - building 'psutil._psutil_osx' extension 04:14:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:14:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:14:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:14:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:14:25 INFO - building 'psutil._psutil_posix' extension 04:14:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:14:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:14:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:14:25 INFO - ^ 04:14:25 INFO - 1 warning generated. 04:14:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:25 INFO - Successfully installed psutil 04:14:25 INFO - Cleaning up... 04:14:25 INFO - Return code: 0 04:14:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:26 INFO - 'HOME': '/Users/cltbld', 04:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:26 INFO - 'LOGNAME': 'cltbld', 04:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:26 INFO - 'MOZ_NO_REMOTE': '1', 04:14:26 INFO - 'NO_EM_RESTART': '1', 04:14:26 INFO - 'PAGER': '/bin/cat', 04:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:26 INFO - 'PWD': '/builds/slave/test', 04:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:26 INFO - 'SHELL': '/bin/bash', 04:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:26 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:26 INFO - 'USER': 'cltbld', 04:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:26 INFO - 'XPC_FLAGS': '0x0', 04:14:26 INFO - 'XPC_SERVICE_NAME': '0', 04:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:29 INFO - Installing collected packages: mozsystemmonitor 04:14:29 INFO - Running setup.py install for mozsystemmonitor 04:14:29 INFO - Successfully installed mozsystemmonitor 04:14:29 INFO - Cleaning up... 04:14:29 INFO - Return code: 0 04:14:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:29 INFO - 'HOME': '/Users/cltbld', 04:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:29 INFO - 'LOGNAME': 'cltbld', 04:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:29 INFO - 'MOZ_NO_REMOTE': '1', 04:14:29 INFO - 'NO_EM_RESTART': '1', 04:14:29 INFO - 'PAGER': '/bin/cat', 04:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:29 INFO - 'PWD': '/builds/slave/test', 04:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:29 INFO - 'SHELL': '/bin/bash', 04:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:29 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:29 INFO - 'USER': 'cltbld', 04:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:29 INFO - 'XPC_FLAGS': '0x0', 04:14:29 INFO - 'XPC_SERVICE_NAME': '0', 04:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:29 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:33 INFO - warning: no files found matching '*.txt' 04:14:33 INFO - no previously-included directories found matching 'build' 04:14:33 INFO - no previously-included directories found matching 'dist' 04:14:33 INFO - no previously-included directories found matching '.git*' 04:14:33 INFO - Installing collected packages: jsonschema, functools32 04:14:33 INFO - Running setup.py install for functools32 04:14:33 INFO - warning: no files found matching '*.txt' 04:14:33 INFO - no previously-included directories found matching 'build' 04:14:33 INFO - no previously-included directories found matching 'dist' 04:14:33 INFO - no previously-included directories found matching '.git*' 04:14:33 INFO - Successfully installed jsonschema functools32 04:14:33 INFO - Cleaning up... 04:14:33 INFO - Return code: 0 04:14:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:14:33 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')]} 04:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:33 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')]} 04:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:33 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:33 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 04:14:33 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 04:14:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:33 INFO - 'HOME': '/Users/cltbld', 04:14:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:33 INFO - 'LOGNAME': 'cltbld', 04:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:33 INFO - 'MOZ_NO_REMOTE': '1', 04:14:33 INFO - 'NO_EM_RESTART': '1', 04:14:33 INFO - 'PAGER': '/bin/cat', 04:14:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:33 INFO - 'PWD': '/builds/slave/test', 04:14:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:33 INFO - 'SHELL': '/bin/bash', 04:14:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:33 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:33 INFO - 'USER': 'cltbld', 04:14:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:33 INFO - 'XPC_FLAGS': '0x0', 04:14:33 INFO - 'XPC_SERVICE_NAME': '0', 04:14:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:14:33 INFO - Cleaning up... 04:14:33 INFO - Return code: 0 04:14:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:33 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')]} 04:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:33 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')]} 04:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:33 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:33 INFO - 'HOME': '/Users/cltbld', 04:14:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:33 INFO - 'LOGNAME': 'cltbld', 04:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:33 INFO - 'MOZ_NO_REMOTE': '1', 04:14:33 INFO - 'NO_EM_RESTART': '1', 04:14:33 INFO - 'PAGER': '/bin/cat', 04:14:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:33 INFO - 'PWD': '/builds/slave/test', 04:14:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:33 INFO - 'SHELL': '/bin/bash', 04:14:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:33 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:33 INFO - 'USER': 'cltbld', 04:14:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:33 INFO - 'XPC_FLAGS': '0x0', 04:14:33 INFO - 'XPC_SERVICE_NAME': '0', 04:14:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:33 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:37 INFO - Downloading docopt-0.6.1.tar.gz 04:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:37 INFO - Running setup.py install for blobuploader 04:14:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:38 INFO - Running setup.py install for requests 04:14:38 INFO - Running setup.py install for docopt 04:14:38 INFO - Successfully installed blobuploader requests docopt 04:14:38 INFO - Cleaning up... 04:14:38 INFO - Return code: 0 04:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:38 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:38 INFO - 'HOME': '/Users/cltbld', 04:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:38 INFO - 'LOGNAME': 'cltbld', 04:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:38 INFO - 'MOZ_NO_REMOTE': '1', 04:14:38 INFO - 'NO_EM_RESTART': '1', 04:14:38 INFO - 'PAGER': '/bin/cat', 04:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:38 INFO - 'PWD': '/builds/slave/test', 04:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:38 INFO - 'SHELL': '/bin/bash', 04:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:38 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:38 INFO - 'USER': 'cltbld', 04:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:38 INFO - 'XPC_FLAGS': '0x0', 04:14:38 INFO - 'XPC_SERVICE_NAME': '0', 04:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-2wlEIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-cAmIkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-5Sq0z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Pi721b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-CxmH0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-81ro_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-DcgmP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-9xcxoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:39 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-NB4REd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-oiKXYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-X18MCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Vgb2LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-aczvGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-KZow37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-zItNCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-o3dXnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Pehqge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:40 INFO - Running setup.py install for manifestparser 04:14:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:41 INFO - Running setup.py install for mozcrash 04:14:41 INFO - Running setup.py install for mozdebug 04:14:41 INFO - Running setup.py install for mozdevice 04:14:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:41 INFO - Running setup.py install for mozfile 04:14:41 INFO - Running setup.py install for mozhttpd 04:14:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:41 INFO - Running setup.py install for mozinfo 04:14:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:41 INFO - Running setup.py install for mozInstall 04:14:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Running setup.py install for mozleak 04:14:42 INFO - Running setup.py install for mozlog 04:14:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Running setup.py install for moznetwork 04:14:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Running setup.py install for mozprocess 04:14:42 INFO - Running setup.py install for mozprofile 04:14:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:42 INFO - Running setup.py install for mozrunner 04:14:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:43 INFO - Running setup.py install for mozscreenshot 04:14:43 INFO - Running setup.py install for moztest 04:14:43 INFO - Running setup.py install for mozversion 04:14:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:43 INFO - Cleaning up... 04:14:43 INFO - Return code: 0 04:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:43 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:43 INFO - 'HOME': '/Users/cltbld', 04:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:43 INFO - 'LOGNAME': 'cltbld', 04:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:43 INFO - 'MOZ_NO_REMOTE': '1', 04:14:43 INFO - 'NO_EM_RESTART': '1', 04:14:43 INFO - 'PAGER': '/bin/cat', 04:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:43 INFO - 'PWD': '/builds/slave/test', 04:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:43 INFO - 'SHELL': '/bin/bash', 04:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:43 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:43 INFO - 'USER': 'cltbld', 04:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:43 INFO - 'XPC_FLAGS': '0x0', 04:14:43 INFO - 'XPC_SERVICE_NAME': '0', 04:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:43 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-3bE9pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:43 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-gHofog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-hJnQUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-8k1lpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-NrTWdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Fc1RV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-odKMOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-cVItUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-q9evsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-jRr9YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:44 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Jkq2kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:45 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-6I2WOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:45 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-iYoblB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:45 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Y7idtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:45 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-uBlcig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:45 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-x_Ij8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:45 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-btoH54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - Downloading blessings-1.6.tar.gz 04:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:48 INFO - Installing collected packages: blessings 04:14:48 INFO - Running setup.py install for blessings 04:14:48 INFO - Successfully installed blessings 04:14:48 INFO - Cleaning up... 04:14:48 INFO - Return code: 0 04:14:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:48 INFO - Reading from file tmpfile_stdout 04:14:48 INFO - Current package versions: 04:14:48 INFO - blessings == 1.6 04:14:48 INFO - blobuploader == 1.2.4 04:14:48 INFO - docopt == 0.6.1 04:14:48 INFO - functools32 == 3.2.3-2 04:14:48 INFO - jsonschema == 2.5.1 04:14:48 INFO - manifestparser == 1.1 04:14:48 INFO - mozInstall == 1.12 04:14:48 INFO - mozcrash == 1.0 04:14:48 INFO - mozdebug == 0.1 04:14:48 INFO - mozdevice == 0.50 04:14:48 INFO - mozfile == 1.2 04:14:48 INFO - mozhttpd == 0.7 04:14:48 INFO - mozinfo == 0.9 04:14:48 INFO - mozleak == 0.1 04:14:48 INFO - mozlog == 3.4 04:14:48 INFO - moznetwork == 0.27 04:14:48 INFO - mozprocess == 0.25 04:14:48 INFO - mozprofile == 0.28 04:14:48 INFO - mozrunner == 6.13 04:14:48 INFO - mozscreenshot == 0.1 04:14:48 INFO - mozsystemmonitor == 0.3 04:14:48 INFO - moztest == 0.8 04:14:48 INFO - mozversion == 1.4 04:14:48 INFO - psutil == 3.1.1 04:14:48 INFO - requests == 1.2.3 04:14:48 INFO - wsgiref == 0.1.2 04:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:48 INFO - 'HOME': '/Users/cltbld', 04:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:48 INFO - 'LOGNAME': 'cltbld', 04:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:48 INFO - 'MOZ_NO_REMOTE': '1', 04:14:48 INFO - 'NO_EM_RESTART': '1', 04:14:48 INFO - 'PAGER': '/bin/cat', 04:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:48 INFO - 'PWD': '/builds/slave/test', 04:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:48 INFO - 'SHELL': '/bin/bash', 04:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:48 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:48 INFO - 'USER': 'cltbld', 04:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:48 INFO - 'XPC_FLAGS': '0x0', 04:14:48 INFO - 'XPC_SERVICE_NAME': '0', 04:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:14:49 INFO - Cleaning up... 04:14:49 INFO - Return code: 0 04:14:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:49 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')]} 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:49 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')]} 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:49 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 0x108657b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9912473d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, '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.CsWSHSMy78/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.SWdq3rh3xq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:49 INFO - 'HOME': '/Users/cltbld', 04:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:49 INFO - 'LOGNAME': 'cltbld', 04:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:49 INFO - 'MOZ_NO_REMOTE': '1', 04:14:49 INFO - 'NO_EM_RESTART': '1', 04:14:49 INFO - 'PAGER': '/bin/cat', 04:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:49 INFO - 'PWD': '/builds/slave/test', 04:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:49 INFO - 'SHELL': '/bin/bash', 04:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:14:49 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:49 INFO - 'USER': 'cltbld', 04:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:49 INFO - 'XPC_FLAGS': '0x0', 04:14:49 INFO - 'XPC_SERVICE_NAME': '0', 04:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:49 INFO - Cleaning up... 04:14:49 INFO - Return code: 0 04:14:49 INFO - Running post-action listener: _resource_record_post_action 04:14:49 INFO - Running post-action listener: _start_resource_monitoring 04:14:49 INFO - Starting resource monitoring. 04:14:49 INFO - [mozharness: 2017-05-02 11:14:49.502998Z] Finished create-virtualenv step (success) 04:14:49 INFO - [mozharness: 2017-05-02 11:14:49.503948Z] Running install step. 04:14:49 INFO - Running pre-action listener: _resource_record_pre_action 04:14:49 INFO - Running main action method: install 04:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:49 INFO - Reading from file tmpfile_stdout 04:14:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:49 INFO - Reading from file tmpfile_stdout 04:14:49 INFO - Output received: 04:14:49 INFO - Usage: mozinstall [options] installer 04:14:49 INFO - Options: 04:14:49 INFO - -h, --help show this help message and exit 04:14:49 INFO - -d DEST, --destination=DEST 04:14:49 INFO - Directory to install application into. [default: 04:14:49 INFO - "/builds/slave/test"] 04:14:49 INFO - --app=APP Application being installed. [default: firefox] 04:14:49 INFO - mkdir: /builds/slave/test/build/application 04:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:15:09 INFO - Reading from file tmpfile_stdout 04:15:09 INFO - Output received: 04:15:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:15:09 INFO - Running post-action listener: _resource_record_post_action 04:15:09 INFO - [mozharness: 2017-05-02 11:15:09.746669Z] Finished install step (success) 04:15:09 INFO - [mozharness: 2017-05-02 11:15:09.746777Z] Running run-tests step. 04:15:09 INFO - Running pre-action listener: _resource_record_pre_action 04:15:09 INFO - Running main action method: run_tests 04:15:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:09 INFO - 2017-05-02 04:15:09.761 screenresolution[1622:7556] starting screenresolution argv=screenresolution get 04:15:09 INFO - 2017-05-02 04:15:09.763 screenresolution[1622:7556] Display 0: 1600x1200x32@60 04:15:09 INFO - 2017-05-02 04:15:09.769 screenresolution[1623:7558] starting screenresolution argv=screenresolution list 04:15:09 INFO - Available Modes on Display 0 04:15:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:09 INFO - Intel Iris: 04:15:09 INFO - Chipset Model: Intel Iris 04:15:09 INFO - Type: GPU 04:15:09 INFO - Bus: Built-In 04:15:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:09 INFO - Vendor: Intel (0x8086) 04:15:09 INFO - Device ID: 0x0a2e 04:15:09 INFO - Revision ID: 0x0009 04:15:09 INFO - Displays: 04:15:09 INFO - Display: 04:15:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:09 INFO - Display Serial Number: 1600x1200 60 04:15:09 INFO - Main Display: Yes 04:15:09 INFO - Mirror: Off 04:15:09 INFO - Online: Yes 04:15:09 INFO - Rotation: Supported 04:15:10 INFO - Return code: 0 04:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:10 INFO - Python 2.7.3 04:15:10 INFO - Return code: 0 04:15:10 INFO - grabbing minidump binary from tooltool 04:15: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')]} 04:15:10 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 0x108435d30>, '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 0x10835bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10842abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:15:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:15:10 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 04:15:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:10 INFO - Return code: 0 04:15:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:15:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:10 INFO - ENV: RUST_BACKTRACE is now 1 04:15:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:15:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsWSHSMy78/Render', 04:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:10 INFO - 'HOME': '/Users/cltbld', 04:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:10 INFO - 'LOGNAME': 'cltbld', 04:15:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:10 INFO - 'MOZ_NO_REMOTE': '1', 04:15:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:10 INFO - 'NO_EM_RESTART': '1', 04:15:10 INFO - 'PAGER': '/bin/cat', 04:15:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:10 INFO - 'PWD': '/builds/slave/test', 04:15:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:10 INFO - 'RUST_BACKTRACE': '1', 04:15:10 INFO - 'SHELL': '/bin/bash', 04:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWdq3rh3xq/Listeners', 04:15:10 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:10 INFO - 'USER': 'cltbld', 04:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:10 INFO - 'XPC_FLAGS': '0x0', 04:15:10 INFO - 'XPC_SERVICE_NAME': '0', 04:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:15:10 INFO - mozversion application_buildid: 20170502020321 04:15:10 INFO - mozversion application_changeset: a812a96caba20dea7bc3815b71b4784afc6b864b 04:15:10 INFO - mozversion application_display_name: Nightly 04:15:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:10 INFO - mozversion application_name: Firefox 04:15:10 INFO - mozversion application_remotingname: firefox 04:15:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:15:10 INFO - mozversion application_vendor: Mozilla 04:15:10 INFO - mozversion application_version: 55.0a1 04:15:10 INFO - mozversion platform_buildid: 20170502020321 04:15:10 INFO - mozversion platform_changeset: a812a96caba20dea7bc3815b71b4784afc6b864b 04:15:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:15:10 INFO - mozversion platform_version: 55.0a1 04:15:10 INFO - using testdate: 1493723710 04:15:10 INFO - actual date: 1493723710 04:15:10 INFO - starting webserver on 'localhost:49234' 04:15:10 INFO - SUITE-START | Running 2 tests 04:15:10 INFO - TEST-START | dromaeo_css 04:15:10 INFO - operating with platform_type : mac_ 04:15:10 INFO - Initialising browser for dromaeo_css test... 04:15:10 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp33RPUQ/profile http://localhost:49234/getInfo.html) 04:15:13 INFO - PID 1633 | 2017-05-02 04:15:13.144 plugin-container[1635:7751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b4b, name = 'com.apple.tsm.portname' 04:15:13 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:13 INFO - PID 1633 | 2017-05-02 04:15:13.147 plugin-container[1635:7751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9937, name = 'com.apple.CFPasteboardClient' 04:15:13 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:13 INFO - PID 1633 | 2017-05-02 04:15:13.147 plugin-container[1635:7751] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:15:13 INFO - PID 1633 | __metrics Screen width/height:1600/1200 04:15:13 INFO - PID 1633 | colorDepth:24 04:15:13 INFO - PID 1633 | Browser inner width/height: 1024/689 04:15:13 INFO - PID 1633 | __metrics 04:15:14 INFO - TEST-INFO | 1633: exit 0 04:15:14 INFO - Browser initialized. 04:15:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:14 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp33RPUQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:16 INFO - PID 1636 | 2017-05-02 04:15:16.367 plugin-container[1637:7884] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:15:16 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:16 INFO - PID 1636 | 2017-05-02 04:15:16.367 plugin-container[1637:7884] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:15:16 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:16 INFO - PID 1636 | 2017-05-02 04:15:16.367 plugin-container[1637:7884] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:15:26 INFO - PID 1636 | RSS: Main: 234745856 04:15:26 INFO - PID 1636 | 04:18:29 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 04:18:31 INFO - PID 1636 | RSS: Main: 258523136 04:18:31 INFO - PID 1636 | 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 04:20:14 INFO - PID 1636 | 04:20:14 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:20:14 INFO - PID 1636 | Full stack: 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 04:20:14 INFO - PID 1636 | 04:20:14 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:20:14 INFO - PID 1636 | Full stack: 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 04:20:14 INFO - PID 1636 | 04:20:14 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:20:14 INFO - PID 1636 | Full stack: 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | ************************* 04:20:14 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 04:20:14 INFO - PID 1636 | 04:20:14 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:20:14 INFO - PID 1636 | Full stack: 04:20:14 INFO - PID 1636 | ************************* 04:21:33 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 04:21:33 INFO - PID 1636 | RSS: Main: 258674688 04:21:33 INFO - PID 1636 | 04:24:35 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 04:24:36 INFO - PID 1636 | RSS: Main: 267517952 04:24:36 INFO - PID 1636 | 04:27:38 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 04:27:38 INFO - PID 1636 | RSS: Main: 260358144 04:27:38 INFO - PID 1636 | 04:30:41 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 04:30:42 INFO - PID 1636 | RSS: Main: 268955648 04:30:42 INFO - PID 1636 | 04:33:43 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 04:33:44 INFO - PID 1636 | RSS: Main: 266764288 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | __start_tp_report 04:33:44 INFO - PID 1636 | _x_x_mozilla_page_load 04:33:44 INFO - PID 1636 | _x_x_mozilla_page_load_details 04:33:44 INFO - PID 1636 | |i|pagename|runs| 04:33:44 INFO - PID 1636 | |0;dojo.html;2786.4705705915876;3556.8399422026023;3603.5315408996826;3618.6019537850816;3667.2298817248384;5126.487351264872;5537.667739935601;5681.261436013323;6132.110843927628;6188.133661287423;5498.4501549845;6153.1077993691;6169.259688837335;6169.5989760665525;6216.502679785618;5348.117560602496;5383.031054410205;5427.240186373911;5435.619506634537;5506.229127922094;4538.7503687297185;5436.836894893159;5486.753096110685;5517.475839795213;5517.613767036309;5432.6740395576;5458.372287186985;5464.098423760075;5473.534749546293;5512.586556008316;5475.479829416199;5481.725913704338;5507.834764957058;5522.171674248895;5526.281583394173;5398.676079435247;5425.186222066682;5426.593005524602;5428.5385742211565;5449.707820465001;5061.5950723942;6114.807612515561;6125.47964319526;6135.570510064297;6190.50475961922;6659.9001014984815;6693.129893113913;6696.129503164606;6696.5647232929705;6716.697748601276;6790.151231096113;6804.659767011679;6806;6813.625250611214;6823.590584564892;6245.188125543741;6256.937430625727;6335.461485773669;6340.461060809791;6367.204099487564;6919.37725604698;6960.338767817049;6976.686049127801;6992.160940687048;6994.615296158659;6389.9680501597195;6437.742490300429;6533.444657204096;6640.8671826563195;6649.933500665028;6574.046763219402;6579.374959378852;6782.457403407716;6783.626900520519;6785.1518560179975;5970.671613061323;6182.752689892444;6688;6690.799276021728;6707.295733947963;6490.545661803723;6577.638229897306;6578.407943285031;6638.535302528777;6714.52998290115;5293.550048245942;5334.226537152092;5354.143337066051;5357.43746906577;5385.3268341457315;4715.599174070242;4728.290756386501;4734.502877197913;4768.904621907543;4771.23660214371;5006.4743201963265;6261.749530018839;6363.077353783676;6399.04014397844;6426.8714625707225;6683.43190828785;6722.294159113223;6751.122354094035;6762.120924279812;6795;6325;6368.949123394588;6369.777057803048;6382.457491113308;6404.167458230493;5772.942270577324;5939.673317967467;5948.821535353946;5966.701664916824;5966.910496342558;6845.418139458202;6864.450843932574;6971.79084627462;6974.581525108307;6991.7902462926195;6776.7628133015105;6784.93215067843;6806.9659651703405;6812.523123381316;6875.174979002351;6921.204061532988;6973.12835895513;6987.650617469005;7001.054857594363;7044.330788575077;5119.974400127976;5776;6177.567570270038;6566.113574667359;6653.833654158685;6653.135092437952;6776.695048722918;6783.118194634666;6812.557183783038;6822.351876571718;5763.510101641407;6291.811245662638;6445.742170313135;6466.935330646634;6594.505412094208;6487.610743355413;6568.868622627616;6568.967155164385;6584.868302633825;6593.80218593443;5298.97350513245;6313.936860631518;6389.945658966404;6424.2933277338525;6496.317886621837;6564.901526477202;6585.934140658532;6609.372109649576;6626.370494802986;6641.933580664325;6434.517411194086;6436;6440.742370305135;6442.065900444316;6465.709043093166 04:33:44 INFO - PID 1636 | |1;ext.html;738.9445791565632;766.4481573267245;821.548148518315;1213.278099530779;1264.5068423314915;36660.63339366605;37784.05539861505;37839.243215135684;37879.99999999996;37905.241895162115;32397.514037289402;37654.24691506168;37681.811590942074;37715.81142094286;37968.620313796855;7825.256600622932;7983.880241796378;8058.758237252891;8438.578071096452;8461.196186362316;8389.916100838975;8434.746957591282;8454;8487.44831585948;8517.190866867637;8440.324774018063;8442.746717598482;8514.616842242114;8519.488830670149;8546;8389.832203355898;8411.242988131067;8465.619047142862;8488.87266690997;8488.872666910001;7050.506464547484;8277.213664701843;8297.294729947962;8339.082700902896;8351.749447516584;37101.814490927376;37371;37506.24987500262;37539.62460375416;37590.43614345787;3530.6822385985383;3541.8937431877084;3547.8048707321086;3548.7515873888838;3557.2529768748595;30623.693763062307;30627.693723062708;30658.233544161576;30727;30839.383212335626;2663.813533052687;3065.371598822236;3077.861496232675;3080.291532947412;3087.72210501056;215140;243093.56906430886;257906.99999999814;271470;271961;46393;46482;46526.76736616295;46561;46622.53377466182;48175;48623.513764862604;54743;55519.44480555224;55709.721451392485;14661.48684796027;14784.965052446225;14789.408423663148;14799.852001480063;14837.777433338508;11779.823302650468;11933.641990740292;11936.701582460335;11978.221415607957;12001.819972700416;14212.289385530683;14215;14227.573172804832;14241.857581424054;14338.928305358406;5092.312537807423;5312.884294298241;6013.067974463965;6035.124906888476;6285.654289014056;901.977450563728;921.5668635741191;1043.8538604595362;1080.702806728156;1095.3482677806692;19680;23063.654045189334;24674.259772206864;24773.876130619592;24992.625110623354;987.6148302162162;1094.2176343914139;1131.7453572946022;1166.8133098704166;1182.1252273317682;12703.872961270454;12823.422945967453;12838.165519241405;12870.356482175854;12907;286423;341848;343918;344027;344483.2775836155;54436;54545.45454545483;54563.18155227675;54615.72692136514;54821.72589137029;1524.3521503361028;1533.9002964807253;1577.7791109244715;1581.4464937271862;1594.856462918343;22159.002844872342;22692.432689182242;24408.755912440647;24710.011599535817;24725.381865453506;38153;38252.85241442761;38266;38271;38437.84686459411;299185.5040724782;299639;299948;300231;300617.993820059;31070.912518062665;32259.838700806347;34767.30465390729;35541.28917421689;36441.90674279776;38041.85874423772;39511.81464556068;42938.78530607327;43412;45713.77143114263;25401.364965875262;28503.429931400842;29556.408871822874;30555.694443055287;31055.534166987964;30703.385932280784;30794.538081929237;31191.84404077965;31207;31265.218369540034;37453.06367340838;37969.24061518809;38342.23315533729;38351.808240959734;38390.808045959595;25624.359391014626;29962.550561741155;30609.928652497056;31227;31682.207944801565;22549.43626409353;24324.513509729353;24370.390740231636;24826.751732482444;24907.875460623305 04:33:44 INFO - PID 1636 | |2;jquery.html;432.19180133151013;441.4944888103121;445.6319100361888;458.2004402317955;458.80959401848236;19628.411147665574;21312.36062918113;22130.88934555325;22191.778082219174;22226.999785009673;21804.236851710193;22381.769002704845;23263.185788497405;23272.76727232727;23449.296521104352;6176.197094377736;6315.463185629227;6339.619622822645;6395.072714456401;6403.551751377406;6071.3625069367745;6269.216347956505;6316.557840951135;6332.113504109406;6340;6104.755809767604;6217.347178546255;6266.122742816009;6277.152584401116;6350.936490635104;6182.1345011698395;6193.6903154842075;6224.035274532432;6230.906536401958;6238.4385405313515;5484.670919744828;5486.067368547317;5539.806106786284;5548.55611551079;5553.805616803433;26959.730402695917;27019.45961080787;27149.45701085987;27240.59139112915;27321.453570928472;2232.810211132056;2274.0221704666988;2285.725712914444;2291.5875142474347;2298.069281940817;17403.651926961516;17783.19975601101;17904.373346932796;18172.182251798567;18313.450596482126;2147.50607360308;2158.686990386401;2182.0944308112116;2191.539776646906;2199.8680079195137;159507;159960.60059099123;161444;162746;164116.17941910334;11056.778864422666;12761.29812860283;12772.233665980071;12927.741445171045;13071.281079540717;16346.34614615426;16670.499885003468;16670.666586668198;16728.330866765195;16746;8660.39377243587;8941.955290223637;8990.685326013558;9122.543872806333;9129.269658427309;8430.957190009383;8433.789155271044;8450.535220562806;8614.353923455767;8699;7910.841783164305;7999.920000800034;8076.27313541784;8105.311048560939;8111.391645626483;1838.6782313095155;2154.1060459908963;2158.8488805783445;2169.848110632272;2373.311739595498;798.6046906781064;867.6789587852409;953.814006268771;970.5632465390603;1042.3954106618144;18655.253789848524;20341.49146271355;21531.89234053851;21595.784042159376;21700.891495542735;1000.279798545061;1010.525053224983;1021.8620486234412;1033.7002269341956;1044.242923880196;9332.486713230837;10729.088027517591;11072.667819965414;11087.889121108847;11176.385298808644;512829;549808;555074;557189;558457;104139;118963;127130;135468;138721;1192.874748151449;1212.860521040074;1243.8258643789695;1246.6883279180206;1251.1492185313891;18787;20326.085326160064;22663;22680.144375455882;22699.773002270427;54928.04305974989;57801.71099144477;58305.70847145737;58404.4159558399;58508;72014.91977620445;73054.17364565928;74003;75488.49023019618;75751.5911783982;8691.565421728761;8968.417052891542;8976.147266009719;9064.50145242018;9089.818203635758;14260.358283877044;14294.356753946306;14315.856841431452;14595.270236488346;14770.335334910169;11907.880921190677;12046.457909393923;12060.15578909503;12164.08769342285;12211.328376939353;11163.665090047312;11227.66317010491;11466.484008219817;11644.592439264585;11912.583059592873;10723.142148628247;12135.02919766399;12179.451924663234;12200.877991219973;12233.3271670059;8744.475331480131;8880.245179159843;9024.503652298923;9028.954855225682;9105.362624616479;11412.429378530875;12035.578754743541;12251.69370765738;12270.938645306716;12274.509019639114 04:33:44 INFO - PID 1636 | |3;mootools.html;1414.2151106136093;1436.612114729024;1436.755751522241;1474.764037753959;1474.8082749242596;9098.954505227473;11369.147313951446;11687.824682629767;11832.053435725133;11992.920637142655;11569.53721851125;11822.527098916033;11823.34971576563;11832.645020649394;11871.406429678504;2499.9000039998377;2549.197002944076;2550.579154439515;2560.7695307422327;2566.871656417181;2483.2301986384186;2527.8736063196857;2528.5575024370755;2533.8479691218586;2534.4044149624915;2448.326710154704;2470.567650661136;2493.326801763523;2495.800335973118;2508.2726009457238;2459.6433517140003;2482.466269752003;2504.749525047499;2512.6984761828517;2519.344970307715;2395.35325462126;2484.00639744102;2500.712418071927;2502.774750272466;2506.135383292761;11661.475233614508;11770.117241206945;11776.293422394683;11776.352300623463;11867.703307417383;6603.7688680895935;6765.830854228634;6840.521163518556;6852.965735171342;6854.451643868479;3978.0253837809632;4311.525732169459;4389.275769498029;4389.539098394686;4391.6047555719815;1260.4706023470073;1268.9175203611735;1292.8965682745452;1305.073397887501;1309.9214047157202;13479.326033698277;16247.593810154722;16369.754453683205;16447.25987330561;16545.586360341087;4255.8084886180195;5508.173773933942;5674.205611214434;5683.26117604717;5695.5443564514735;9814.362066465657;11724.70688232801;11736.237144585575;11753.294802311717;11782.351970641697;6523.575967562093;6536.607803531708;6553.279139294674;6562.2453417856605;6573.539852210395;6050.6974651267265;6087.756489740361;6246.781362652286;6253.437190652863;6262.530310226751;3660.6156353583024;4292.227399068198;4410.3825464435;4439.822407103744;4491.438570178728;1131.8981291683788;1268.1503392726895;1283.063363744453;1288.5361269942814;1290.0904862072216;777.6267391651926;791.4301702773994;808.8463191993502;814.1004190369674;829.2536716954789;5228.9738551307;5791.610013596706;6134.355892631299;6390.137331460193;7128.275092862775;791.8178818871577;940.8635747816528;947.9099485548862;950.5342382232657;962.8844538655406;4103.7948102594755;4248.660107191417;4291.871243862689;4399.802008909543;4465.464144302705;14484.85515144835;14993.250337483083;15069.17119558413;15097;15105.169215693022;14484.710305793826;14867.256637168099;14959.92520037393;14989;15124.848751512343;7504.849903001909;8405.327573794082;8602.655893764304;8643.567821608895;8660.69687560945;5882.94117058841;6052;6870.385459416933;6964.501424218155;7051.1186101737285;10684.145268378355;13045;13117.475300987853;13136.40886160106;13399.665008374868;12376.319302438453;13475.932620336836;13575.79636305476;13835.79246311286;13884.305784710523;9037.593308301273;9282.9535852323;9398.95300523493;9496.43021418717;9497.810043799223;10941.179411544006;10954.835677464685;11020.44897755093;11040.447977601249;11041.889581104086;8905.376623636283;8923;9058.592363343798;9071.591778369857;9184.632614695338;8825.293976481738;8827.735167944971;8901.376903616685;8917.554122293988;8924.286057115545;8122.75631731049;8148.83702325962;8156;8248.340132789242;8293.087760346478;5986.43128902771;6011.068284415923;6069.575129740876;6158.414950579688;6203.658798766111;5565.6104072714525;6035.758569657164;6109.022556390956;6236.781712640217;6397.4562162216735 04:33:44 INFO - PID 1636 | |4;prototype.html;308.5017696420281;383.77932688704004;406.1734370555918;410.56070005094523;413.62773503846535;5531.695756733378;5684.801031963882;5990.880182396355;6435.099086127946;6506.642134682591;5360.517553420192;5465.9726701366435;5906.5570082243785;6043.884640375866;6359.427651511363;4556.339330797033;4574.771261436931;4586.77066146693;4598.103369842882;4601.516840731725;3417.6500282388565;3886.1644746379525;4139.275626765319;4517.9774101129615;4619.706482184977;4520.954790452102;4545.454545454533;4561.156186105581;4563.452385713719;4575.450945886499;3753.493278407407;4569.246074397721;4570.908581828378;4591.862244132682;4602.815887364502;3471.444568868994;3595.9101022474647;3713.721470889667;3875.1087249932675;3924.725269231155;5325.840224793263;5728.42715728428;6191.349908259658;6229.570467517672;6241.126242326078;5462.153366228241;5496.945030549723;5504.422035686275;5513.724313784335;5516.779328826842;5548.307766131328;6566.967165164191;6727.865442691168;6791.864162716767;6823.351781580742;3793.7534060285993;4091.40674602184;4391.297392417198;4394.472663280395;4407.889802754925;6496.675166241669;6912.005429792009;7096.609686467243;7216.206217316091;7285.996351003463;4432.512423633398;4441.289393696993;4456.041950980555;4456.977715111469;4459.531749166355;4410.625096866738;4431.933520997188;4518.096380723802;4521.344405061248;4531.025829446685;4023.91952160961;5276.894462110737;5380.354357477127;5399.514043736082;5419.566434685295;6843.62360070191;6844.4182244509775;6852.349026842442;6862.519623626298;6874.14722890005;1530.8545688159606;1537.7232098222428;1538.6307286251442;1545.0883978452766;1549.1170033081262;836.5986971822174;986.1962500562018;988.7824678570703;996.3274789517047;1011.22135955314;5348.358197016383;6250.218722659668;6503.967480162569;6519.413252807175;6537.1501704778075;5859.736311865976;6199.814005579839;6417.486601071903;6882.69027893736;6898.930665746817;5369.919451208235;6456.677166141674;6507.3797603701905;6539;6544.312847151075;3228.8537569163077;3405.5062016008037;3524.6827785498917;3694.704423646102;3709.295233905549;7072.328128827753;7286.817829554304;7290.854182916312;7315.817104572428;7340.706371745177;6432.839179020562;7124.394426473704;7250.854982900418;7260.818479537948;7296.306850849161;6531.934680653228;6649.411905784993;7319.451041171827;7419.777406677808;7451.105867296068;6133.883810085514;6466.902996455151;6958.826029349104;7078.221395646372;7102.4673149512955;7065.470089743392;7093.32613401726;7103.609301488468;7121.679524421517;7148.606826624586;6542.803715888341;6597.835054123685;7450.105987281561;7466.8506629866015;7478.214787447239;4406.955930440655;4428.75641839689;4434.113177364605;4443.955560444354;4453.309736990772;5798.507126894261;5902.970485147547;6223.719932602953;7011.894821577783;7187.676554554953;5923.229980102559;6052.60790018307;6737.629430381376;6827.692753825991;6832.863342733217;5753.827385178452;5823.272090988627;6421.440777048348;6826.146731658543;6836.213835408992;5583.69289689071;6470.7088181032905;6617.569857959217;6642.43539299165;6696.698648560924;5719.28508936383;6819.795406137824;6839.623820689711;6864.965675171592;6888.039377357939;6425.1968503937005;6542.443892269211;6655.767048153291;6657.800265992028;6669.499362643561 04:33:44 INFO - PID 1636 | |5;yui.html;772.5712229712511;791.1100012485954;825.2490233887164;859.2782063067023;865.1478293880526;14636.41454341825;15071.040764700574;16246.268917898693;16590.585235369123;16627.75058374124;15280.159591222478;15731.84268157318;17101.48695539136;17581.648367032652;17663.381781637647;977.9902200977988;1007.249599048706;1010.2877471382658;1016.1972042086743;1018.3024628129717;909.6088681866795;1012.812629663511;1021.0861279155151;1022.1975749037008;1026.296986564206;862.361852229352;1070;1075.0163600305711;1075.9946200268987;1078.8651418572679;1069.9251052426334;1072.6781965410385;1074.6453670288824;1075.2473268711856;1076.993011534218;645.3449748505271;661.4840424468922;796.4982061301401;797.5294576200012;797.7247849491916;16685.332586696517;16816.32734690611;16834.242459089248;17319.047452390114;17412;16960.3215871365;16991.235394407282;17094.743578846326;17161.399351022654;17343.479695609152;11599.826002609967;11996.64010079699;12080.879191208063;13964.371603277878;14053.156810591398;3614;3626.746127771057;3629.8548058077645;3632.8183590820354;3637.217998130415;105267;117515.4124229382;128367;130531.59949804754;131635;13201.867981320256;13552.525661601796;13556;13739;13777.655558610915;25168;25234.36914077126;25643.97424103015;25910.481790364465;26172.82222300001;7728.690852365842;8000.51996880189;8015.158408367154;8034.517928924283;8067.152948940394;3409.4544872820725;3976.1053762903116;4056.35098384263;4065.5121385433345;4066.4916885389325;4198.874033778991;4339.479262488521;4406.691531592758;4412.007298357844;4423.469183697913;817.7751118442357;901.4591245252795;934.8036912248368;939.3565407695613;941.4210260689626;630.4767043354005;651.5667081390822;664.6311297230084;671.895856142289;690.3579670906005;9318.741969834122;11098;11324.547018119347;11446.19876608646;11869.881301186877;651.2965996723527;652.7617419641797;657.0768070860448;670.276101810044;679.5752654590881;5337.653052551572;5411.431799661058;5545.916811247835;5603.6077474577205;5650.0959846424375;109791.45104274427;110051.89948100576;111257;111335.44332278287;111493.44253278682;93143;97796;98103;98131.99999999857;98782.5060874691;73237.53524929365;86109;88361;88461.55769221112;89752.20495590051;10640.201984851012;10746.24776265654;10905;10913.290636108628;10936.398498082683;37311.81344093371;43055.569444306406;43642.56357436385;44203.557964419946;44438.777806112055;41324.793376032925;42197.578024220595;55657;56112;56642.716786415804;13707.314634268447;13819.723605527632;13876.514321998682;15769.526914192593;17011.574710632332;18188.90905545464;18518.629627407645;18593.721094183868;18667.346642867433;18738.531536711147;16352;16702.74945875837;17367.826321736622;17408.129593520527;17448.953062816272;16651.583710407336;16804.663906722042;16899.493015209562;17411.825881741526;17537;16214.51356459308;16276.593085172492;16804.915975420045;16941.407050753165;16978.83021169822;10259.7435064124;11332.263402878787;12001.279923204287;12007.639770806889;12102.152849300464;10908.509117089592;12907.677308066997;13049.021323400593;13059.412326445523;13066 04:33:44 INFO - PID 1636 | __end_tp_report 04:33:44 INFO - PID 1636 | __start_cc_report 04:33:44 INFO - PID 1636 | _x_x_mozilla_cycle_collect,416 04:33:44 INFO - PID 1636 | __end_cc_report 04:33:44 INFO - PID 1636 | __startTimestamp1493724824005__endTimestamp 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | ------- Summary: start ------- 04:33:44 INFO - PID 1636 | Number of tests: 6 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6127.09 Median:6389.97 stddev:776.66 (12.2%) stddev-sans-first:733.50 04:33:44 INFO - PID 1636 | Values: 2786.5 3556.8 3603.5 3618.6 3667.2 5126.5 5537.7 5681.3 6132.1 6188.1 5498.5 6153.1 6169.3 6169.6 6216.5 5348.1 5383.0 5427.2 5435.6 5506.2 4538.8 5436.8 5486.8 5517.5 5517.6 5432.7 5458.4 5464.1 5473.5 5512.6 5475.5 5481.7 5507.8 5522.2 5526.3 5398.7 5425.2 5426.6 5428.5 5449.7 5061.6 6114.8 6125.5 6135.6 6190.5 6659.9 6693.1 6696.1 6696.6 6716.7 6790.2 6804.7 6806.0 6813.6 6823.6 6245.2 6256.9 6335.5 6340.5 6367.2 6919.4 6960.3 6976.7 6992.2 6994.6 6390.0 6437.7 6533.4 6640.9 6649.9 6574.0 6579.4 6782.5 6783.6 6785.2 5970.7 6182.8 6688.0 6690.8 6707.3 6490.5 6577.6 6578.4 6638.5 6714.5 5293.6 5334.2 5354.1 5357.4 5385.3 4715.6 4728.3 4734.5 4768.9 4771.2 5006.5 6261.7 6363.1 6399.0 6426.9 6683.4 6722.3 6751.1 6762.1 6795.0 6325.0 6368.9 6369.8 6382.5 6404.2 5772.9 5939.7 5948.8 5966.7 5966.9 6845.4 6864.5 6971.8 6974.6 6991.8 6776.8 6784.9 6807.0 6812.5 6875.2 6921.2 6973.1 6987.7 7001.1 7044.3 5120.0 5776.0 6177.6 6566.1 6653.8 6653.1 6776.7 6783.1 6812.6 6822.4 5763.5 6291.8 6445.7 6466.9 6594.5 6487.6 6568.9 6569.0 6584.9 6593.8 5299.0 6313.9 6389.9 6424.3 6496.3 6564.9 6585.9 6609.4 6626.4 6641.9 6434.5 6436.0 6440.7 6442.1 6465.7 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:44609.50 Median:344255.14 stddev:77941.01 (22.6%) stddev-sans-first:78090.05 04:33:44 INFO - PID 1636 | Values: 738.9 766.4 821.5 1213.3 1264.5 36660.6 37784.1 37839.2 37880.0 37905.2 32397.5 37654.2 37681.8 37715.8 37968.6 7825.3 7983.9 8058.8 8438.6 8461.2 8389.9 8434.7 8454.0 8487.4 8517.2 8440.3 8442.7 8514.6 8519.5 8546.0 8389.8 8411.2 8465.6 8488.9 8488.9 7050.5 8277.2 8297.3 8339.1 8351.7 37101.8 37371.0 37506.2 37539.6 37590.4 3530.7 3541.9 3547.8 3548.8 3557.3 30623.7 30627.7 30658.2 30727.0 30839.4 2663.8 3065.4 3077.9 3080.3 3087.7 215140.0 243093.6 257907.0 271470.0 271961.0 46393.0 46482.0 46526.8 46561.0 46622.5 48175.0 48623.5 54743.0 55519.4 55709.7 14661.5 14785.0 14789.4 14799.9 14837.8 11779.8 11933.6 11936.7 11978.2 12001.8 14212.3 14215.0 14227.6 14241.9 14338.9 5092.3 5312.9 6013.1 6035.1 6285.7 902.0 921.6 1043.9 1080.7 1095.3 19680.0 23063.7 24674.3 24773.9 24992.6 987.6 1094.2 1131.7 1166.8 1182.1 12703.9 12823.4 12838.2 12870.4 12907.0 286423.0 341848.0 343918.0 344027.0 344483.3 54436.0 54545.5 54563.2 54615.7 54821.7 1524.4 1533.9 1577.8 1581.4 1594.9 22159.0 22692.4 24408.8 24710.0 24725.4 38153.0 38252.9 38266.0 38271.0 38437.8 299185.5 299639.0 299948.0 300231.0 300618.0 31070.9 32259.8 34767.3 35541.3 36441.9 38041.9 39511.8 42938.8 43412.0 45713.8 25401.4 28503.4 29556.4 30555.7 31055.5 30703.4 30794.5 31191.8 31207.0 31265.2 37453.1 37969.2 38342.2 38351.8 38390.8 25624.4 29962.6 30609.9 31227.0 31682.2 22549.4 24324.5 24370.4 24826.8 24907.9 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:35621.24 Median:22689.96 stddev:92899.84 (409.4%) stddev-sans-first:93122.87 04:33:44 INFO - PID 1636 | Values: 432.2 441.5 445.6 458.2 458.8 19628.4 21312.4 22130.9 22191.8 22227.0 21804.2 22381.8 23263.2 23272.8 23449.3 6176.2 6315.5 6339.6 6395.1 6403.6 6071.4 6269.2 6316.6 6332.1 6340.0 6104.8 6217.3 6266.1 6277.2 6350.9 6182.1 6193.7 6224.0 6230.9 6238.4 5484.7 5486.1 5539.8 5548.6 5553.8 26959.7 27019.5 27149.5 27240.6 27321.5 2232.8 2274.0 2285.7 2291.6 2298.1 17403.7 17783.2 17904.4 18172.2 18313.5 2147.5 2158.7 2182.1 2191.5 2199.9 159507.0 159960.6 161444.0 162746.0 164116.2 11056.8 12761.3 12772.2 12927.7 13071.3 16346.3 16670.5 16670.7 16728.3 16746.0 8660.4 8942.0 8990.7 9122.5 9129.3 8431.0 8433.8 8450.5 8614.4 8699.0 7910.8 7999.9 8076.3 8105.3 8111.4 1838.7 2154.1 2158.8 2169.8 2373.3 798.6 867.7 953.8 970.6 1042.4 18655.3 20341.5 21531.9 21595.8 21700.9 1000.3 1010.5 1021.9 1033.7 1044.2 9332.5 10729.1 11072.7 11087.9 11176.4 512829.0 549808.0 555074.0 557189.0 558457.0 104139.0 118963.0 127130.0 135468.0 138721.0 1192.9 1212.9 1243.8 1246.7 1251.1 18787.0 20326.1 22663.0 22680.1 22699.8 54928.0 57801.7 58305.7 58404.4 58508.0 72014.9 73054.2 74003.0 75488.5 75751.6 8691.6 8968.4 8976.1 9064.5 9089.8 14260.4 14294.4 14315.9 14595.3 14770.3 11907.9 12046.5 12060.2 12164.1 12211.3 11163.7 11227.7 11466.5 11644.6 11912.6 10723.1 12135.0 12179.5 12200.9 12233.3 8744.5 8880.2 9024.5 9029.0 9105.4 11412.4 12035.6 12251.7 12270.9 12274.5 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7041.58 Median:4176.23 stddev:4417.44 (105.8%) stddev-sans-first:4409.59 04:33:44 INFO - PID 1636 | Values: 1414.2 1436.6 1436.8 1474.8 1474.8 9099.0 11369.1 11687.8 11832.1 11992.9 11569.5 11822.5 11823.3 11832.6 11871.4 2499.9 2549.2 2550.6 2560.8 2566.9 2483.2 2527.9 2528.6 2533.8 2534.4 2448.3 2470.6 2493.3 2495.8 2508.3 2459.6 2482.5 2504.7 2512.7 2519.3 2395.4 2484.0 2500.7 2502.8 2506.1 11661.5 11770.1 11776.3 11776.4 11867.7 6603.8 6765.8 6840.5 6853.0 6854.5 3978.0 4311.5 4389.3 4389.5 4391.6 1260.5 1268.9 1292.9 1305.1 1309.9 13479.3 16247.6 16369.8 16447.3 16545.6 4255.8 5508.2 5674.2 5683.3 5695.5 9814.4 11724.7 11736.2 11753.3 11782.4 6523.6 6536.6 6553.3 6562.2 6573.5 6050.7 6087.8 6246.8 6253.4 6262.5 3660.6 4292.2 4410.4 4439.8 4491.4 1131.9 1268.2 1283.1 1288.5 1290.1 777.6 791.4 808.8 814.1 829.3 5229.0 5791.6 6134.4 6390.1 7128.3 791.8 940.9 947.9 950.5 962.9 4103.8 4248.7 4291.9 4399.8 4465.5 14484.9 14993.3 15069.2 15097.0 15105.2 14484.7 14867.3 14959.9 14989.0 15124.8 7504.8 8405.3 8602.7 8643.6 8660.7 5882.9 6052.0 6870.4 6964.5 7051.1 10684.1 13045.0 13117.5 13136.4 13399.7 12376.3 13475.9 13575.8 13835.8 13884.3 9037.6 9283.0 9399.0 9496.4 9497.8 10941.2 10954.8 11020.4 11040.4 11041.9 8905.4 8923.0 9058.6 9071.6 9184.6 8825.3 8827.7 8901.4 8917.6 8924.3 8122.8 8148.8 8156.0 8248.3 8293.1 5986.4 6011.1 6069.6 6158.4 6203.7 5565.6 6035.8 6109.0 6236.8 6397.5 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5397.36 Median:6048.25 stddev:1761.53 (29.1%) stddev-sans-first:1724.56 04:33:44 INFO - PID 1636 | Values: 308.5 383.8 406.2 410.6 413.6 5531.7 5684.8 5990.9 6435.1 6506.6 5360.5 5466.0 5906.6 6043.9 6359.4 4556.3 4574.8 4586.8 4598.1 4601.5 3417.7 3886.2 4139.3 4518.0 4619.7 4521.0 4545.5 4561.2 4563.5 4575.5 3753.5 4569.2 4570.9 4591.9 4602.8 3471.4 3595.9 3713.7 3875.1 3924.7 5325.8 5728.4 6191.3 6229.6 6241.1 5462.2 5496.9 5504.4 5513.7 5516.8 5548.3 6567.0 6727.9 6791.9 6823.4 3793.8 4091.4 4391.3 4394.5 4407.9 6496.7 6912.0 7096.6 7216.2 7286.0 4432.5 4441.3 4456.0 4457.0 4459.5 4410.6 4431.9 4518.1 4521.3 4531.0 4023.9 5276.9 5380.4 5399.5 5419.6 6843.6 6844.4 6852.3 6862.5 6874.1 1530.9 1537.7 1538.6 1545.1 1549.1 836.6 986.2 988.8 996.3 1011.2 5348.4 6250.2 6504.0 6519.4 6537.2 5859.7 6199.8 6417.5 6882.7 6898.9 5369.9 6456.7 6507.4 6539.0 6544.3 3228.9 3405.5 3524.7 3694.7 3709.3 7072.3 7286.8 7290.9 7315.8 7340.7 6432.8 7124.4 7250.9 7260.8 7296.3 6531.9 6649.4 7319.5 7419.8 7451.1 6133.9 6466.9 6958.8 7078.2 7102.5 7065.5 7093.3 7103.6 7121.7 7148.6 6542.8 6597.8 7450.1 7466.9 7478.2 4407.0 4428.8 4434.1 4444.0 4453.3 5798.5 5903.0 6223.7 7011.9 7187.7 5923.2 6052.6 6737.6 6827.7 6832.9 5753.8 5823.3 6421.4 6826.1 6836.2 5583.7 6470.7 6617.6 6642.4 6696.7 5719.3 6819.8 6839.6 6865.0 6888.0 6425.2 6542.4 6655.8 6657.8 6669.5 04:33:44 INFO - PID 1636 | 04:33:44 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21963.91 Median:17411.91 stddev:31456.94 (180.7%) stddev-sans-first:31504.94 04:33:44 INFO - PID 1636 | Values: 772.6 791.1 825.2 859.3 865.1 14636.4 15071.0 16246.3 16590.6 16627.8 15280.2 15731.8 17101.5 17581.6 17663.4 978.0 1007.2 1010.3 1016.2 1018.3 909.6 1012.8 1021.1 1022.2 1026.3 862.4 1070.0 1075.0 1076.0 1078.9 1069.9 1072.7 1074.6 1075.2 1077.0 645.3 661.5 796.5 797.5 797.7 16685.3 16816.3 16834.2 17319.0 17412.0 16960.3 16991.2 17094.7 17161.4 17343.5 11599.8 11996.6 12080.9 13964.4 14053.2 3614.0 3626.7 3629.9 3632.8 3637.2 105267.0 117515.4 128367.0 130531.6 131635.0 13201.9 13552.5 13556.0 13739.0 13777.7 25168.0 25234.4 25644.0 25910.5 26172.8 7728.7 8000.5 8015.2 8034.5 8067.2 3409.5 3976.1 4056.4 4065.5 4066.5 4198.9 4339.5 4406.7 4412.0 4423.5 817.8 901.5 934.8 939.4 941.4 630.5 651.6 664.6 671.9 690.4 9318.7 11098.0 11324.5 11446.2 11869.9 651.3 652.8 657.1 670.3 679.6 5337.7 5411.4 5545.9 5603.6 5650.1 109791.5 110051.9 111257.0 111335.4 111493.4 93143.0 97796.0 98103.0 98132.0 98782.5 73237.5 86109.0 88361.0 88461.6 89752.2 10640.2 10746.2 10905.0 10913.3 10936.4 37311.8 43055.6 43642.6 44203.6 44438.8 41324.8 42197.6 55657.0 56112.0 56642.7 13707.3 13819.7 13876.5 15769.5 17011.6 18188.9 18518.6 18593.7 18667.3 18738.5 16352.0 16702.7 17367.8 17408.1 17449.0 16651.6 16804.7 16899.5 17411.8 17537.0 16214.5 16276.6 16804.9 16941.4 16978.8 10259.7 11332.3 12001.3 12007.6 12102.2 10908.5 12907.7 13049.0 13059.4 13066.0 04:33:44 INFO - PID 1636 | -------- Summary: end -------- 04:33:44 INFO - PID 1636 | 04:33:44 INFO - TEST-INFO | 1636: exit 0 04:33:44 INFO - TEST-OK | dromaeo_css | took 1114415ms 04:33:44 INFO - TEST-START | kraken 04:33:44 INFO - operating with platform_type : mac_ 04:33:44 INFO - Initialising browser for kraken test... 04:33:44 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpSn9Y3p/profile http://localhost:49234/getInfo.html) 04:33:47 INFO - PID 1650 | 2017-05-02 04:33:47.891 plugin-container[1651:10211] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:33:47 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:47 INFO - PID 1650 | 2017-05-02 04:33:47.895 plugin-container[1651:10211] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a13, name = 'com.apple.CFPasteboardClient' 04:33:47 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:47 INFO - PID 1650 | 2017-05-02 04:33:47.895 plugin-container[1651:10211] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:33:48 INFO - PID 1650 | __metrics Screen width/height:1600/1200 04:33:48 INFO - PID 1650 | colorDepth:24 04:33:48 INFO - PID 1650 | Browser inner width/height: 1024/689 04:33:48 INFO - PID 1650 | __metrics 04:33:49 INFO - TEST-INFO | 1650: exit 0 04:33:49 INFO - Browser initialized. 04:33:49 INFO - Running cycle 1/1 for kraken test... 04:33:49 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpSn9Y3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:51 INFO - PID 1652 | 2017-05-02 04:33:51.327 plugin-container[1653:10335] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 04:33:51 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:51 INFO - PID 1652 | 2017-05-02 04:33:51.328 plugin-container[1653:10335] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x480b, name = 'com.apple.CFPasteboardClient' 04:33:51 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:51 INFO - PID 1652 | 2017-05-02 04:33:51.328 plugin-container[1653:10335] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:34:01 INFO - PID 1652 | RSS: Main: 234745856 04:34:01 INFO - PID 1652 | 04:34:03 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:04 INFO - PID 1652 | RSS: Main: 247963648 04:34:04 INFO - PID 1652 | 04:34:07 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 04:34:08 INFO - PID 1652 | RSS: Main: 256364544 04:34:08 INFO - PID 1652 | 04:34:11 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 04:34:12 INFO - PID 1652 | RSS: Main: 258830336 04:34:12 INFO - PID 1652 | 04:34:14 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 04:34:14 INFO - PID 1652 | RSS: Main: 260947968 04:34:14 INFO - PID 1652 | 04:34:16 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:17 INFO - PID 1652 | RSS: Main: 261718016 04:34:17 INFO - PID 1652 | 04:34:20 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:21 INFO - PID 1652 | RSS: Main: 266883072 04:34:21 INFO - PID 1652 | 04:34:23 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:24 INFO - PID 1652 | RSS: Main: 268574720 04:34:24 INFO - PID 1652 | 04:34:27 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 04:34:28 INFO - PID 1652 | RSS: Main: 267563008 04:34:28 INFO - PID 1652 | 04:34:29 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:30 INFO - PID 1652 | RSS: Main: 267182080 04:34:30 INFO - PID 1652 | 04:34:32 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:32 INFO - PID 1652 | RSS: Main: 267186176 04:34:32 INFO - PID 1652 | 04:34:34 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:35 INFO - PID 1652 | RSS: Main: 266776576 04:34:35 INFO - PID 1652 | 04:34:38 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:39 INFO - PID 1652 | RSS: Main: 266850304 04:34:39 INFO - PID 1652 | 04:34:42 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:42 INFO - PID 1652 | RSS: Main: 267132928 04:34:42 INFO - PID 1652 | 04:34:44 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 04:34:45 INFO - PID 1652 | RSS: Main: 268623872 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | __start_tp_report 04:34:45 INFO - PID 1652 | _x_x_mozilla_page_load 04:34:45 INFO - PID 1652 | _x_x_mozilla_page_load_details 04:34:45 INFO - PID 1652 | |i|pagename|runs| 04:34:45 INFO - PID 1652 | |0;ai-astar;104;116;122;115;113;115;109;116;116;115 04:34:45 INFO - PID 1652 | |1;audio-beat-detection;146;111;108;147;129;147;143;140;168;111 04:34:45 INFO - PID 1652 | |2;audio-dft;198;198;196;221;225;251;169;273;288;218 04:34:45 INFO - PID 1652 | |3;audio-fft;81;68;77;78;65;82;86;49;70;82 04:34:45 INFO - PID 1652 | |4;audio-oscillator;90;71;84;72;72;72;97;106;99;114 04:34:45 INFO - PID 1652 | |5;imaging-gaussian-blur;105;89;90;89;90;93;102;90;89;88 04:34:45 INFO - PID 1652 | |6;imaging-darkroom;97;97;96;97;96;121;96;96;96;96 04:34:45 INFO - PID 1652 | |7;imaging-desaturate;93;120;89;140;105;89;92;90;91;125 04:34:45 INFO - PID 1652 | |8;json-parse-financial;50;51;48;50;52;51;50;52;51;50 04:34:45 INFO - PID 1652 | |9;json-stringify-tinderbox;59;57;54;55;64;61;57;61;56;58 04:34:45 INFO - PID 1652 | |10;stanford-crypto-aes;82;86;82;85;81;83;82;85;81;84 04:34:45 INFO - PID 1652 | |11;stanford-crypto-ccm;139;125;144;158;155;139;144;157;201;148 04:34:45 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;184;184;184;222;184;186;184;180;184;187 04:34:45 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;66;87;96;96;99;60;88;93;95;96 04:34:45 INFO - PID 1652 | __end_tp_report 04:34:45 INFO - PID 1652 | __start_cc_report 04:34:45 INFO - PID 1652 | _x_x_mozilla_cycle_collect,990 04:34:45 INFO - PID 1652 | __end_cc_report 04:34:45 INFO - PID 1652 | __startTimestamp1493724884999__endTimestamp 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | ------- Summary: start ------- 04:34:45 INFO - PID 1652 | Number of tests: 14 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.50 stddev:4.77 (4.1%) stddev-sans-first:3.38 04:34:45 INFO - PID 1652 | Values: 104.0 116.0 122.0 115.0 113.0 115.0 109.0 116.0 116.0 115.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:144.50 stddev:19.73 (13.7%) stddev-sans-first:20.52 04:34:45 INFO - PID 1652 | Values: 146.0 111.0 108.0 147.0 129.0 147.0 143.0 140.0 168.0 111.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:223.70 Median:223.00 stddev:37.17 (16.7%) stddev-sans-first:38.24 04:34:45 INFO - PID 1652 | Values: 198.0 198.0 196.0 221.0 225.0 251.0 169.0 273.0 288.0 218.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:73.80 Median:79.50 stddev:11.07 (13.9%) stddev-sans-first:11.43 04:34:45 INFO - PID 1652 | Values: 81.0 68.0 77.0 78.0 65.0 82.0 86.0 49.0 70.0 82.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:78.00 stddev:15.91 (20.4%) stddev-sans-first:16.85 04:34:45 INFO - PID 1652 | Values: 90.0 71.0 84.0 72.0 72.0 72.0 97.0 106.0 99.0 114.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:89.50 stddev:5.99 (6.7%) stddev-sans-first:4.31 04:34:45 INFO - PID 1652 | Values: 105.0 89.0 90.0 89.0 90.0 93.0 102.0 90.0 89.0 88.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:96.00 stddev:7.81 (8.1%) stddev-sans-first:8.26 04:34:45 INFO - PID 1652 | Values: 97.0 97.0 96.0 97.0 96.0 121.0 96.0 96.0 96.0 96.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:89.50 stddev:18.47 (20.6%) stddev-sans-first:19.20 04:34:45 INFO - PID 1652 | Values: 93.0 120.0 89.0 140.0 105.0 89.0 92.0 90.0 91.0 125.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:1.18 (2.3%) stddev-sans-first:1.24 04:34:45 INFO - PID 1652 | Values: 50.0 51.0 48.0 50.0 52.0 51.0 50.0 52.0 51.0 50.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.50 stddev:3.08 (5.3%) stddev-sans-first:3.26 04:34:45 INFO - PID 1652 | Values: 59.0 57.0 54.0 55.0 64.0 61.0 57.0 61.0 56.0 58.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.79 (2.1%) stddev-sans-first:1.86 04:34:45 INFO - PID 1652 | Values: 82.0 86.0 82.0 85.0 81.0 83.0 82.0 85.0 81.0 84.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:151.50 stddev:20.20 (13.3%) stddev-sans-first:20.95 04:34:45 INFO - PID 1652 | Values: 139.0 125.0 144.0 158.0 155.0 139.0 144.0 157.0 201.0 148.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.90 Median:184.00 stddev:12.11 (6.6%) stddev-sans-first:12.77 04:34:45 INFO - PID 1652 | Values: 184.0 184.0 184.0 222.0 184.0 186.0 184.0 180.0 184.0 187.0 04:34:45 INFO - PID 1652 | 04:34:45 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.60 Median:95.50 stddev:13.56 (14.2%) stddev-sans-first:11.92 04:34:45 INFO - PID 1652 | Values: 66.0 87.0 96.0 96.0 99.0 60.0 88.0 93.0 95.0 96.0 04:34:45 INFO - PID 1652 | -------- Summary: end -------- 04:34:45 INFO - PID 1652 | 04:34:46 INFO - TEST-INFO | 1652: exit 0 04:34:46 INFO - TEST-OK | kraken | took 61455ms 04:34:46 INFO - SUITE-END | took 1175s 04:34:46 INFO - Completed test suite (00:19:36) 04:34:46 INFO - javascript benchmark 04:34:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7895.821103687293, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2786.4705705915876, 3556.8399422026023, 3603.5315408996826, 3618.6019537850816, 3667.2298817248384, 5126.487351264872, 5537.667739935601, 5681.261436013323, 6132.110843927628, 6188.133661287423, 5498.4501549845, 6153.1077993691, 6169.259688837335, 6169.5989760665525, 6216.502679785618, 5348.117560602496, 5383.031054410205, 5427.240186373911, 5435.619506634537, 5506.229127922094, 4538.7503687297185, 5436.836894893159, 5486.753096110685, 5517.475839795213, 5517.613767036309, 5432.6740395576, 5458.372287186985, 5464.098423760075, 5473.534749546293, 5512.586556008316, 5475.479829416199, 5481.725913704338, 5507.834764957058, 5522.171674248895, 5526.281583394173, 5398.676079435247, 5425.186222066682, 5426.593005524602, 5428.5385742211565, 5449.707820465001, 5061.5950723942, 6114.807612515561, 6125.47964319526, 6135.570510064297, 6190.50475961922, 6659.9001014984815, 6693.129893113913, 6696.129503164606, 6696.5647232929705, 6716.697748601276, 6790.151231096113, 6804.659767011679, 6806.0, 6813.625250611214, 6823.590584564892, 6245.188125543741, 6256.937430625727, 6335.461485773669, 6340.461060809791, 6367.204099487564, 6919.37725604698, 6960.338767817049, 6976.686049127801, 6992.160940687048, 6994.615296158659, 6389.9680501597195, 6437.742490300429, 6533.444657204096, 6640.8671826563195, 6649.933500665028, 6574.046763219402, 6579.374959378852, 6782.457403407716, 6783.626900520519, 6785.1518560179975, 5970.671613061323, 6182.752689892444, 6688.0, 6690.799276021728, 6707.295733947963, 6490.545661803723, 6577.638229897306, 6578.407943285031, 6638.535302528777, 6714.52998290115, 5293.550048245942, 5334.226537152092, 5354.143337066051, 5357.43746906577, 5385.3268341457315, 4715.599174070242, 4728.290756386501, 4734.502877197913, 4768.904621907543, 4771.23660214371, 5006.4743201963265, 6261.749530018839, 6363.077353783676, 6399.04014397844, 6426.8714625707225, 6683.43190828785, 6722.294159113223, 6751.122354094035, 6762.120924279812, 6795.0, 6325.0, 6368.949123394588, 6369.777057803048, 6382.457491113308, 6404.167458230493, 5772.942270577324, 5939.673317967467, 5948.821535353946, 5966.701664916824, 5966.910496342558, 6845.418139458202, 6864.450843932574, 6971.79084627462, 6974.581525108307, 6991.7902462926195, 6776.7628133015105, 6784.93215067843, 6806.9659651703405, 6812.523123381316, 6875.174979002351, 6921.204061532988, 6973.12835895513, 6987.650617469005, 7001.054857594363, 7044.330788575077, 5119.974400127976, 5776.0, 6177.567570270038, 6566.113574667359, 6653.833654158685, 6653.135092437952, 6776.695048722918, 6783.118194634666, 6812.557183783038, 6822.351876571718, 5763.510101641407, 6291.811245662638, 6445.742170313135, 6466.935330646634, 6594.505412094208, 6487.610743355413, 6568.868622627616, 6568.967155164385, 6584.868302633825, 6593.80218593443, 5298.97350513245, 6313.936860631518, 6389.945658966404, 6424.2933277338525, 6496.317886621837, 6564.901526477202, 6585.934140658532, 6609.372109649576, 6626.370494802986, 6641.933580664325, 6434.517411194086, 6436.0, 6440.742370305135, 6442.065900444316, 6465.709043093166], "value": 6074.200172491995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.9445791565632, 766.4481573267245, 821.548148518315, 1213.278099530779, 1264.5068423314915, 36660.63339366605, 37784.05539861505, 37839.243215135684, 37879.99999999996, 37905.241895162115, 32397.514037289402, 37654.24691506168, 37681.811590942074, 37715.81142094286, 37968.620313796855, 7825.256600622932, 7983.880241796378, 8058.758237252891, 8438.578071096452, 8461.196186362316, 8389.916100838975, 8434.746957591282, 8454.0, 8487.44831585948, 8517.190866867637, 8440.324774018063, 8442.746717598482, 8514.616842242114, 8519.488830670149, 8546.0, 8389.832203355898, 8411.242988131067, 8465.619047142862, 8488.87266690997, 8488.872666910001, 7050.506464547484, 8277.213664701843, 8297.294729947962, 8339.082700902896, 8351.749447516584, 37101.814490927376, 37371.0, 37506.24987500262, 37539.62460375416, 37590.43614345787, 3530.6822385985383, 3541.8937431877084, 3547.8048707321086, 3548.7515873888838, 3557.2529768748595, 30623.693763062307, 30627.693723062708, 30658.233544161576, 30727.0, 30839.383212335626, 2663.813533052687, 3065.371598822236, 3077.861496232675, 3080.291532947412, 3087.72210501056, 215140.0, 243093.56906430886, 257906.99999999814, 271470.0, 271961.0, 46393.0, 46482.0, 46526.76736616295, 46561.0, 46622.53377466182, 48175.0, 48623.513764862604, 54743.0, 55519.44480555224, 55709.721451392485, 14661.48684796027, 14784.965052446225, 14789.408423663148, 14799.852001480063, 14837.777433338508, 11779.823302650468, 11933.641990740292, 11936.701582460335, 11978.221415607957, 12001.819972700416, 14212.289385530683, 14215.0, 14227.573172804832, 14241.857581424054, 14338.928305358406, 5092.312537807423, 5312.884294298241, 6013.067974463965, 6035.124906888476, 6285.654289014056, 901.977450563728, 921.5668635741191, 1043.8538604595362, 1080.702806728156, 1095.3482677806692, 19680.0, 23063.654045189334, 24674.259772206864, 24773.876130619592, 24992.625110623354, 987.6148302162162, 1094.2176343914139, 1131.7453572946022, 1166.8133098704166, 1182.1252273317682, 12703.872961270454, 12823.422945967453, 12838.165519241405, 12870.356482175854, 12907.0, 286423.0, 341848.0, 343918.0, 344027.0, 344483.2775836155, 54436.0, 54545.45454545483, 54563.18155227675, 54615.72692136514, 54821.72589137029, 1524.3521503361028, 1533.9002964807253, 1577.7791109244715, 1581.4464937271862, 1594.856462918343, 22159.002844872342, 22692.432689182242, 24408.755912440647, 24710.011599535817, 24725.381865453506, 38153.0, 38252.85241442761, 38266.0, 38271.0, 38437.84686459411, 299185.5040724782, 299639.0, 299948.0, 300231.0, 300617.993820059, 31070.912518062665, 32259.838700806347, 34767.30465390729, 35541.28917421689, 36441.90674279776, 38041.85874423772, 39511.81464556068, 42938.78530607327, 43412.0, 45713.77143114263, 25401.364965875262, 28503.429931400842, 29556.408871822874, 30555.694443055287, 31055.534166987964, 30703.385932280784, 30794.538081929237, 31191.84404077965, 31207.0, 31265.218369540034, 37453.06367340838, 37969.24061518809, 38342.23315533729, 38351.808240959734, 38390.808045959595, 25624.359391014626, 29962.550561741155, 30609.928652497056, 31227.0, 31682.207944801565, 22549.43626409353, 24324.513509729353, 24370.390740231636, 24826.751732482444, 24907.875460623305], "value": 17471.18339644492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.19180133151013, 441.4944888103121, 445.6319100361888, 458.2004402317955, 458.80959401848236, 19628.411147665574, 21312.36062918113, 22130.88934555325, 22191.778082219174, 22226.999785009673, 21804.236851710193, 22381.769002704845, 23263.185788497405, 23272.76727232727, 23449.296521104352, 6176.197094377736, 6315.463185629227, 6339.619622822645, 6395.072714456401, 6403.551751377406, 6071.3625069367745, 6269.216347956505, 6316.557840951135, 6332.113504109406, 6340.0, 6104.755809767604, 6217.347178546255, 6266.122742816009, 6277.152584401116, 6350.936490635104, 6182.1345011698395, 6193.6903154842075, 6224.035274532432, 6230.906536401958, 6238.4385405313515, 5484.670919744828, 5486.067368547317, 5539.806106786284, 5548.55611551079, 5553.805616803433, 26959.730402695917, 27019.45961080787, 27149.45701085987, 27240.59139112915, 27321.453570928472, 2232.810211132056, 2274.0221704666988, 2285.725712914444, 2291.5875142474347, 2298.069281940817, 17403.651926961516, 17783.19975601101, 17904.373346932796, 18172.182251798567, 18313.450596482126, 2147.50607360308, 2158.686990386401, 2182.0944308112116, 2191.539776646906, 2199.8680079195137, 159507.0, 159960.60059099123, 161444.0, 162746.0, 164116.17941910334, 11056.778864422666, 12761.29812860283, 12772.233665980071, 12927.741445171045, 13071.281079540717, 16346.34614615426, 16670.499885003468, 16670.666586668198, 16728.330866765195, 16746.0, 8660.39377243587, 8941.955290223637, 8990.685326013558, 9122.543872806333, 9129.269658427309, 8430.957190009383, 8433.789155271044, 8450.535220562806, 8614.353923455767, 8699.0, 7910.841783164305, 7999.920000800034, 8076.27313541784, 8105.311048560939, 8111.391645626483, 1838.6782313095155, 2154.1060459908963, 2158.8488805783445, 2169.848110632272, 2373.311739595498, 798.6046906781064, 867.6789587852409, 953.814006268771, 970.5632465390603, 1042.3954106618144, 18655.253789848524, 20341.49146271355, 21531.89234053851, 21595.784042159376, 21700.891495542735, 1000.279798545061, 1010.525053224983, 1021.8620486234412, 1033.7002269341956, 1044.242923880196, 9332.486713230837, 10729.088027517591, 11072.667819965414, 11087.889121108847, 11176.385298808644, 512829.0, 549808.0, 555074.0, 557189.0, 558457.0, 104139.0, 118963.0, 127130.0, 135468.0, 138721.0, 1192.874748151449, 1212.860521040074, 1243.8258643789695, 1246.6883279180206, 1251.1492185313891, 18787.0, 20326.085326160064, 22663.0, 22680.144375455882, 22699.773002270427, 54928.04305974989, 57801.71099144477, 58305.70847145737, 58404.4159558399, 58508.0, 72014.91977620445, 73054.17364565928, 74003.0, 75488.49023019618, 75751.5911783982, 8691.565421728761, 8968.417052891542, 8976.147266009719, 9064.50145242018, 9089.818203635758, 14260.358283877044, 14294.356753946306, 14315.856841431452, 14595.270236488346, 14770.335334910169, 11907.880921190677, 12046.457909393923, 12060.15578909503, 12164.08769342285, 12211.328376939353, 11163.665090047312, 11227.66317010491, 11466.484008219817, 11644.592439264585, 11912.583059592873, 10723.142148628247, 12135.02919766399, 12179.451924663234, 12200.877991219973, 12233.3271670059, 8744.475331480131, 8880.245179159843, 9024.503652298923, 9028.954855225682, 9105.362624616479, 11412.429378530875, 12035.578754743541, 12251.69370765738, 12270.938645306716, 12274.509019639114], "value": 10572.328973206073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2151106136093, 1436.612114729024, 1436.755751522241, 1474.764037753959, 1474.8082749242596, 9098.954505227473, 11369.147313951446, 11687.824682629767, 11832.053435725133, 11992.920637142655, 11569.53721851125, 11822.527098916033, 11823.34971576563, 11832.645020649394, 11871.406429678504, 2499.9000039998377, 2549.197002944076, 2550.579154439515, 2560.7695307422327, 2566.871656417181, 2483.2301986384186, 2527.8736063196857, 2528.5575024370755, 2533.8479691218586, 2534.4044149624915, 2448.326710154704, 2470.567650661136, 2493.326801763523, 2495.800335973118, 2508.2726009457238, 2459.6433517140003, 2482.466269752003, 2504.749525047499, 2512.6984761828517, 2519.344970307715, 2395.35325462126, 2484.00639744102, 2500.712418071927, 2502.774750272466, 2506.135383292761, 11661.475233614508, 11770.117241206945, 11776.293422394683, 11776.352300623463, 11867.703307417383, 6603.7688680895935, 6765.830854228634, 6840.521163518556, 6852.965735171342, 6854.451643868479, 3978.0253837809632, 4311.525732169459, 4389.275769498029, 4389.539098394686, 4391.6047555719815, 1260.4706023470073, 1268.9175203611735, 1292.8965682745452, 1305.073397887501, 1309.9214047157202, 13479.326033698277, 16247.593810154722, 16369.754453683205, 16447.25987330561, 16545.586360341087, 4255.8084886180195, 5508.173773933942, 5674.205611214434, 5683.26117604717, 5695.5443564514735, 9814.362066465657, 11724.70688232801, 11736.237144585575, 11753.294802311717, 11782.351970641697, 6523.575967562093, 6536.607803531708, 6553.279139294674, 6562.2453417856605, 6573.539852210395, 6050.6974651267265, 6087.756489740361, 6246.781362652286, 6253.437190652863, 6262.530310226751, 3660.6156353583024, 4292.227399068198, 4410.3825464435, 4439.822407103744, 4491.438570178728, 1131.8981291683788, 1268.1503392726895, 1283.063363744453, 1288.5361269942814, 1290.0904862072216, 777.6267391651926, 791.4301702773994, 808.8463191993502, 814.1004190369674, 829.2536716954789, 5228.9738551307, 5791.610013596706, 6134.355892631299, 6390.137331460193, 7128.275092862775, 791.8178818871577, 940.8635747816528, 947.9099485548862, 950.5342382232657, 962.8844538655406, 4103.7948102594755, 4248.660107191417, 4291.871243862689, 4399.802008909543, 4465.464144302705, 14484.85515144835, 14993.250337483083, 15069.17119558413, 15097.0, 15105.169215693022, 14484.710305793826, 14867.256637168099, 14959.92520037393, 14989.0, 15124.848751512343, 7504.849903001909, 8405.327573794082, 8602.655893764304, 8643.567821608895, 8660.69687560945, 5882.94117058841, 6052.0, 6870.385459416933, 6964.501424218155, 7051.1186101737285, 10684.145268378355, 13045.0, 13117.475300987853, 13136.40886160106, 13399.665008374868, 12376.319302438453, 13475.932620336836, 13575.79636305476, 13835.79246311286, 13884.305784710523, 9037.593308301273, 9282.9535852323, 9398.95300523493, 9496.43021418717, 9497.810043799223, 10941.179411544006, 10954.835677464685, 11020.44897755093, 11040.447977601249, 11041.889581104086, 8905.376623636283, 8923.0, 9058.592363343798, 9071.591778369857, 9184.632614695338, 8825.293976481738, 8827.735167944971, 8901.376903616685, 8917.554122293988, 8924.286057115545, 8122.75631731049, 8148.83702325962, 8156.0, 8248.340132789242, 8293.087760346478, 5986.43128902771, 6011.068284415923, 6069.575129740876, 6158.414950579688, 6203.658798766111, 5565.6104072714525, 6035.758569657164, 6109.022556390956, 6236.781712640217, 6397.4562162216735], "value": 5357.932353025119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.5017696420281, 383.77932688704004, 406.1734370555918, 410.56070005094523, 413.62773503846535, 5531.695756733378, 5684.801031963882, 5990.880182396355, 6435.099086127946, 6506.642134682591, 5360.517553420192, 5465.9726701366435, 5906.5570082243785, 6043.884640375866, 6359.427651511363, 4556.339330797033, 4574.771261436931, 4586.77066146693, 4598.103369842882, 4601.516840731725, 3417.6500282388565, 3886.1644746379525, 4139.275626765319, 4517.9774101129615, 4619.706482184977, 4520.954790452102, 4545.454545454533, 4561.156186105581, 4563.452385713719, 4575.450945886499, 3753.493278407407, 4569.246074397721, 4570.908581828378, 4591.862244132682, 4602.815887364502, 3471.444568868994, 3595.9101022474647, 3713.721470889667, 3875.1087249932675, 3924.725269231155, 5325.840224793263, 5728.42715728428, 6191.349908259658, 6229.570467517672, 6241.126242326078, 5462.153366228241, 5496.945030549723, 5504.422035686275, 5513.724313784335, 5516.779328826842, 5548.307766131328, 6566.967165164191, 6727.865442691168, 6791.864162716767, 6823.351781580742, 3793.7534060285993, 4091.40674602184, 4391.297392417198, 4394.472663280395, 4407.889802754925, 6496.675166241669, 6912.005429792009, 7096.609686467243, 7216.206217316091, 7285.996351003463, 4432.512423633398, 4441.289393696993, 4456.041950980555, 4456.977715111469, 4459.531749166355, 4410.625096866738, 4431.933520997188, 4518.096380723802, 4521.344405061248, 4531.025829446685, 4023.91952160961, 5276.894462110737, 5380.354357477127, 5399.514043736082, 5419.566434685295, 6843.62360070191, 6844.4182244509775, 6852.349026842442, 6862.519623626298, 6874.14722890005, 1530.8545688159606, 1537.7232098222428, 1538.6307286251442, 1545.0883978452766, 1549.1170033081262, 836.5986971822174, 986.1962500562018, 988.7824678570703, 996.3274789517047, 1011.22135955314, 5348.358197016383, 6250.218722659668, 6503.967480162569, 6519.413252807175, 6537.1501704778075, 5859.736311865976, 6199.814005579839, 6417.486601071903, 6882.69027893736, 6898.930665746817, 5369.919451208235, 6456.677166141674, 6507.3797603701905, 6539.0, 6544.312847151075, 3228.8537569163077, 3405.5062016008037, 3524.6827785498917, 3694.704423646102, 3709.295233905549, 7072.328128827753, 7286.817829554304, 7290.854182916312, 7315.817104572428, 7340.706371745177, 6432.839179020562, 7124.394426473704, 7250.854982900418, 7260.818479537948, 7296.306850849161, 6531.934680653228, 6649.411905784993, 7319.451041171827, 7419.777406677808, 7451.105867296068, 6133.883810085514, 6466.902996455151, 6958.826029349104, 7078.221395646372, 7102.4673149512955, 7065.470089743392, 7093.32613401726, 7103.609301488468, 7121.679524421517, 7148.606826624586, 6542.803715888341, 6597.835054123685, 7450.105987281561, 7466.8506629866015, 7478.214787447239, 4406.955930440655, 4428.75641839689, 4434.113177364605, 4443.955560444354, 4453.309736990772, 5798.507126894261, 5902.970485147547, 6223.719932602953, 7011.894821577783, 7187.676554554953, 5923.229980102559, 6052.60790018307, 6737.629430381376, 6827.692753825991, 6832.863342733217, 5753.827385178452, 5823.272090988627, 6421.440777048348, 6826.146731658543, 6836.213835408992, 5583.69289689071, 6470.7088181032905, 6617.569857959217, 6642.43539299165, 6696.698648560924, 5719.28508936383, 6819.795406137824, 6839.623820689711, 6864.965675171592, 6888.039377357939, 6425.1968503937005, 6542.443892269211, 6655.767048153291, 6657.800265992028, 6669.499362643561], "value": 4837.948900726379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.5712229712511, 791.1100012485954, 825.2490233887164, 859.2782063067023, 865.1478293880526, 14636.41454341825, 15071.040764700574, 16246.268917898693, 16590.585235369123, 16627.75058374124, 15280.159591222478, 15731.84268157318, 17101.48695539136, 17581.648367032652, 17663.381781637647, 977.9902200977988, 1007.249599048706, 1010.2877471382658, 1016.1972042086743, 1018.3024628129717, 909.6088681866795, 1012.812629663511, 1021.0861279155151, 1022.1975749037008, 1026.296986564206, 862.361852229352, 1070.0, 1075.0163600305711, 1075.9946200268987, 1078.8651418572679, 1069.9251052426334, 1072.6781965410385, 1074.6453670288824, 1075.2473268711856, 1076.993011534218, 645.3449748505271, 661.4840424468922, 796.4982061301401, 797.5294576200012, 797.7247849491916, 16685.332586696517, 16816.32734690611, 16834.242459089248, 17319.047452390114, 17412.0, 16960.3215871365, 16991.235394407282, 17094.743578846326, 17161.399351022654, 17343.479695609152, 11599.826002609967, 11996.64010079699, 12080.879191208063, 13964.371603277878, 14053.156810591398, 3614.0, 3626.746127771057, 3629.8548058077645, 3632.8183590820354, 3637.217998130415, 105267.0, 117515.4124229382, 128367.0, 130531.59949804754, 131635.0, 13201.867981320256, 13552.525661601796, 13556.0, 13739.0, 13777.655558610915, 25168.0, 25234.36914077126, 25643.97424103015, 25910.481790364465, 26172.82222300001, 7728.690852365842, 8000.51996880189, 8015.158408367154, 8034.517928924283, 8067.152948940394, 3409.4544872820725, 3976.1053762903116, 4056.35098384263, 4065.5121385433345, 4066.4916885389325, 4198.874033778991, 4339.479262488521, 4406.691531592758, 4412.007298357844, 4423.469183697913, 817.7751118442357, 901.4591245252795, 934.8036912248368, 939.3565407695613, 941.4210260689626, 630.4767043354005, 651.5667081390822, 664.6311297230084, 671.895856142289, 690.3579670906005, 9318.741969834122, 11098.0, 11324.547018119347, 11446.19876608646, 11869.881301186877, 651.2965996723527, 652.7617419641797, 657.0768070860448, 670.276101810044, 679.5752654590881, 5337.653052551572, 5411.431799661058, 5545.916811247835, 5603.6077474577205, 5650.0959846424375, 109791.45104274427, 110051.89948100576, 111257.0, 111335.44332278287, 111493.44253278682, 93143.0, 97796.0, 98103.0, 98131.99999999857, 98782.5060874691, 73237.53524929365, 86109.0, 88361.0, 88461.55769221112, 89752.20495590051, 10640.201984851012, 10746.24776265654, 10905.0, 10913.290636108628, 10936.398498082683, 37311.81344093371, 43055.569444306406, 43642.56357436385, 44203.557964419946, 44438.777806112055, 41324.793376032925, 42197.578024220595, 55657.0, 56112.0, 56642.716786415804, 13707.314634268447, 13819.723605527632, 13876.514321998682, 15769.526914192593, 17011.574710632332, 18188.90905545464, 18518.629627407645, 18593.721094183868, 18667.346642867433, 18738.531536711147, 16352.0, 16702.74945875837, 17367.826321736622, 17408.129593520527, 17448.953062816272, 16651.583710407336, 16804.663906722042, 16899.493015209562, 17411.825881741526, 17537.0, 16214.51356459308, 16276.593085172492, 16804.915975420045, 16941.407050753165, 16978.83021169822, 10259.7435064124, 11332.263402878787, 12001.279923204287, 12007.639770806889, 12102.152849300464, 10908.509117089592, 12907.677308066997, 13049.021323400593, 13059.412326445523, 13066.0], "value": 8331.301373553404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 122.0, 115.0, 113.0, 115.0, 109.0, 116.0, 116.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 108.0, 147.0, 129.0, 147.0, 143.0, 140.0, 168.0, 111.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 196.0, 221.0, 225.0, 251.0, 169.0, 273.0, 288.0, 218.0], "value": 223.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 77.0, 78.0, 65.0, 82.0, 86.0, 49.0, 70.0, 82.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 84.0, 72.0, 72.0, 72.0, 97.0, 106.0, 99.0, 114.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 89.0, 90.0, 89.0, 90.0, 93.0, 102.0, 90.0, 89.0, 88.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 121.0, 96.0, 96.0, 96.0, 96.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 120.0, 89.0, 140.0, 105.0, 89.0, 92.0, 90.0, 91.0, 125.0], "value": 103.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 48.0, 50.0, 52.0, 51.0, 50.0, 52.0, 51.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 54.0, 55.0, 64.0, 61.0, 57.0, 61.0, 56.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 82.0, 85.0, 81.0, 83.0, 82.0, 85.0, 81.0, 84.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 125.0, 144.0, 158.0, 155.0, 139.0, 144.0, 157.0, 201.0, 148.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 184.0, 222.0, 184.0, 186.0, 184.0, 180.0, 184.0, 187.0], "value": 187.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 87.0, 96.0, 96.0, 99.0, 60.0, 88.0, 93.0, 95.0, 96.0], "value": 87.6, "unit": "score"}]}]} 04:34:46 INFO - Return code: 0 04:34:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:46 ERROR - # TBPL SUCCESS # 04:34:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:46 INFO - 2017-05-02 04:34:46.796 screenresolution[1658:10727] starting screenresolution argv=screenresolution get 04:34:46 INFO - 2017-05-02 04:34:46.799 screenresolution[1658:10727] Display 0: 1600x1200x32@60 04:34:46 INFO - 2017-05-02 04:34:46.805 screenresolution[1659:10730] starting screenresolution argv=screenresolution list 04:34:46 INFO - Available Modes on Display 0 04:34:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:47 INFO - Intel Iris: 04:34:47 INFO - Chipset Model: Intel Iris 04:34:47 INFO - Type: GPU 04:34:47 INFO - Bus: Built-In 04:34:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:47 INFO - Vendor: Intel (0x8086) 04:34:47 INFO - Device ID: 0x0a2e 04:34:47 INFO - Revision ID: 0x0009 04:34:47 INFO - Displays: 04:34:47 INFO - Display: 04:34:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:47 INFO - Display Serial Number: 1600x1200 60 04:34:47 INFO - Main Display: Yes 04:34:47 INFO - Mirror: Off 04:34:47 INFO - Online: Yes 04:34:47 INFO - Rotation: Supported 04:34:47 INFO - Return code: 0 04:34:47 INFO - Running post-action listener: _resource_record_post_action 04:34:47 INFO - [mozharness: 2017-05-02 11:34:47.041698Z] Finished run-tests step (success) 04:34:47 INFO - Running post-run listener: _resource_record_post_run 04:34:47 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39521280; Write bytes: 511649280; Read time: 399; Write time: 1916 04:34:47 INFO - TinderboxPrint: CPU usage
54.0% 04:34:47 INFO - TinderboxPrint: I/O read bytes / time
39,521,280 / 399 04:34:47 INFO - TinderboxPrint: I/O write bytes / time
511,649,280 / 1,916 04:34:47 INFO - TinderboxPrint: CPU idle
2,202.7 (46.0%) 04:34:47 INFO - TinderboxPrint: CPU system
963.6 (20.1%) 04:34:47 INFO - TinderboxPrint: CPU user
1,623.3 (33.9%) 04:34:47 INFO - TinderboxPrint: Swap in / out
248,791,040 / 0 04:34:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208073216; Write bytes: 206084096; Read time: 16397; Write time: 491 04:34:47 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34941952; Write bytes: 298343936; Read time: 365; Write time: 1396 04:34:47 INFO - Running post-run listener: _upload_blobber_files 04:34:47 INFO - Blob upload gear active. 04:34:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:34:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:48 INFO - (blobuploader) - INFO - Done attempting. 04:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:49 INFO - (blobuploader) - INFO - Done attempting. 04:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:51 INFO - (blobuploader) - INFO - Done attempting. 04:34:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:53 INFO - (blobuploader) - INFO - Done attempting. 04:34:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:53 INFO - Return code: 0 04:34:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25f1a0987215f52765b54429443d3b1055ab043856f880d42cc33a6b22a01b3ee66550c6ef126b7cb9728af4ea396eaa03dde5c1442501e62fb6556f709f35dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f3aa2a901f050b74aa9218680bd9da11cf543de19d8f5f04ff71659638bba5ce352bbad377b55baac372235eefe1cd9cb21a6273f3be1eb5b6dba0839742198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd87c2e1080eb24e00c78a48c891c47eefe7f75b22cfa73e9b9b6d683379283c08e3058852affc54eec21af93daac4685a5bb259b1df855fab564f786425bcca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38790bd9b0a7d30eb5dbd0b42bbbea5c6a350ab3b591eddd2f6f6ad4b84f4212a706c7e50c3e8c1d7379d85225c58bdec34332ad9b9130dbc25b5e20eaa565d"} 04:34:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:53 INFO - Contents: 04:34:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25f1a0987215f52765b54429443d3b1055ab043856f880d42cc33a6b22a01b3ee66550c6ef126b7cb9728af4ea396eaa03dde5c1442501e62fb6556f709f35dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f3aa2a901f050b74aa9218680bd9da11cf543de19d8f5f04ff71659638bba5ce352bbad377b55baac372235eefe1cd9cb21a6273f3be1eb5b6dba0839742198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd87c2e1080eb24e00c78a48c891c47eefe7f75b22cfa73e9b9b6d683379283c08e3058852affc54eec21af93daac4685a5bb259b1df855fab564f786425bcca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38790bd9b0a7d30eb5dbd0b42bbbea5c6a350ab3b591eddd2f6f6ad4b84f4212a706c7e50c3e8c1d7379d85225c58bdec34332ad9b9130dbc25b5e20eaa565d"} 04:34:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:53 INFO - Copying logs to upload dir... 04:34:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.892724 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-02 04:34:53.408282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:53.411367) ========= 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.CsWSHSMy78/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.SWdq3rh3xq/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25f1a0987215f52765b54429443d3b1055ab043856f880d42cc33a6b22a01b3ee66550c6ef126b7cb9728af4ea396eaa03dde5c1442501e62fb6556f709f35dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f3aa2a901f050b74aa9218680bd9da11cf543de19d8f5f04ff71659638bba5ce352bbad377b55baac372235eefe1cd9cb21a6273f3be1eb5b6dba0839742198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd87c2e1080eb24e00c78a48c891c47eefe7f75b22cfa73e9b9b6d683379283c08e3058852affc54eec21af93daac4685a5bb259b1df855fab564f786425bcca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38790bd9b0a7d30eb5dbd0b42bbbea5c6a350ab3b591eddd2f6f6ad4b84f4212a706c7e50c3e8c1d7379d85225c58bdec34332ad9b9130dbc25b5e20eaa565d"} build_url:https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011004 build_url: 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25f1a0987215f52765b54429443d3b1055ab043856f880d42cc33a6b22a01b3ee66550c6ef126b7cb9728af4ea396eaa03dde5c1442501e62fb6556f709f35dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f3aa2a901f050b74aa9218680bd9da11cf543de19d8f5f04ff71659638bba5ce352bbad377b55baac372235eefe1cd9cb21a6273f3be1eb5b6dba0839742198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd87c2e1080eb24e00c78a48c891c47eefe7f75b22cfa73e9b9b6d683379283c08e3058852affc54eec21af93daac4685a5bb259b1df855fab564f786425bcca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38790bd9b0a7d30eb5dbd0b42bbbea5c6a350ab3b591eddd2f6f6ad4b84f4212a706c7e50c3e8c1d7379d85225c58bdec34332ad9b9130dbc25b5e20eaa565d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:53.446866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:53.447214) ========= 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.CsWSHSMy78/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.SWdq3rh3xq/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005030 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:53.495769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:34:53.496102) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:34:53.496421) ========= ========= Total master_lag: 0.18 =========