builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0166 starttime: 1479150003.56 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.561375) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.561798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.562076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.592793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.593160) ========= 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.t61O9livnz/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.LRMPgFuNux/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 11:00:03-- 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% 54.5M=0s 2016-11-14 11:00:03 (54.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104242 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.719943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.720247) ========= 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.t61O9livnz/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.LRMPgFuNux/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.028211 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:03.772830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:00:03.773173) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t61O9livnz/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.LRMPgFuNux/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 11:00:03,853 truncating revision to first 12 chars 2016-11-14 11:00:03,853 Setting DEBUG logging. 2016-11-14 11:00:03,853 attempt 1/10 2016-11-14 11:00:03,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f11ca24b2382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:00:05,040 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:00:05.224253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:05.227603) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:05.228019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:05.228286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:00:05.246834) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 11:00:05.247199) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t61O9livnz/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.LRMPgFuNux/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:05 INFO - MultiFileLogger online at 20161114 11:00:05 in /builds/slave/test 11:00:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:00:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:00:05 INFO - {'append_to_log': False, 11:00:05 INFO - 'base_work_dir': '/builds/slave/test', 11:00:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:00:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:00:05 INFO - 'branch': 'Mozilla-Aurora', 11:00:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:05 INFO - 'config_files': ('talos/mac_config.py',), 11:00:05 INFO - 'default_actions': ('clobber', 11:00:05 INFO - 'read-buildbot-config', 11:00:05 INFO - 'download-and-extract', 11:00:05 INFO - 'populate-webroot', 11:00:05 INFO - 'create-virtualenv', 11:00:05 INFO - 'install', 11:00:05 INFO - 'run-tests'), 11:00:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:05 INFO - 'download_minidump_stackwalk': True, 11:00:05 INFO - 'download_symbols': 'ondemand', 11:00:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:05 INFO - 'installer_path': 'installer.exe', 11:00:05 INFO - 'log_level': 'info', 11:00:05 INFO - 'log_name': 'talos', 11:00:05 INFO - 'log_to_console': True, 11:00:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:00:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:00:05 INFO - 'opt_config_files': (), 11:00:05 INFO - 'pip_index': False, 11:00:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:00:05 INFO - 'cmd': ('bash', 11:00:05 INFO - '-c', 11:00:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:00:05 INFO - 'enabled': True, 11:00:05 INFO - 'halt_on_failure': False, 11:00:05 INFO - 'name': 'check_screen_resolution'},), 11:00:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:00:05 INFO - 'cmd': ('bash', 11:00:05 INFO - '-c', 11:00:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:00:05 INFO - 'enabled': True, 11:00:05 INFO - 'halt_on_failure': False, 11:00:05 INFO - 'name': 'check_screen_resolution'},), 11:00:05 INFO - 'run_cmd_checks_enabled': True, 11:00:05 INFO - 'sps_profile': False, 11:00:05 INFO - 'sps_profile_interval': 0, 11:00:05 INFO - 'suite': 'dromaeojs-e10s', 11:00:05 INFO - 'system_bits': '32', 11:00:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:05 INFO - 'title': 't-yosemite-r7-0166', 11:00:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:05 INFO - 'use_talos_json': True, 11:00:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:00:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:05 INFO - 'work_dir': 'build'} 11:00:05 INFO - [mozharness: 2016-11-14 19:00:05.459012Z] Running clobber step. 11:00:05 INFO - Running pre-action listener: _resource_record_pre_action 11:00:05 INFO - Running main action method: clobber 11:00:05 INFO - rmtree: /builds/slave/test/build 11:00:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:00:07 INFO - Running post-action listener: _resource_record_post_action 11:00:07 INFO - [mozharness: 2016-11-14 19:00:07.663524Z] Finished clobber step (success) 11:00:07 INFO - [mozharness: 2016-11-14 19:00:07.663707Z] Running read-buildbot-config step. 11:00:07 INFO - Running pre-action listener: _resource_record_pre_action 11:00:07 INFO - Running main action method: read_buildbot_config 11:00:07 INFO - Using buildbot properties: 11:00:07 INFO - { 11:00:07 INFO - "project": "", 11:00:07 INFO - "product": "firefox", 11:00:07 INFO - "script_repo_revision": "production", 11:00:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 11:00:07 INFO - "repository": "", 11:00:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 11:00:07 INFO - "buildid": "20161114081542", 11:00:07 INFO - "pgo_build": "False", 11:00:07 INFO - "basedir": "/builds/slave/test", 11:00:07 INFO - "buildnumber": 19, 11:00:07 INFO - "slavename": "t-yosemite-r7-0166", 11:00:07 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:00:07 INFO - "platform": "yosemite_r7", 11:00:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:00:07 INFO - "branch": "mozilla-aurora", 11:00:07 INFO - "repo_path": "releases/mozilla-aurora", 11:00:07 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:00:07 INFO - "stage_platform": "macosx64", 11:00:07 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:00:07 INFO - "slavebuilddir": "test" 11:00:07 INFO - } 11:00:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 11:00:07 INFO - Running post-action listener: _resource_record_post_action 11:00:07 INFO - [mozharness: 2016-11-14 19:00:07.667240Z] Finished read-buildbot-config step (success) 11:00:07 INFO - [mozharness: 2016-11-14 19:00:07.667374Z] Running download-and-extract step. 11:00:07 INFO - Running pre-action listener: _resource_record_pre_action 11:00:07 INFO - Running main action method: download_and_extract 11:00:07 INFO - mkdir: /builds/slave/test/build/tests 11:00:07 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')]} 11:00:07 INFO - trying https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 11:00:07 INFO - Downloading https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 11:00:08 INFO - Downloaded 1199 bytes. 11:00:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:00:08 INFO - Using the following test package requirements: 11:00:08 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:00:08 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 11:00:08 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 11:00:08 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'jsshell-mac.zip'], 11:00:08 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 11:00:08 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:00:08 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 11:00:08 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 11:00:08 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 11:00:08 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:00:08 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 11:00:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:00:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:00:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:00:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:00:09 INFO - Http code: 200 11:00:09 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 11:00:09 INFO - x-amz-cf-id: EFO9061meL-fsLebL7tKHiK3_SICk_O0ZOuA5doVZlEzV7yO9_zoSg== 11:00:09 INFO - x-amz-version-id: beIhMZs6B_1lhCUU5tXTJZFEtB99JGu9 11:00:09 INFO - Expected file size: 16327504 11:00:09 INFO - Obtained file size: 16327504 11:00:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:00:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:00:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:00:16 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:00:17 INFO - Http code: 200 11:00:17 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 11:00:17 INFO - x-amz-cf-id: g063c9fT7Uai91UltHmQq5vVv8Gp7zSS8Z1vES3rutmBKg-7rICdRQ== 11:00:17 INFO - x-amz-version-id: beIhMZs6B_1lhCUU5tXTJZFEtB99JGu9 11:00:17 INFO - Expected file size: 16327504 11:00:17 INFO - Obtained file size: 16327504 11:00:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 11:00:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:00:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 11:00:24 INFO - Http code: 200 11:00:24 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 11:00:24 INFO - x-amz-cf-id: hTI_gVIHZ8F1tvx59oUwXgpJk5WLUl6DvWiJg4JnEDdjo-pUzlj7-A== 11:00:24 INFO - x-amz-version-id: fL.n5SYgNX8ZLi3RUYlMNYmEt036hZfV 11:00:25 INFO - Expected file size: 14409038 11:00:25 INFO - Obtained file size: 14409038 11:00: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')]} 11:00:25 INFO - trying https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:00:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 11:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 11:00:28 INFO - Downloaded 114359577 bytes. 11:00:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:00:28 INFO - mkdir: /builds/slave/test/properties 11:00:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:00:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:00:28 INFO - Contents: 11:00:28 INFO - build_url:https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:00:29 INFO - Running post-action listener: _resource_record_post_action 11:00:29 INFO - Running post-action listener: set_extra_try_arguments 11:00:29 INFO - [mozharness: 2016-11-14 19:00:29.019239Z] Finished download-and-extract step (success) 11:00:29 INFO - [mozharness: 2016-11-14 19:00:29.019362Z] Running populate-webroot step. 11:00:29 INFO - Running pre-action listener: _resource_record_pre_action 11:00:29 INFO - Running main action method: populate_webroot 11:00:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:29 INFO - '--tppagecycles', 11:00:29 INFO - '7'], 11:00:29 INFO - 'tests': ['tsvgm']}}, 11:00:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:00:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:00:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:00:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['damp', 'tps']}, 11:00:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'tests': ['damp', 'tps']}, 11:00:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['dromaeo_dom']}, 11:00:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['basic_compositor_video']}, 11:00:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:00:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['a11yr', 11:00:29 INFO - 'ts_paint', 11:00:29 INFO - 'tpaint', 11:00:29 INFO - 'sessionrestore', 11:00:29 INFO - 'sessionrestore_no_auto_restore', 11:00:29 INFO - 'tabpaint']}, 11:00:29 INFO - 'other-e10s': {'tests': ['a11yr', 11:00:29 INFO - 'ts_paint', 11:00:29 INFO - 'tpaint', 11:00:29 INFO - 'sessionrestore', 11:00:29 INFO - 'sessionrestore_no_auto_restore', 11:00:29 INFO - 'tabpaint']}, 11:00:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:00:29 INFO - 'ts_paint', 11:00:29 INFO - 'tpaint', 11:00:29 INFO - 'sessionrestore', 11:00:29 INFO - 'sessionrestore_no_auto_restore', 11:00:29 INFO - 'tabpaint']}, 11:00:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:00:29 INFO - 'ts_paint', 11:00:29 INFO - 'tpaint', 11:00:29 INFO - 'sessionrestore', 11:00:29 INFO - 'sessionrestore_no_auto_restore', 11:00:29 INFO - 'tabpaint']}, 11:00:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['a11yr', 11:00:29 INFO - 'ts_paint', 11:00:29 INFO - 'tpaint', 11:00:29 INFO - 'sessionrestore', 11:00:29 INFO - 'sessionrestore_no_auto_restore', 11:00:29 INFO - 'tabpaint']}, 11:00:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['a11yr', 11:00:29 INFO - 'ts_paint', 11:00:29 INFO - 'tpaint', 11:00:29 INFO - 'sessionrestore', 11:00:29 INFO - 'sessionrestore_no_auto_restore', 11:00:29 INFO - 'tabpaint']}, 11:00:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['tsvgx', 11:00:29 INFO - 'tsvgr_opacity', 11:00:29 INFO - 'tart', 11:00:29 INFO - 'tscrollx', 11:00:29 INFO - 'cart']}, 11:00:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:00:29 INFO - 'tsvgr_opacity', 11:00:29 INFO - 'tart', 11:00:29 INFO - 'tscrollx', 11:00:29 INFO - 'cart']}, 11:00:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'talos_options': ['--disable-e10s'], 11:00:29 INFO - 'tests': ['tp5o']}, 11:00:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'tests': ['tp5o']}, 11:00:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'talos_options': ['--disable-e10s', 11:00:29 INFO - '--xperf_path', 11:00:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:29 INFO - 'tests': ['tp5n']}, 11:00:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:29 INFO - 'talos_options': ['--xperf_path', 11:00:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:29 INFO - 'tests': ['tp5n']}}, 11:00:29 INFO - 'talos.zip': {'path': '', 11:00:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:29 INFO - Running post-action listener: _resource_record_post_action 11:00:29 INFO - [mozharness: 2016-11-14 19:00:29.037919Z] Finished populate-webroot step (success) 11:00:29 INFO - [mozharness: 2016-11-14 19:00:29.038027Z] Running create-virtualenv step. 11:00:29 INFO - Running pre-action listener: _resource_record_pre_action 11:00:29 INFO - Running main action method: create_virtualenv 11:00:29 INFO - Creating virtualenv /builds/slave/test/build/venv 11:00:29 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 11:00:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:00:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:29 INFO - Using real prefix '/tools/python27' 11:00:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:00:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:32 INFO - Installing pip.................done. 11:00:32 INFO - Return code: 0 11:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:00:32 INFO - Reading from file tmpfile_stdout 11:00:32 INFO - Output received: 11:00:32 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) 11:00:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00: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', 'pip>=1.5'] in /builds/slave/test/build 11:00: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 pip>=1.5 11:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:33 INFO - 'HOME': '/Users/cltbld', 11:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:33 INFO - 'LOGNAME': 'cltbld', 11:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:33 INFO - 'MOZ_NO_REMOTE': '1', 11:00:33 INFO - 'NO_EM_RESTART': '1', 11:00:33 INFO - 'PAGER': '/bin/cat', 11:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:33 INFO - 'PWD': '/builds/slave/test', 11:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:33 INFO - 'SHELL': '/bin/bash', 11:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:33 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:33 INFO - 'USER': 'cltbld', 11:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:33 INFO - 'XPC_FLAGS': '0x0', 11:00:33 INFO - 'XPC_SERVICE_NAME': '0', 11:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:33 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 11:00:33 INFO - Cleaning up... 11:00:33 INFO - Return code: 0 11:00:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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', '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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:00: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 psutil>=3.1.1 11:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:33 INFO - 'HOME': '/Users/cltbld', 11:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:33 INFO - 'LOGNAME': 'cltbld', 11:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:33 INFO - 'MOZ_NO_REMOTE': '1', 11:00:33 INFO - 'NO_EM_RESTART': '1', 11:00:33 INFO - 'PAGER': '/bin/cat', 11:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:33 INFO - 'PWD': '/builds/slave/test', 11:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:33 INFO - 'SHELL': '/bin/bash', 11:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:33 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:33 INFO - 'USER': 'cltbld', 11:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:33 INFO - 'XPC_FLAGS': '0x0', 11:00:33 INFO - 'XPC_SERVICE_NAME': '0', 11:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:33 INFO - Downloading/unpacking psutil>=3.1.1 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:36 INFO - Installing collected packages: psutil 11:00:36 INFO - Running setup.py install for psutil 11:00:36 INFO - building 'psutil._psutil_osx' extension 11:00:36 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 11:00:37 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 11:00:37 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 11:00:37 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 11:00:37 INFO - building 'psutil._psutil_posix' extension 11:00:37 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 11:00:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:00:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:00:37 INFO - ^ 11:00:37 INFO - 1 warning generated. 11:00:37 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 11:00:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:38 INFO - Successfully installed psutil 11:00:38 INFO - Cleaning up... 11:00:38 INFO - Return code: 0 11:00:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:38 INFO - 'HOME': '/Users/cltbld', 11:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:38 INFO - 'LOGNAME': 'cltbld', 11:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:38 INFO - 'MOZ_NO_REMOTE': '1', 11:00:38 INFO - 'NO_EM_RESTART': '1', 11:00:38 INFO - 'PAGER': '/bin/cat', 11:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:38 INFO - 'PWD': '/builds/slave/test', 11:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:38 INFO - 'SHELL': '/bin/bash', 11:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:38 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:38 INFO - 'USER': 'cltbld', 11:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:38 INFO - 'XPC_FLAGS': '0x0', 11:00:38 INFO - 'XPC_SERVICE_NAME': '0', 11:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:00:38 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 11:00:38 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 11:00:38 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 11:00:38 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 11:00:38 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 11:00:38 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 11:00:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:00:40 INFO - Installing collected packages: mozsystemmonitor 11:00:40 INFO - Running setup.py install for mozsystemmonitor 11:00:41 INFO - Successfully installed mozsystemmonitor 11:00:41 INFO - Cleaning up... 11:00:41 INFO - Return code: 0 11:00:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:00:41 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')]} 11:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:41 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')]} 11:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:41 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:41 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 11:00:41 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 11:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:41 INFO - 'HOME': '/Users/cltbld', 11:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:41 INFO - 'LOGNAME': 'cltbld', 11:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:41 INFO - 'MOZ_NO_REMOTE': '1', 11:00:41 INFO - 'NO_EM_RESTART': '1', 11:00:41 INFO - 'PAGER': '/bin/cat', 11:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:41 INFO - 'PWD': '/builds/slave/test', 11:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:41 INFO - 'SHELL': '/bin/bash', 11:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:41 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:41 INFO - 'USER': 'cltbld', 11:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:41 INFO - 'XPC_FLAGS': '0x0', 11:00:41 INFO - 'XPC_SERVICE_NAME': '0', 11:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:41 INFO - Downloading/unpacking jsonschema==2.5.1 11:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:44 INFO - warning: no files found matching '*.txt' 11:00:44 INFO - no previously-included directories found matching 'build' 11:00:44 INFO - no previously-included directories found matching 'dist' 11:00:44 INFO - no previously-included directories found matching '.git*' 11:00:44 INFO - Installing collected packages: jsonschema, functools32 11:00:44 INFO - Running setup.py install for functools32 11:00:44 INFO - warning: no files found matching '*.txt' 11:00:44 INFO - no previously-included directories found matching 'build' 11:00:44 INFO - no previously-included directories found matching 'dist' 11:00:44 INFO - no previously-included directories found matching '.git*' 11:00:44 INFO - Successfully installed jsonschema functools32 11:00:44 INFO - Cleaning up... 11:00:44 INFO - Return code: 0 11:00:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:44 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:44 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 11:00:44 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 11:00:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:44 INFO - 'HOME': '/Users/cltbld', 11:00:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:44 INFO - 'LOGNAME': 'cltbld', 11:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:44 INFO - 'MOZ_NO_REMOTE': '1', 11:00:44 INFO - 'NO_EM_RESTART': '1', 11:00:44 INFO - 'PAGER': '/bin/cat', 11:00:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:44 INFO - 'PWD': '/builds/slave/test', 11:00:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:44 INFO - 'SHELL': '/bin/bash', 11:00:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:44 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:44 INFO - 'USER': 'cltbld', 11:00:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:44 INFO - 'XPC_FLAGS': '0x0', 11:00:44 INFO - 'XPC_SERVICE_NAME': '0', 11:00:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:00:45 INFO - Cleaning up... 11:00:45 INFO - Return code: 0 11:00:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:45 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:45 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 11:00:45 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 11:00:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:45 INFO - 'HOME': '/Users/cltbld', 11:00:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:45 INFO - 'LOGNAME': 'cltbld', 11:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:45 INFO - 'MOZ_NO_REMOTE': '1', 11:00:45 INFO - 'NO_EM_RESTART': '1', 11:00:45 INFO - 'PAGER': '/bin/cat', 11:00:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:45 INFO - 'PWD': '/builds/slave/test', 11:00:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:45 INFO - 'SHELL': '/bin/bash', 11:00:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:45 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:45 INFO - 'USER': 'cltbld', 11:00:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:45 INFO - 'XPC_FLAGS': '0x0', 11:00:45 INFO - 'XPC_SERVICE_NAME': '0', 11:00:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:45 INFO - Downloading/unpacking blobuploader==1.2.4 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:00:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:48 INFO - Downloading docopt-0.6.1.tar.gz 11:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:49 INFO - Running setup.py install for blobuploader 11:00:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:00:49 INFO - Running setup.py install for requests 11:00:49 INFO - Running setup.py install for docopt 11:00:49 INFO - Successfully installed blobuploader requests docopt 11:00:49 INFO - Cleaning up... 11:00:49 INFO - Return code: 0 11:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:49 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:49 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 11:00:49 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 11:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:49 INFO - 'HOME': '/Users/cltbld', 11:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:49 INFO - 'LOGNAME': 'cltbld', 11:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:49 INFO - 'MOZ_NO_REMOTE': '1', 11:00:49 INFO - 'NO_EM_RESTART': '1', 11:00:49 INFO - 'PAGER': '/bin/cat', 11:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:49 INFO - 'PWD': '/builds/slave/test', 11:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:49 INFO - 'SHELL': '/bin/bash', 11:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:49 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:49 INFO - 'USER': 'cltbld', 11:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:49 INFO - 'XPC_FLAGS': '0x0', 11:00:49 INFO - 'XPC_SERVICE_NAME': '0', 11:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Nwgxf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-cciFsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-JH1I63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-oHlHZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-5h3gvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-UtwQjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-959G4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-64Rte6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-UcRCBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-kkevDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-fGvpfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-cyLPlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-GrbTH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-pojg4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-OWIUqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ogXyre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:51 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-doipnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:51 INFO - Running setup.py install for manifestparser 11:00:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:00:52 INFO - Running setup.py install for mozcrash 11:00:52 INFO - Running setup.py install for mozdebug 11:00:52 INFO - Running setup.py install for mozdevice 11:00:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:00:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:00:52 INFO - Running setup.py install for mozfile 11:00:52 INFO - Running setup.py install for mozhttpd 11:00:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:00:52 INFO - Running setup.py install for mozinfo 11:00:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:00:52 INFO - Running setup.py install for mozInstall 11:00:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Running setup.py install for mozleak 11:00:53 INFO - Running setup.py install for mozlog 11:00:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Running setup.py install for moznetwork 11:00:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Running setup.py install for mozprocess 11:00:53 INFO - Running setup.py install for mozprofile 11:00:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:00:53 INFO - Running setup.py install for mozrunner 11:00:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:00:54 INFO - Running setup.py install for mozscreenshot 11:00:54 INFO - Running setup.py install for moztest 11:00:54 INFO - Running setup.py install for mozversion 11:00:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:00:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:54 INFO - Cleaning up... 11:00:54 INFO - Return code: 0 11:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:54 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:00:54 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 11:00:54 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 11:00:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:00:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:54 INFO - 'HOME': '/Users/cltbld', 11:00:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:54 INFO - 'LOGNAME': 'cltbld', 11:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:54 INFO - 'MOZ_NO_REMOTE': '1', 11:00:54 INFO - 'NO_EM_RESTART': '1', 11:00:54 INFO - 'PAGER': '/bin/cat', 11:00:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:54 INFO - 'PWD': '/builds/slave/test', 11:00:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:54 INFO - 'SHELL': '/bin/bash', 11:00:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:00:54 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:00:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:54 INFO - 'USER': 'cltbld', 11:00:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:54 INFO - 'XPC_FLAGS': '0x0', 11:00:54 INFO - 'XPC_SERVICE_NAME': '0', 11:00:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ibSO_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-22m59g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-djxLIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-JPkSy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-8hgt6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-TkHLEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-N4ZAka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-YNS0uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-5Tcew8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-8o0Fe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-i1b7ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:55 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)) 11:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Fh1U8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:56 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-gortBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:56 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-lBKSxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:56 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ofkLHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:56 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Buio5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:56 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7Ib_eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:56 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)) 11:00:56 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)) 11:00:56 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)) 11:00:56 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)) 11:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:56 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 11:00:56 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 11:00:56 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 11:00:56 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 11:00:56 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 11:00:56 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 11:00:59 INFO - Downloading blessings-1.6.tar.gz 11:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:59 INFO - Installing collected packages: blessings 11:00:59 INFO - Running setup.py install for blessings 11:00:59 INFO - Successfully installed blessings 11:00:59 INFO - Cleaning up... 11:00:59 INFO - Return code: 0 11:00:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:59 INFO - Reading from file tmpfile_stdout 11:00:59 INFO - Current package versions: 11:00:59 INFO - blessings == 1.6 11:00:59 INFO - blobuploader == 1.2.4 11:00:59 INFO - docopt == 0.6.1 11:00:59 INFO - functools32 == 3.2.3-2 11:00:59 INFO - jsonschema == 2.5.1 11:00:59 INFO - manifestparser == 1.1 11:00:59 INFO - mozInstall == 1.12 11:00:59 INFO - mozcrash == 1.0 11:00:59 INFO - mozdebug == 0.1 11:00:59 INFO - mozdevice == 0.48 11:00:59 INFO - mozfile == 1.2 11:00:59 INFO - mozhttpd == 0.7 11:00:59 INFO - mozinfo == 0.9 11:00:59 INFO - mozleak == 0.1 11:00:59 INFO - mozlog == 3.4 11:00:59 INFO - moznetwork == 0.27 11:00:59 INFO - mozprocess == 0.23 11:00:59 INFO - mozprofile == 0.28 11:00:59 INFO - mozrunner == 6.13 11:00:59 INFO - mozscreenshot == 0.1 11:00:59 INFO - mozsystemmonitor == 0.3 11:00:59 INFO - moztest == 0.7 11:00:59 INFO - mozversion == 1.4 11:00:59 INFO - psutil == 3.1.1 11:00:59 INFO - requests == 1.2.3 11:00:59 INFO - wsgiref == 0.1.2 11:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 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')]} 11:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:01:00 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 11:01:00 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 11:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:00 INFO - 'HOME': '/Users/cltbld', 11:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:00 INFO - 'LOGNAME': 'cltbld', 11:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:00 INFO - 'MOZ_NO_REMOTE': '1', 11:01:00 INFO - 'NO_EM_RESTART': '1', 11:01:00 INFO - 'PAGER': '/bin/cat', 11:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:00 INFO - 'PWD': '/builds/slave/test', 11:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:00 INFO - 'SHELL': '/bin/bash', 11:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:01:00 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:00 INFO - 'USER': 'cltbld', 11:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:00 INFO - 'XPC_FLAGS': '0x0', 11:01:00 INFO - 'XPC_SERVICE_NAME': '0', 11:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 INFO - Cleaning up... 11:01:00 INFO - Return code: 0 11:01:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:01:00 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')]} 11:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 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')]} 11:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:01 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 0x10823a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733ca3e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, '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.t61O9livnz/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.LRMPgFuNux/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 11:01:01 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 11:01:01 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 11:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:01 INFO - 'HOME': '/Users/cltbld', 11:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:01 INFO - 'LOGNAME': 'cltbld', 11:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:01 INFO - 'MOZ_NO_REMOTE': '1', 11:01:01 INFO - 'NO_EM_RESTART': '1', 11:01:01 INFO - 'PAGER': '/bin/cat', 11:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:01 INFO - 'PWD': '/builds/slave/test', 11:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:01 INFO - 'SHELL': '/bin/bash', 11:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:01:01 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:01 INFO - 'USER': 'cltbld', 11:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:01 INFO - 'XPC_FLAGS': '0x0', 11:01:01 INFO - 'XPC_SERVICE_NAME': '0', 11:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:01:01 INFO - Cleaning up... 11:01:01 INFO - Return code: 0 11:01:01 INFO - Running post-action listener: _resource_record_post_action 11:01:01 INFO - Running post-action listener: _start_resource_monitoring 11:01:01 INFO - Starting resource monitoring. 11:01:01 INFO - [mozharness: 2016-11-14 19:01:01.408825Z] Finished create-virtualenv step (success) 11:01:01 INFO - [mozharness: 2016-11-14 19:01:01.409788Z] Running install step. 11:01:01 INFO - Running pre-action listener: _resource_record_pre_action 11:01:01 INFO - Running main action method: install 11:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:01 INFO - Reading from file tmpfile_stdout 11:01:01 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:01:01 INFO - Reading from file tmpfile_stdout 11:01:01 INFO - Output received: 11:01:01 INFO - Usage: mozinstall [options] installer 11:01:01 INFO - Options: 11:01:01 INFO - -h, --help show this help message and exit 11:01:01 INFO - -d DEST, --destination=DEST 11:01:01 INFO - Directory to install application into. [default: 11:01:01 INFO - "/builds/slave/test"] 11:01:01 INFO - --app=APP Application being installed. [default: firefox] 11:01:01 INFO - mkdir: /builds/slave/test/build/application 11:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:01:33 INFO - Reading from file tmpfile_stdout 11:01:33 INFO - Output received: 11:01:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:01:33 INFO - Running post-action listener: _resource_record_post_action 11:01:33 INFO - [mozharness: 2016-11-14 19:01:33.432505Z] Finished install step (success) 11:01:33 INFO - [mozharness: 2016-11-14 19:01:33.432675Z] Running run-tests step. 11:01:33 INFO - Running pre-action listener: _resource_record_pre_action 11:01:33 INFO - Running main action method: run_tests 11:01:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:01:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:01:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:01:33 INFO - 2016-11-14 11:01:33.446 screenresolution[1640:7687] starting screenresolution argv=screenresolution get 11:01:33 INFO - 2016-11-14 11:01:33.449 screenresolution[1640:7687] Display 0: 1600x1200x32@60 11:01:33 INFO - 2016-11-14 11:01:33.455 screenresolution[1641:7689] starting screenresolution argv=screenresolution list 11:01:33 INFO - Available Modes on Display 0 11:01:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:01:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:01:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:01:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:01:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:01:33 INFO - Intel Iris: 11:01:33 INFO - Chipset Model: Intel Iris 11:01:33 INFO - Type: GPU 11:01:33 INFO - Bus: Built-In 11:01:33 INFO - VRAM (Dynamic, Max): 1536 MB 11:01:33 INFO - Vendor: Intel (0x8086) 11:01:33 INFO - Device ID: 0x0a2e 11:01:33 INFO - Revision ID: 0x0009 11:01:33 INFO - Displays: 11:01:33 INFO - Display: 11:01:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:01:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:01:33 INFO - Display Serial Number: 1600x1200 60 11:01:33 INFO - Main Display: Yes 11:01:33 INFO - Mirror: Off 11:01:33 INFO - Online: Yes 11:01:33 INFO - Rotation: Supported 11:01:33 INFO - Return code: 0 11:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:01:33 INFO - Python 2.7.3 11:01:33 INFO - Return code: 0 11:01:33 INFO - grabbing minidump binary from tooltool 11:01: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')]} 11:01:33 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 0x10804ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108046b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:01:33 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 11:01:33 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 11:01:33 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 11:01:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:33 INFO - Return code: 0 11:01:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:01:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:01:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:01:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:01:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--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 11:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --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 11:01:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t61O9livnz/Render', 11:01:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:33 INFO - 'HOME': '/Users/cltbld', 11:01:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:33 INFO - 'LOGNAME': 'cltbld', 11:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:33 INFO - 'MOZ_NO_REMOTE': '1', 11:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:01:33 INFO - 'NO_EM_RESTART': '1', 11:01:33 INFO - 'PAGER': '/bin/cat', 11:01:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:33 INFO - 'PWD': '/builds/slave/test', 11:01:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:01:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:33 INFO - 'SHELL': '/bin/bash', 11:01:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LRMPgFuNux/Listeners', 11:01:33 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 11:01:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:33 INFO - 'USER': 'cltbld', 11:01:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:33 INFO - 'XPC_FLAGS': '0x0', 11:01:33 INFO - 'XPC_SERVICE_NAME': '0', 11:01:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--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 11:01:34 INFO - mozversion application_buildid: 20161114081542 11:01:34 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:01:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:01:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:34 INFO - mozversion application_name: Firefox 11:01:34 INFO - mozversion application_remotingname: firefox-dev 11:01:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:01:34 INFO - mozversion application_vendor: Mozilla 11:01:34 INFO - mozversion application_version: 52.0a2 11:01:34 INFO - mozversion platform_buildid: 20161114081542 11:01:34 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:01:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:01:34 INFO - mozversion platform_version: 52.0a2 11:01:34 INFO - using testdate: 1479150094 11:01:34 INFO - actual date: 1479150094 11:01:34 INFO - starting webserver on 'localhost:49272' 11:01:34 INFO - SUITE-START | Running 2 tests 11:01:34 INFO - TEST-START | dromaeo_css 11:01:34 INFO - operating with platform_type : mac_ 11:01:34 INFO - Initialising browser for dromaeo_css test... 11:01:34 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpOPdPa9/profile http://localhost:49272/getInfo.html) 11:01:35 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:01:36 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 11:01:36 INFO - PROCESS | 1651 | colorDepth:24 11:01:36 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 11:01:36 INFO - PROCESS | 1651 | __metrics 11:01:36 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 11:01:37 INFO - TEST-INFO | 1651: exit 0 11:01:37 INFO - Browser initialized. 11:01:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:37 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpOPdPa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:49 INFO - PROCESS | 1654 | RSS: Main: 224432128 11:01:49 INFO - PROCESS | 1654 | 11:02:39 INFO - PROCESS | 1654 | 1479150159330 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:04:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 11:04:55 INFO - PROCESS | 1654 | RSS: Main: 236408832 11:04:55 INFO - PROCESS | 1654 | 11:07:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 11:07:57 INFO - PROCESS | 1654 | RSS: Main: 251834368 11:07:57 INFO - PROCESS | 1654 | 11:10:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 11:11:00 INFO - PROCESS | 1654 | RSS: Main: 255356928 11:11:00 INFO - PROCESS | 1654 | 11:14:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 11:14:03 INFO - PROCESS | 1654 | RSS: Main: 255045632 11:14:03 INFO - PROCESS | 1654 | 11:17:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 11:17:06 INFO - PROCESS | 1654 | RSS: Main: 258621440 11:17:06 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 11:20:09 INFO - PROCESS | 1654 | RSS: Main: 260583424 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | __start_tp_report 11:20:09 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 11:20:09 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 11:20:09 INFO - PROCESS | 1654 | |i|pagename|runs| 11:20:09 INFO - PROCESS | 1654 | |0;dojo.html;2835.305350189204;3391.3047825195836;3400.5239266502695;3407.5740532433447;3421.7433692473064;5682.516986056185;5777.855553611156;5809.854753631162;5816.098504731763;5841.4450627190345;5992.490638295739;6037.426444487777;6041.818745437633;6067.908981365283;6081.78713745019;4597.264437689971;5370.973145134279;5406.59450541209;5424.240606315119;5480.26016487773;5444.591655625824;5464.316960379952;5481.095619222843;5501.724913754317;5536.2249285100115;5338.412774594792;5345.064613692608;5481.616286859921;5491.588130890179;5492.395836457987;5399.730013499329;5400.297961265011;5425.321834770653;5449.536789372908;5473.781048758045;5333.813316533902;5409.675419474805;5457.890842183134;5483.972580137074;5495.862603434946;6008.699565021731;6052.727627256784;6077.058056001327;6081.331053584102;6100.328963813977;6149.7847575334645;6203.038529028008;6233.688315584202;6268.122462855204;6287.717052732638;6248.593841400339;6263.6241825490615;6263.841189379934;6354;6365.777197798101;6061.393860613947;6089.299730531001;6099.542534309856;6103.633781973007;6105.053716673922;6311.684415779193;6361.872762544724;6363.872722545523;6375.10748495211;6391.201099862517;5196.440438299776;6295.622262664255;6317.557770955989;6340.239171299474;6344.555881088279;6329.683515824282;6332.746690132343;6334.239891213084;6350.968245158745;6392.4886009119155;5793;5801.419858014165;6168.475679567197;6192.59748116371;6285.465735412449;6289.591176573508;6293.968530157412;6299.370062993664;6307.779227727007;6310.5267104967315;5057.115004874132;5088.974555127201;5105.15764898795;5110.565601923878;5114.28400023997;4478.708883922534;4484.529124441952;4514.119746649372;4530.524294949048;4576.542345765463;6080.2399700037495;6095.6952152392205;6099.146119543268;6144.416280453439;6148.401415631878;6276.263119112522;6291.7797877075;6333.145025421509;6338.556301058881;6353.078803573456;5098.005888851639;5270.604704647167;5953.196318497034;5956.76172953077;6151.477124444383;4780.880477988078;4786.880327991828;5520.227168196456;5558.138488534284;5558.610897237155;6407.199100112486;6491.058796474579;6535.3464653534265;6537.0521274413995;6542.24764152119;5533.253010843646;6366.681665916593;6371.5221358397375;6372.299047104908;6396.456301214449;5237.738113094406;5411.188321751769;6337.2395312562785;6565.015247712881;6575.4410875076155;6218.31598524171;6244.469220116341;6251.312355640966;6271.31015588294;6305.747770089329;5625.8593535161945;6198.275219325389;6250.937490625036;6311.810645680637;6317.842053948688;6232.034034724625;6285;6287.842803929755;6295.055741638791;6316.368363163647;6077.058056001327;6128.992047069418;6129.939558357133;6135.44703110649;6135.508280839814;6034.63792172471;6081.148639190428;6169.629822210682;6203.96898015507;6210.192674952227;6189.597676151036;6213.720382582705;6231.376862313914;6239.220097487814;6242.375762423721;5062.848114556569;6036.366181550874;6150.384961503813;6178.474829639531;6179.62922224668 11:20:09 INFO - PROCESS | 1654 | |1;ext.html;491.40785353648846;506.14461559963684;523.0271694647952;524.3707550938873;529.64249131836;32942.17644558887;40340.39489407658;40393.79803100981;40499.98750031247;40623.78128656145;42201;42610;42686.7865660672;42724;42814.57185428145;9326.393784404027;9510;9510.952445237765;9526.571304291288;9549.188318992894;9482.66810661627;9561.856572151388;9580.80838383232;9591.520423978807;9612.711618651452;9524.999875013127;9574.856377154349;9575.138237558618;9592.760180995461;9629.614815407374;9480.715578532621;9561.235101191887;9566.856497152548;9567;9590.280728945358;9361.251099911991;9404.38871473352;9439.669611563631;9440.197583205436;9462.243020558408;39747.602523974965;39921.20157596861;39999.8000010001;40031.79984100061;40130.19739605192;3288.19439237386;3297.7032067113837;3304.2895777407734;3345.2974875276223;3404.14896275931;30179.849100754574;30319;30344.241393965105;30940.226494337596;31191.688083119105;3028.258076771205;3138;3148.9685103148904;3211.855466504013;3250.9921924203336;384319;515083;521498;522261;522569.9999999962;62825.057624135676;63573.68213158905;63577.72844543083;63600.68199658972;63668;66635.33364666291;66999.66500167469;67119.32880671228;67162.99255511172;67211.32788672148;13902;16336.591585210228;16508.596769274507;16515.91742041306;16563.83436165623;10667.946660266649;10748.838767418494;12667.986561075091;12702.936485317514;12705.983521318272;15213.31540080699;18156.59573633722;19180.520486987938;19275.93982330985;19386.2245510178;6428.360768004129;6651.7671881484885;7462.104547454232;7760.555425041094;7804.492707973964;822.7284995951321;863.6415887406656;968.2205824311357;998.0618218874235;999.2905037423511;25402.491950160893;26901.654917254058;30270.243243919078;30417.391652166833;30633.69366306353;914.8947870994921;991.3345579426489;1031.6079889641887;1032.7986042721598;1046.5662043001137;15011.099334039993;15454.536363909101;15730.842691573167;15850.976628880951;15886.285117169524;517113;614893;615445.9227703833;615961;616938;57763.422365775805;58236;58362.12456813151;58442.4155758437;58498;1231.8829711177423;1280.7054377493043;1326.5091915991145;1368.2337890781193;1369.9383527741077;29523.261918452212;30104.397912042074;30161.944331948278;30275.76414318863;30428.391432171677;51634.74182629063;52325.738371309424;52445;52510.73744631252;52663.21005185002;485454;486278;487149;488070;573174;26785.33036674099;26972.865135674198;27119;27124.1862744118;27237.59143612887;46151.84620384517;46172;46641.36755213551;47682.52317476781;47849.28226076681;38968.220635586564;38987;39441.40837887491;39647.80176099101;40596.78209653715;35932.742354017486;36120.4581931266;38866.6113338863;39206.6079339203;40043.79978100091;37458.43812342762;38279;38469;38474.42288365621;38584.035399115244;32030.51954220642;33905.66094339025;34491;34821.477677834344;34854;25695.743042570084;25983.579703957934;26005.349866253495;26007.609885852107;26216.475670486863 11:20:09 INFO - PROCESS | 1654 | |2;jquery.html;323.73130301849466;375.30943064760834;381.9866304679336;388.84640566976066;407.03735665151925;17884;18179.545511362205;19116.33092841751;19449.611007779837;19694.409167724956;19329.710054349194;19676.508087297825;20012.799872001277;20081;20086.799132008677;5638.887222255553;5641.379448260688;5911.527077833763;5917.053271476565;5944.524438044946;5674;5824.446677565625;5826.417358264161;5828.883422331551;5835.18307436957;5683.687397193174;5749.482546570808;5785.595008349417;5787.681677507735;5803.448672376138;4882.6826256293225;5513.889722205554;5721.370649228582;5751.166080918243;5752.568557358173;4436.0906014267;4754.286856971447;4767.7616119194245;4995.775190116454;5056.721880296583;12886.097973141885;12975.351232438341;13021.218726876417;13218.73562528744;13225.470981160743;2282.600544904635;2308.9769102309097;2312.7224733031976;2537.555927712643;2899.420115976792;9522.523873806282;9651.613935442574;9866;10340.121089707383;10390.584376625002;1496.6108811708925;1773.973390399145;1786.4015554789162;1787.1064467766116;1810.6650269700017;115602;116802.24796627973;122212;124421;131351.34324328316;10527.368357898551;11087.279326843729;11502.309861408343;11667.124965627612;11784.88215117855;14544.709105817825;14591.270436478346;14749.336279867432;14750.778738318933;14765.409383624534;7560.470767046254;8035.477693949992;8368.623411946477;8472.44929079608;8482.406231563855;8315.708950186714;8333.210060995158;8348.874766878502;8474.703385381483;8498.575071246536;4502.707324023928;4552.226121559276;4585.72485650862;4606.378138951266;4682.133805245972;1676.8826182167375;1883.2655264446876;1931.874428162165;1932.1884808380514;1932.4202739178472;775.8409526047146;808.5714571277115;822.4736168851939;925.3892430995511;929.5120061967522;19630.705539416922;20623.58752824935;20866.47833804167;20941.267055653283;21054.894725526276;892.4466830565091;916.505087252876;928.8560273157672;955.4649396338073;981.9852702209473;10560.683179504627;11107.83338249927;11130.610428634958;11137.721556960978;11165.83251251232;487460;488104;492641;578895;585653;74980;80680;112848.43575782068;123864;126150;949.1505102932974;955.9235261179089;996.5166894056376;1002.5688953749811;1004.467632154959;18601.627967440305;18965.90517047406;19110.808891910903;19186.520336991685;19290.903545482743;55202.72398637981;56129.71935140298;56624;56910.430895690515;57525;66373;80476;84221;84530;84778.57610711906;6767.89848152288;8015.879761803461;8123.0658474276215;8208.46644968075;8245.505269683837;11627.186096973131;12533.93733031329;12616.053795965156;12624.242545447303;12814.359282036048;10787.892121078688;10825.729356766144;10876.836847447137;10953.780924381308;10999.945000274947;10640.946795265974;10711.196660250669;10898.964598363144;11036.337819730841;11181;9886;11146.832797507881;11148.108151348035;11262.986331230228;11646.94176529112;7986.800329991796;7997.680092796456;8201.26188643025;8390.07709152005;8391.244787969112;10416.739581510523;10858.945705271422;11042.613508527164;11129.443527823738;11135.10919126484 11:20:09 INFO - PROCESS | 1654 | |3;mootools.html;1204.572376806234;1299.805029245613;1344.7915573086173;1769.59299361147;1776.3960253513803;7609.6956121755065;7893.210678932104;8100.068492123408;8550.914490855082;8581.52801595912;6855.451563874891;7396.297351751575;8336.208060234283;8336.416450848443;8338.291245244147;2277.9886100569474;2319.3158018384534;2327.534493101378;2331.8834058297102;2348.7064116985375;1984.6130004649099;2328.53429314137;2347.6009078456705;2350.4006478348083;2369.360272726363;2270.126001489422;2279.452931296485;2295.5867943770113;2298.1496846166942;2313.028528018228;1975.3283883479614;2269.580127676377;2279.338991692407;2284.1662793080573;2291.8051965582945;2287.3709729824263;2291.0721157931066;2291.7708229177115;2298.092253559851;2310.8613483190893;8349.33205343571;8416.957915210445;8417.326613870875;8419.368547358912;8422.957885210595;5054.368203974504;5204.609654275944;5217.452167522393;5232.189010703347;5237.764300606482;3153.4796758534812;3302.398336806647;3522.700570451489;3525.0834782956617;3525.4359302511475;1023.4780262066325;1054.1777413617315;1067.2742535076145;1082.7888561730465;1084.7993121272589;10932.398718070503;10970.890291097066;10981.945090274578;11049.33703977764;11094.667159985212;4527.320901864681;4595.885102872388;4682.742449165328;4705.200115980291;4762.238041913277;8241.928549288674;8347.248747612744;9469.90530094704;9488.620455181854;9500.334976551714;5206.088934436459;5207.4011488678525;5215.713135777492;5218.712970786643;5221.817236396708;4267.189234045583;4336.588024137702;4736.313234580966;4786.042791441726;4788.353572267769;3317.883874064396;3321.9501707474406;3800.9809950950066;3817.9236415272094;3933.115049113984;1111.2776695148218;1286.2604002698486;1287.6137158852307;1295.591888555102;1300.7073408483016;761.219749756493;868.7480630617176;869.6695255802755;879.0374539878823;887.6183241206344;4636.721796692209;5569.303837020372;5572.024895643327;5903.787184899034;6045.697715114226;827.2513375395276;865.6191275838611;866.1381924984555;897.7800438892513;922.6171138977384;3715.758475699071;3786.072412259014;3802.1825307559006;3808.6953043756434;3830.540335159799;10005.49972501372;10372.27394082407;10395.896041039492;10409.9479502602;10434.269601127848;10346.948265258625;10347.896521034694;10375.740606484747;10381.480925953672;10382.480875956171;7682.231776822273;7857.1749966253865;7876.133625301212;8015.238552337519;8016.118226995026;5004.199328107486;5299.5760339172;5563.109902415594;5750.338711048115;5752.626079305;9283.72148835536;9407.388519746468;9496.24030077606;9515.476648784383;9533.47565883883;9148.908510914805;9375.203107735919;9514.85727714071;9598.616055357987;9640.035996400304;6632.436242919213;6826.180858297036;6988.965055174692;7020.508564400443;7130.251323611154;6512;6589;6936.687849046906;7683.9231607683205;7877.606119693878;7143.285671433023;7290.343869051599;7295.197528271779;7332.120145582564;7377.741779037708;6068.241469816273;7079.1858936223;7107.969344444923;7135.703929569791;7226.494145409771;5790.652560846363;6473.029045643003;6777.051212830109;6827.180738311435;6829.112215411965;4758.619310455086;4765.237561990065;4831.637627178046;4848.9757551212015;4854.441739200037;4694.507076756891;4782.282657601388;4793.952060479351;4959.97520012412;5021.949780502148 11:20:09 INFO - PROCESS | 1654 | |4;prototype.html;303.06202303869514;307.74918441470214;308.7823084725269;313.52031391970286;316.8890888189134;4757.9762101189535;5303.965726683298;5462.640476107195;5479.424660410659;5495.532879705225;4757.333973243749;5234.398044224915;5336.759845806938;5468.7539060742265;5502.779888804453;4217.536071032184;4232.174725928445;4241.745495270294;4250.596193361625;4257.212415703089;4016.2369149861433;4114.650254728352;4188.664906807463;4252.170826688797;4276.379924910886;3447.9827600862086;3642.4900513928073;4109.732867363627;4162.209180255757;4169.9791501042455;4130.938035929464;4138;4153.190127925056;4206.242876282268;4207.221663992141;3228.515722641599;3256.772025958184;3504.8598056077726;3677.8344974475945;3687.3915803892323;5198.9480105198845;5262;5307.522322990911;5363.410024897258;5373.408925018245;4739.573438390561;4739.715617062987;4777.426708794932;4813.350197723297;4817.542333478314;5415.323084614423;5498.945010549884;5746.367899531048;5836.519479221356;5856.853578660525;3224.6452890182063;3985.5488874342072;3989.3617021276746;3994.6205110514456;4003.499562554681;5238.60710446718;5808.390119037483;5956.289888100904;6071.241094863142;6200.87598248037;4081.775502347399;4086.4483294755423;4098.508179018478;4113.218488487178;4114.732542384735;3276.852541635632;3942.1222507569637;4053;4090.2637525245145;4091.133878484803;4043.4137050127565;4757.191277482836;4806.389859397141;4848.9757551212015;4859.319695242669;5835.854103647358;5868.354481007086;5900.350961394243;5904.937111320004;5920.644761314335;1246.3581255653346;1261.2810697902291;1301.3537874588653;1305.7519071376598;1311.7769979103575;887.6183241206214;888.7822483491586;901.3059943843335;903.4482421827346;923.5705396990431;4613.861584152481;4676.205045142334;4896.877578060506;5022.8949631081105;5212.50481204285;5164;5556.166355158898;5608.579356548275;5657.246253661296;5680.11958146488;4513.35262629138;4966.51004698589;5065.746712664352;5104.259882317043;5203.661761985459;2629.7238789927164;2639.828411153269;2942.867570959312;2963.4221326841057;2966.391889662614;5545.556355491551;5572.4148964358155;5643.604947653625;5857.56489660036;5877.4122587740885;4840.418090612991;5480.314960629921;5574.665520068727;5676.205331253628;5829.504492118217;4999.950020491581;5314.820923421456;5767.548791763567;5784.219130417424;5886.793962211302;5300.257963885137;5702.971485142713;5746.224259724883;5746.2529871116485;5782.930157920798;5445.495072266644;5478.342598888159;5484.451554844643;5532.446755324436;5601.523870470893;4727.770779597261;4750.904981900412;5170.794107653279;5805.3033635962265;5881.823545293648;3346.4311067119133;3398.898033059012;3757.4363845423404;3836.8105887175066;3854.2098869731076;5296.33165552865;5738;5876.471117599436;5954.345022047484;6035.728392222449;5677.630953987978;5722.366297401097;5788.334341550607;5854.824355269178;5870.5010074144175;4694.882627934329;5792.247007888947;5827.3881242470625;5830.4461076197695;5854.892238793946;5355.3305836770405;5545.667259964415;5559.583031272751;5571.860703482445;5745.482906538432;5541.251930989265;5796.058320462692;5846.707664616837;5908.615939963888;5916.7041647918295;4883.121038213156;5059.494050595058;5145.089340970996;5743.942560574508;5756.913646295226 11:20:09 INFO - PROCESS | 1654 | |5;yui.html;676.7293082766893;679.5514960126316;688.887446773461;717.5858150256315;784.9097353804315;13589.7961530577;13915.37380817863;13916.652083697913;14041.648958776022;14105.435782568698;13258.204507729519;13351.599452016431;13399.93300033501;14228.573142805732;14823.629409264773;647.9935200647992;671.03036112817;806.9878951815728;825.0800357601262;838.9412741108094;836.2515548584014;836.5817091454273;836.8744688296744;839;839.2740279658083;870.3994243971639;875.4090988582712;875.8905136857893;877.662100091463;880.1286726141107;854.5983387807752;854.7606670132373;860.6858496648741;867.1805144138791;870.595173244438;623.7442648514133;644.1561554363799;646.5764923974804;647.8866198415305;648.5265755998148;13630.318484075757;14286.785698214535;14308.92845535776;14517.128972261698;14535.70928581433;13365.86634133656;13387.263700496469;13486;13543.98420118495;13872.375743091585;11304.982551570398;11356.829647555292;11543.134264930164;11554.884451155465;11664.708382290426;3585.3904836177912;3626.220362622049;3637.854485820564;3656.469811877263;3661.4507823826375;85742;91345.54327228387;94103.52948235215;94536;95010.52494737551;10179;10257.538410771383;10368.844467332996;10467.84298235527;10576.629817956335;20230.291939782037;20240.190392384433;20314.593708125754;20610.690839637417;20671.17315307371;7361.889571656429;7497.887531687029;7577;7615.276548727862;7679.923200768033;4180.853670121592;4295.5060168080445;4329.675274354436;4369.279068953587;4386.320120381346;3459.6713312235297;3551.183227857607;3568.072301201706;3574.982125089358;3576.4277715565904;619.4084649160042;637.6747858592151;639.7217210513442;641.5637366590763;655.0828839624563;597.698162427971;598.5869749872573;627.0312367392389;644.9226092868886;645.1838424393146;8518.296340731878;8943.463392196489;8973.461592304351;9123.498207598646;9191.816163676824;513.8432778002744;537.4383768961445;547.4279378049947;553.3028384235811;610.6854969690613;4322.054092696279;4338.175746608134;4576.610988065985;4589.839355622537;4637.652176086807;84437.57781211054;106756;110296.79406411826;110408.47957602248;114338.42830785793;73102.17244568928;86110;91604.54197728969;93960.06039939514;97456;64229;79108;80904.59547702341;81995.18004819876;83951.74072388919;7362.77911662651;8534.871976920227;8774.912250877409;8816.206541411304;8903.510306933182;53069.469305306455;57910.7104464475;57948;58374.29261542636;60031.39968600258;79536.4092718154;79593.60203198947;80184;82760;83651;8792;9781.875084365389;11047.447627618747;11327.943360283476;11387.202895797214;12167.187267588733;12253.835885590855;12263;12290.631281061582;12536.247825130522;11843.1709780318;11922.344271065174;11928.821067684165;11995.64013079609;12319.322437266037;11753.236039657395;11899.940500297444;11991.280523168638;11995.520179192734;12149.212698066194;11562.364069976233;11749.647510574696;11797.35114568707;11840.526378944745;11917.463714133059;10205.336653117523;10213.438260895426;10269.537870795682;10500.369977801356;10516.000979906896;9602.279829012712;10074.44590547527;10104.242181836538;10109.03964123407;10109.545070471993 11:20:09 INFO - PROCESS | 1654 | __end_tp_report 11:20:09 INFO - PROCESS | 1654 | __start_cc_report 11:20:09 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,376 11:20:09 INFO - PROCESS | 1654 | __end_cc_report 11:20:09 INFO - PROCESS | 1654 | __startTimestamp1479151209413__endTimestamp 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | ------- Summary: start ------- 11:20:09 INFO - PROCESS | 1654 | Number of tests: 6 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5842.23 Median:6103.63 stddev:669.13 (11.0%) stddev-sans-first:628.23 11:20:09 INFO - PROCESS | 1654 | Values: 2835.3 3391.3 3400.5 3407.6 3421.7 5682.5 5777.9 5809.9 5816.1 5841.4 5992.5 6037.4 6041.8 6067.9 6081.8 4597.3 5371.0 5406.6 5424.2 5480.3 5444.6 5464.3 5481.1 5501.7 5536.2 5338.4 5345.1 5481.6 5491.6 5492.4 5399.7 5400.3 5425.3 5449.5 5473.8 5333.8 5409.7 5457.9 5484.0 5495.9 6008.7 6052.7 6077.1 6081.3 6100.3 6149.8 6203.0 6233.7 6268.1 6287.7 6248.6 6263.6 6263.8 6354.0 6365.8 6061.4 6089.3 6099.5 6103.6 6105.1 6311.7 6361.9 6363.9 6375.1 6391.2 5196.4 6295.6 6317.6 6340.2 6344.6 6329.7 6332.7 6334.2 6351.0 6392.5 5793.0 5801.4 6168.5 6192.6 6285.5 6289.6 6294.0 6299.4 6307.8 6310.5 5057.1 5089.0 5105.2 5110.6 5114.3 4478.7 4484.5 4514.1 4530.5 4576.5 6080.2 6095.7 6099.1 6144.4 6148.4 6276.3 6291.8 6333.1 6338.6 6353.1 5098.0 5270.6 5953.2 5956.8 6151.5 4780.9 4786.9 5520.2 5558.1 5558.6 6407.2 6491.1 6535.3 6537.1 6542.2 5533.3 6366.7 6371.5 6372.3 6396.5 5237.7 5411.2 6337.2 6565.0 6575.4 6218.3 6244.5 6251.3 6271.3 6305.7 5625.9 6198.3 6250.9 6311.8 6317.8 6232.0 6285.0 6287.8 6295.1 6316.4 6077.1 6129.0 6129.9 6135.4 6135.5 6034.6 6081.1 6169.6 6204.0 6210.2 6189.6 6213.7 6231.4 6239.2 6242.4 5062.8 6036.4 6150.4 6178.5 6179.6 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:67271.58 Median:40446.89 stddev:142635.88 (352.6%) stddev-sans-first:142947.89 11:20:09 INFO - PROCESS | 1654 | Values: 491.4 506.1 523.0 524.4 529.6 32942.2 40340.4 40393.8 40500.0 40623.8 42201.0 42610.0 42686.8 42724.0 42814.6 9326.4 9510.0 9511.0 9526.6 9549.2 9482.7 9561.9 9580.8 9591.5 9612.7 9525.0 9574.9 9575.1 9592.8 9629.6 9480.7 9561.2 9566.9 9567.0 9590.3 9361.3 9404.4 9439.7 9440.2 9462.2 39747.6 39921.2 39999.8 40031.8 40130.2 3288.2 3297.7 3304.3 3345.3 3404.1 30179.8 30319.0 30344.2 30940.2 31191.7 3028.3 3138.0 3149.0 3211.9 3251.0 384319.0 515083.0 521498.0 522261.0 522570.0 62825.1 63573.7 63577.7 63600.7 63668.0 66635.3 66999.7 67119.3 67163.0 67211.3 13902.0 16336.6 16508.6 16515.9 16563.8 10667.9 10748.8 12668.0 12702.9 12706.0 15213.3 18156.6 19180.5 19275.9 19386.2 6428.4 6651.8 7462.1 7760.6 7804.5 822.7 863.6 968.2 998.1 999.3 25402.5 26901.7 30270.2 30417.4 30633.7 914.9 991.3 1031.6 1032.8 1046.6 15011.1 15454.5 15730.8 15851.0 15886.3 517113.0 614893.0 615445.9 615961.0 616938.0 57763.4 58236.0 58362.1 58442.4 58498.0 1231.9 1280.7 1326.5 1368.2 1369.9 29523.3 30104.4 30161.9 30275.8 30428.4 51634.7 52325.7 52445.0 52510.7 52663.2 485454.0 486278.0 487149.0 488070.0 573174.0 26785.3 26972.9 27119.0 27124.2 27237.6 46151.8 46172.0 46641.4 47682.5 47849.3 38968.2 38987.0 39441.4 39647.8 40596.8 35932.7 36120.5 38866.6 39206.6 40043.8 37458.4 38279.0 38469.0 38474.4 38584.0 32030.5 33905.7 34491.0 34821.5 34854.0 25695.7 25983.6 26005.3 26007.6 26216.5 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:32154.99 Median:1611.58 stddev:88640.74 (5500.3%) stddev-sans-first:88857.18 11:20:09 INFO - PROCESS | 1654 | Values: 323.7 375.3 382.0 388.8 407.0 17884.0 18179.5 19116.3 19449.6 19694.4 19329.7 19676.5 20012.8 20081.0 20086.8 5638.9 5641.4 5911.5 5917.1 5944.5 5674.0 5824.4 5826.4 5828.9 5835.2 5683.7 5749.5 5785.6 5787.7 5803.4 4882.7 5513.9 5721.4 5751.2 5752.6 4436.1 4754.3 4767.8 4995.8 5056.7 12886.1 12975.4 13021.2 13218.7 13225.5 2282.6 2309.0 2312.7 2537.6 2899.4 9522.5 9651.6 9866.0 10340.1 10390.6 1496.6 1774.0 1786.4 1787.1 1810.7 115602.0 116802.2 122212.0 124421.0 131351.3 10527.4 11087.3 11502.3 11667.1 11784.9 14544.7 14591.3 14749.3 14750.8 14765.4 7560.5 8035.5 8368.6 8472.4 8482.4 8315.7 8333.2 8348.9 8474.7 8498.6 4502.7 4552.2 4585.7 4606.4 4682.1 1676.9 1883.3 1931.9 1932.2 1932.4 775.8 808.6 822.5 925.4 929.5 19630.7 20623.6 20866.5 20941.3 21054.9 892.4 916.5 928.9 955.5 982.0 10560.7 11107.8 11130.6 11137.7 11165.8 487460.0 488104.0 492641.0 578895.0 585653.0 74980.0 80680.0 112848.4 123864.0 126150.0 949.2 955.9 996.5 1002.6 1004.5 18601.6 18965.9 19110.8 19186.5 19290.9 55202.7 56129.7 56624.0 56910.4 57525.0 66373.0 80476.0 84221.0 84530.0 84778.6 6767.9 8015.9 8123.1 8208.5 8245.5 11627.2 12533.9 12616.1 12624.2 12814.4 10787.9 10825.7 10876.8 10953.8 10999.9 10640.9 10711.2 10899.0 11036.3 11181.0 9886.0 11146.8 11148.1 11263.0 11646.9 7986.8 7997.7 8201.3 8390.1 8391.2 10416.7 10858.9 11042.6 11129.4 11135.1 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5410.55 Median:5013.07 stddev:3001.32 (59.9%) stddev-sans-first:2993.09 11:20:09 INFO - PROCESS | 1654 | Values: 1204.6 1299.8 1344.8 1769.6 1776.4 7609.7 7893.2 8100.1 8550.9 8581.5 6855.5 7396.3 8336.2 8336.4 8338.3 2278.0 2319.3 2327.5 2331.9 2348.7 1984.6 2328.5 2347.6 2350.4 2369.4 2270.1 2279.5 2295.6 2298.1 2313.0 1975.3 2269.6 2279.3 2284.2 2291.8 2287.4 2291.1 2291.8 2298.1 2310.9 8349.3 8417.0 8417.3 8419.4 8423.0 5054.4 5204.6 5217.5 5232.2 5237.8 3153.5 3302.4 3522.7 3525.1 3525.4 1023.5 1054.2 1067.3 1082.8 1084.8 10932.4 10970.9 10981.9 11049.3 11094.7 4527.3 4595.9 4682.7 4705.2 4762.2 8241.9 8347.2 9469.9 9488.6 9500.3 5206.1 5207.4 5215.7 5218.7 5221.8 4267.2 4336.6 4736.3 4786.0 4788.4 3317.9 3322.0 3801.0 3817.9 3933.1 1111.3 1286.3 1287.6 1295.6 1300.7 761.2 868.7 869.7 879.0 887.6 4636.7 5569.3 5572.0 5903.8 6045.7 827.3 865.6 866.1 897.8 922.6 3715.8 3786.1 3802.2 3808.7 3830.5 10005.5 10372.3 10395.9 10409.9 10434.3 10346.9 10347.9 10375.7 10381.5 10382.5 7682.2 7857.2 7876.1 8015.2 8016.1 5004.2 5299.6 5563.1 5750.3 5752.6 9283.7 9407.4 9496.2 9515.5 9533.5 9148.9 9375.2 9514.9 9598.6 9640.0 6632.4 6826.2 6989.0 7020.5 7130.3 6512.0 6589.0 6936.7 7683.9 7877.6 7143.3 7290.3 7295.2 7332.1 7377.7 6068.2 7079.2 7108.0 7135.7 7226.5 5790.7 6473.0 6777.1 6827.2 6829.1 4758.6 4765.2 4831.6 4849.0 4854.4 4694.5 4782.3 4794.0 4960.0 5021.9 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4606.90 Median:5201.30 stddev:1413.27 (27.2%) stddev-sans-first:1379.82 11:20:09 INFO - PROCESS | 1654 | Values: 303.1 307.7 308.8 313.5 316.9 4758.0 5304.0 5462.6 5479.4 5495.5 4757.3 5234.4 5336.8 5468.8 5502.8 4217.5 4232.2 4241.7 4250.6 4257.2 4016.2 4114.7 4188.7 4252.2 4276.4 3448.0 3642.5 4109.7 4162.2 4170.0 4130.9 4138.0 4153.2 4206.2 4207.2 3228.5 3256.8 3504.9 3677.8 3687.4 5198.9 5262.0 5307.5 5363.4 5373.4 4739.6 4739.7 4777.4 4813.4 4817.5 5415.3 5498.9 5746.4 5836.5 5856.9 3224.6 3985.5 3989.4 3994.6 4003.5 5238.6 5808.4 5956.3 6071.2 6200.9 4081.8 4086.4 4098.5 4113.2 4114.7 3276.9 3942.1 4053.0 4090.3 4091.1 4043.4 4757.2 4806.4 4849.0 4859.3 5835.9 5868.4 5900.4 5904.9 5920.6 1246.4 1261.3 1301.4 1305.8 1311.8 887.6 888.8 901.3 903.4 923.6 4613.9 4676.2 4896.9 5022.9 5212.5 5164.0 5556.2 5608.6 5657.2 5680.1 4513.4 4966.5 5065.7 5104.3 5203.7 2629.7 2639.8 2942.9 2963.4 2966.4 5545.6 5572.4 5643.6 5857.6 5877.4 4840.4 5480.3 5574.7 5676.2 5829.5 5000.0 5314.8 5767.5 5784.2 5886.8 5300.3 5703.0 5746.2 5746.3 5782.9 5445.5 5478.3 5484.5 5532.4 5601.5 4727.8 4750.9 5170.8 5805.3 5881.8 3346.4 3398.9 3757.4 3836.8 3854.2 5296.3 5738.0 5876.5 5954.3 6035.7 5677.6 5722.4 5788.3 5854.8 5870.5 4694.9 5792.2 5827.4 5830.4 5854.9 5355.3 5545.7 5559.6 5571.9 5745.5 5541.3 5796.1 5846.7 5908.6 5916.7 4883.1 5059.5 5145.1 5743.9 5756.9 11:20:09 INFO - PROCESS | 1654 | 11:20:09 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:20182.62 Median:2575.75 stddev:29691.81 (1152.7%) stddev-sans-first:29738.98 11:20:09 INFO - PROCESS | 1654 | Values: 676.7 679.6 688.9 717.6 784.9 13589.8 13915.4 13916.7 14041.6 14105.4 13258.2 13351.6 13399.9 14228.6 14823.6 648.0 671.0 807.0 825.1 838.9 836.3 836.6 836.9 839.0 839.3 870.4 875.4 875.9 877.7 880.1 854.6 854.8 860.7 867.2 870.6 623.7 644.2 646.6 647.9 648.5 13630.3 14286.8 14308.9 14517.1 14535.7 13365.9 13387.3 13486.0 13544.0 13872.4 11305.0 11356.8 11543.1 11554.9 11664.7 3585.4 3626.2 3637.9 3656.5 3661.5 85742.0 91345.5 94103.5 94536.0 95010.5 10179.0 10257.5 10368.8 10467.8 10576.6 20230.3 20240.2 20314.6 20610.7 20671.2 7361.9 7497.9 7577.0 7615.3 7679.9 4180.9 4295.5 4329.7 4369.3 4386.3 3459.7 3551.2 3568.1 3575.0 3576.4 619.4 637.7 639.7 641.6 655.1 597.7 598.6 627.0 644.9 645.2 8518.3 8943.5 8973.5 9123.5 9191.8 513.8 537.4 547.4 553.3 610.7 4322.1 4338.2 4576.6 4589.8 4637.7 84437.6 106756.0 110296.8 110408.5 114338.4 73102.2 86110.0 91604.5 93960.1 97456.0 64229.0 79108.0 80904.6 81995.2 83951.7 7362.8 8534.9 8774.9 8816.2 8903.5 53069.5 57910.7 57948.0 58374.3 60031.4 79536.4 79593.6 80184.0 82760.0 83651.0 8792.0 9781.9 11047.4 11327.9 11387.2 12167.2 12253.8 12263.0 12290.6 12536.2 11843.2 11922.3 11928.8 11995.6 12319.3 11753.2 11899.9 11991.3 11995.5 12149.2 11562.4 11749.6 11797.4 11840.5 11917.5 10205.3 10213.4 10269.5 10500.4 10516.0 9602.3 10074.4 10104.2 10109.0 10109.5 11:20:09 INFO - PROCESS | 1654 | -------- Summary: end -------- 11:20:09 INFO - PROCESS | 1654 | 11:20:10 INFO - TEST-INFO | 1654: exit 0 11:20:10 INFO - TEST-OK | dromaeo_css | took 1116141ms 11:20:10 INFO - TEST-START | kraken 11:20:10 INFO - operating with platform_type : mac_ 11:20:10 INFO - Initialising browser for kraken test... 11:20:10 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmp1bcFk1/profile http://localhost:49272/getInfo.html) 11:20:11 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:20:12 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 11:20:12 INFO - PROCESS | 1664 | colorDepth:24 11:20:12 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 11:20:12 INFO - PROCESS | 1664 | __metrics 11:20:12 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 11:20:13 INFO - TEST-INFO | 1664: exit 0 11:20:13 INFO - Browser initialized. 11:20:13 INFO - Running cycle 1/1 for kraken test... 11:20:13 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmp1bcFk1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:25 INFO - PROCESS | 1666 | RSS: Main: 224456704 11:20:25 INFO - PROCESS | 1666 | 11:20:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:29 INFO - PROCESS | 1666 | RSS: Main: 236576768 11:20:29 INFO - PROCESS | 1666 | 11:20:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 11:20:32 INFO - PROCESS | 1666 | RSS: Main: 244228096 11:20:32 INFO - PROCESS | 1666 | 11:20:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 11:20:36 INFO - PROCESS | 1666 | RSS: Main: 247779328 11:20:36 INFO - PROCESS | 1666 | 11:20:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 11:20:39 INFO - PROCESS | 1666 | RSS: Main: 249274368 11:20:39 INFO - PROCESS | 1666 | 11:20:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:41 INFO - PROCESS | 1666 | RSS: Main: 249475072 11:20:41 INFO - PROCESS | 1666 | 11:20:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:45 INFO - PROCESS | 1666 | RSS: Main: 253505536 11:20:45 INFO - PROCESS | 1666 | 11:20:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:49 INFO - PROCESS | 1666 | RSS: Main: 253579264 11:20:49 INFO - PROCESS | 1666 | 11:20:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 11:20:52 INFO - PROCESS | 1666 | RSS: Main: 252858368 11:20:52 INFO - PROCESS | 1666 | 11:20:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:54 INFO - PROCESS | 1666 | RSS: Main: 251863040 11:20:54 INFO - PROCESS | 1666 | 11:20:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:57 INFO - PROCESS | 1666 | RSS: Main: 252002304 11:20:57 INFO - PROCESS | 1666 | 11:20:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:00 INFO - PROCESS | 1666 | RSS: Main: 251973632 11:21:00 INFO - PROCESS | 1666 | 11:21:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:04 INFO - PROCESS | 1666 | RSS: Main: 252592128 11:21:04 INFO - PROCESS | 1666 | 11:21:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:07 INFO - PROCESS | 1666 | RSS: Main: 252952576 11:21:07 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 11:21:09 INFO - PROCESS | 1666 | RSS: Main: 254189568 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | __start_tp_report 11:21:09 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 11:21:09 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 11:21:09 INFO - PROCESS | 1666 | |i|pagename|runs| 11:21:09 INFO - PROCESS | 1666 | |0;ai-astar;105;120;120;168;173;140;121;120;121;119 11:21:09 INFO - PROCESS | 1666 | |1;audio-beat-detection;147;113;122;153;112;116;119;120;182;116 11:21:09 INFO - PROCESS | 1666 | |2;audio-dft;193;227;244;194;208;244;194;195;193;196 11:21:09 INFO - PROCESS | 1666 | |3;audio-fft;82;58;58;86;63;61;58;59;80;59 11:21:09 INFO - PROCESS | 1666 | |4;audio-oscillator;88;71;91;72;72;71;87;70;72;89 11:21:09 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;87;89;103;135;105;90;99;88;109 11:21:09 INFO - PROCESS | 1666 | |6;imaging-darkroom;91;115;151;153;102;94;93;97;95;105 11:21:09 INFO - PROCESS | 1666 | |7;imaging-desaturate;89;92;85;87;91;88;138;144;110;90 11:21:09 INFO - PROCESS | 1666 | |8;json-parse-financial;56;55;53;56;63;86;56;65;73;91 11:21:09 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;68;74;70;73;76;68;70;72;71;73 11:21:09 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;85;87;80;107;105;107;73;71;99;99 11:21:09 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;158;154;151;157;159;148;149;170;271;184 11:21:09 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;165;221;170;168;162;166;162;216;230;168 11:21:09 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;70;68;65;82;90;61;76;89;91;87 11:21:09 INFO - PROCESS | 1666 | __end_tp_report 11:21:09 INFO - PROCESS | 1666 | __start_cc_report 11:21:09 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,975 11:21:09 INFO - PROCESS | 1666 | __end_cc_report 11:21:09 INFO - PROCESS | 1666 | __startTimestamp1479151269859__endTimestamp 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | ------- Summary: start ------- 11:21:09 INFO - PROCESS | 1666 | Number of tests: 14 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:130.70 Median:121.00 stddev:22.60 (18.7%) stddev-sans-first:21.97 11:21:09 INFO - PROCESS | 1666 | Values: 105.0 120.0 120.0 168.0 173.0 140.0 121.0 120.0 121.0 119.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:121.00 stddev:23.12 (19.1%) stddev-sans-first:23.69 11:21:09 INFO - PROCESS | 1666 | Values: 147.0 113.0 122.0 153.0 112.0 116.0 119.0 120.0 182.0 116.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:208.80 Median:202.00 stddev:21.35 (10.6%) stddev-sans-first:21.86 11:21:09 INFO - PROCESS | 1666 | Values: 193.0 227.0 244.0 194.0 208.0 244.0 194.0 195.0 193.0 196.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.40 Median:62.00 stddev:11.42 (18.4%) stddev-sans-first:10.63 11:21:09 INFO - PROCESS | 1666 | Values: 82.0 58.0 58.0 86.0 63.0 61.0 58.0 59.0 80.0 59.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:79.50 stddev:9.07 (11.4%) stddev-sans-first:8.91 11:21:09 INFO - PROCESS | 1666 | Values: 88.0 71.0 91.0 72.0 72.0 71.0 87.0 70.0 72.0 89.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:88.50 stddev:14.88 (16.8%) stddev-sans-first:15.30 11:21:09 INFO - PROCESS | 1666 | Values: 89.0 87.0 89.0 103.0 135.0 105.0 90.0 99.0 88.0 109.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:92.00 stddev:23.43 (25.5%) stddev-sans-first:23.87 11:21:09 INFO - PROCESS | 1666 | Values: 91.0 115.0 151.0 153.0 102.0 94.0 93.0 97.0 95.0 105.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:101.40 Median:88.50 stddev:22.02 (24.9%) stddev-sans-first:22.90 11:21:09 INFO - PROCESS | 1666 | Values: 89.0 92.0 85.0 87.0 91.0 88.0 138.0 144.0 110.0 90.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.00 stddev:13.62 (21.3%) stddev-sans-first:14.02 11:21:09 INFO - PROCESS | 1666 | Values: 56.0 55.0 53.0 56.0 63.0 86.0 56.0 65.0 73.0 91.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:2.59 (3.6%) stddev-sans-first:2.42 11:21:09 INFO - PROCESS | 1666 | Values: 68.0 74.0 70.0 73.0 76.0 68.0 70.0 72.0 71.0 73.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:82.50 stddev:13.87 (16.8%) stddev-sans-first:14.53 11:21:09 INFO - PROCESS | 1666 | Values: 85.0 87.0 80.0 107.0 105.0 107.0 73.0 71.0 99.0 99.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:170.10 Median:158.50 stddev:37.08 (23.4%) stddev-sans-first:39.07 11:21:09 INFO - PROCESS | 1666 | Values: 158.0 154.0 151.0 157.0 159.0 148.0 149.0 170.0 271.0 184.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:169.00 stddev:27.60 (16.3%) stddev-sans-first:28.51 11:21:09 INFO - PROCESS | 1666 | Values: 165.0 221.0 170.0 168.0 162.0 166.0 162.0 216.0 230.0 168.0 11:21:09 INFO - PROCESS | 1666 | 11:21:09 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:84.50 stddev:11.34 (13.4%) stddev-sans-first:11.66 11:21:09 INFO - PROCESS | 1666 | Values: 70.0 68.0 65.0 82.0 90.0 61.0 76.0 89.0 91.0 87.0 11:21:09 INFO - PROCESS | 1666 | -------- Summary: end -------- 11:21:09 INFO - PROCESS | 1666 | 11:21:10 INFO - TEST-INFO | 1666: exit 0 11:21:10 INFO - TEST-OK | kraken | took 60609ms 11:21:10 INFO - SUITE-END | took 1176s 11:21:11 INFO - Completed test suite (00:19:36) 11:21:11 INFO - javascript benchmark 11:21:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7166.767001510866, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2835.305350189204, 3391.3047825195836, 3400.5239266502695, 3407.5740532433447, 3421.7433692473064, 5682.516986056185, 5777.855553611156, 5809.854753631162, 5816.098504731763, 5841.4450627190345, 5992.490638295739, 6037.426444487777, 6041.818745437633, 6067.908981365283, 6081.78713745019, 4597.264437689971, 5370.973145134279, 5406.59450541209, 5424.240606315119, 5480.26016487773, 5444.591655625824, 5464.316960379952, 5481.095619222843, 5501.724913754317, 5536.2249285100115, 5338.412774594792, 5345.064613692608, 5481.616286859921, 5491.588130890179, 5492.395836457987, 5399.730013499329, 5400.297961265011, 5425.321834770653, 5449.536789372908, 5473.781048758045, 5333.813316533902, 5409.675419474805, 5457.890842183134, 5483.972580137074, 5495.862603434946, 6008.699565021731, 6052.727627256784, 6077.058056001327, 6081.331053584102, 6100.328963813977, 6149.7847575334645, 6203.038529028008, 6233.688315584202, 6268.122462855204, 6287.717052732638, 6248.593841400339, 6263.6241825490615, 6263.841189379934, 6354.0, 6365.777197798101, 6061.393860613947, 6089.299730531001, 6099.542534309856, 6103.633781973007, 6105.053716673922, 6311.684415779193, 6361.872762544724, 6363.872722545523, 6375.10748495211, 6391.201099862517, 5196.440438299776, 6295.622262664255, 6317.557770955989, 6340.239171299474, 6344.555881088279, 6329.683515824282, 6332.746690132343, 6334.239891213084, 6350.968245158745, 6392.4886009119155, 5793.0, 5801.419858014165, 6168.475679567197, 6192.59748116371, 6285.465735412449, 6289.591176573508, 6293.968530157412, 6299.370062993664, 6307.779227727007, 6310.5267104967315, 5057.115004874132, 5088.974555127201, 5105.15764898795, 5110.565601923878, 5114.28400023997, 4478.708883922534, 4484.529124441952, 4514.119746649372, 4530.524294949048, 4576.542345765463, 6080.2399700037495, 6095.6952152392205, 6099.146119543268, 6144.416280453439, 6148.401415631878, 6276.263119112522, 6291.7797877075, 6333.145025421509, 6338.556301058881, 6353.078803573456, 5098.005888851639, 5270.604704647167, 5953.196318497034, 5956.76172953077, 6151.477124444383, 4780.880477988078, 4786.880327991828, 5520.227168196456, 5558.138488534284, 5558.610897237155, 6407.199100112486, 6491.058796474579, 6535.3464653534265, 6537.0521274413995, 6542.24764152119, 5533.253010843646, 6366.681665916593, 6371.5221358397375, 6372.299047104908, 6396.456301214449, 5237.738113094406, 5411.188321751769, 6337.2395312562785, 6565.015247712881, 6575.4410875076155, 6218.31598524171, 6244.469220116341, 6251.312355640966, 6271.31015588294, 6305.747770089329, 5625.8593535161945, 6198.275219325389, 6250.937490625036, 6311.810645680637, 6317.842053948688, 6232.034034724625, 6285.0, 6287.842803929755, 6295.055741638791, 6316.368363163647, 6077.058056001327, 6128.992047069418, 6129.939558357133, 6135.44703110649, 6135.508280839814, 6034.63792172471, 6081.148639190428, 6169.629822210682, 6203.96898015507, 6210.192674952227, 6189.597676151036, 6213.720382582705, 6231.376862313914, 6239.220097487814, 6242.375762423721, 5062.848114556569, 6036.366181550874, 6150.384961503813, 6178.474829639531, 6179.62922224668], "value": 5799.889562182679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.40785353648846, 506.14461559963684, 523.0271694647952, 524.3707550938873, 529.64249131836, 32942.17644558887, 40340.39489407658, 40393.79803100981, 40499.98750031247, 40623.78128656145, 42201.0, 42610.0, 42686.7865660672, 42724.0, 42814.57185428145, 9326.393784404027, 9510.0, 9510.952445237765, 9526.571304291288, 9549.188318992894, 9482.66810661627, 9561.856572151388, 9580.80838383232, 9591.520423978807, 9612.711618651452, 9524.999875013127, 9574.856377154349, 9575.138237558618, 9592.760180995461, 9629.614815407374, 9480.715578532621, 9561.235101191887, 9566.856497152548, 9567.0, 9590.280728945358, 9361.251099911991, 9404.38871473352, 9439.669611563631, 9440.197583205436, 9462.243020558408, 39747.602523974965, 39921.20157596861, 39999.8000010001, 40031.79984100061, 40130.19739605192, 3288.19439237386, 3297.7032067113837, 3304.2895777407734, 3345.2974875276223, 3404.14896275931, 30179.849100754574, 30319.0, 30344.241393965105, 30940.226494337596, 31191.688083119105, 3028.258076771205, 3138.0, 3148.9685103148904, 3211.855466504013, 3250.9921924203336, 384319.0, 515083.0, 521498.0, 522261.0, 522569.9999999962, 62825.057624135676, 63573.68213158905, 63577.72844543083, 63600.68199658972, 63668.0, 66635.33364666291, 66999.66500167469, 67119.32880671228, 67162.99255511172, 67211.32788672148, 13902.0, 16336.591585210228, 16508.596769274507, 16515.91742041306, 16563.83436165623, 10667.946660266649, 10748.838767418494, 12667.986561075091, 12702.936485317514, 12705.983521318272, 15213.31540080699, 18156.59573633722, 19180.520486987938, 19275.93982330985, 19386.2245510178, 6428.360768004129, 6651.7671881484885, 7462.104547454232, 7760.555425041094, 7804.492707973964, 822.7284995951321, 863.6415887406656, 968.2205824311357, 998.0618218874235, 999.2905037423511, 25402.491950160893, 26901.654917254058, 30270.243243919078, 30417.391652166833, 30633.69366306353, 914.8947870994921, 991.3345579426489, 1031.6079889641887, 1032.7986042721598, 1046.5662043001137, 15011.099334039993, 15454.536363909101, 15730.842691573167, 15850.976628880951, 15886.285117169524, 517113.0, 614893.0, 615445.9227703833, 615961.0, 616938.0, 57763.422365775805, 58236.0, 58362.12456813151, 58442.4155758437, 58498.0, 1231.8829711177423, 1280.7054377493043, 1326.5091915991145, 1368.2337890781193, 1369.9383527741077, 29523.261918452212, 30104.397912042074, 30161.944331948278, 30275.76414318863, 30428.391432171677, 51634.74182629063, 52325.738371309424, 52445.0, 52510.73744631252, 52663.21005185002, 485454.0, 486278.0, 487149.0, 488070.0, 573174.0, 26785.33036674099, 26972.865135674198, 27119.0, 27124.1862744118, 27237.59143612887, 46151.84620384517, 46172.0, 46641.36755213551, 47682.52317476781, 47849.28226076681, 38968.220635586564, 38987.0, 39441.40837887491, 39647.80176099101, 40596.78209653715, 35932.742354017486, 36120.4581931266, 38866.6113338863, 39206.6079339203, 40043.79978100091, 37458.43812342762, 38279.0, 38469.0, 38474.42288365621, 38584.035399115244, 32030.51954220642, 33905.66094339025, 34491.0, 34821.477677834344, 34854.0, 25695.743042570084, 25983.579703957934, 26005.349866253495, 26007.609885852107, 26216.475670486863], "value": 19757.042662604512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.73130301849466, 375.30943064760834, 381.9866304679336, 388.84640566976066, 407.03735665151925, 17884.0, 18179.545511362205, 19116.33092841751, 19449.611007779837, 19694.409167724956, 19329.710054349194, 19676.508087297825, 20012.799872001277, 20081.0, 20086.799132008677, 5638.887222255553, 5641.379448260688, 5911.527077833763, 5917.053271476565, 5944.524438044946, 5674.0, 5824.446677565625, 5826.417358264161, 5828.883422331551, 5835.18307436957, 5683.687397193174, 5749.482546570808, 5785.595008349417, 5787.681677507735, 5803.448672376138, 4882.6826256293225, 5513.889722205554, 5721.370649228582, 5751.166080918243, 5752.568557358173, 4436.0906014267, 4754.286856971447, 4767.7616119194245, 4995.775190116454, 5056.721880296583, 12886.097973141885, 12975.351232438341, 13021.218726876417, 13218.73562528744, 13225.470981160743, 2282.600544904635, 2308.9769102309097, 2312.7224733031976, 2537.555927712643, 2899.420115976792, 9522.523873806282, 9651.613935442574, 9866.0, 10340.121089707383, 10390.584376625002, 1496.6108811708925, 1773.973390399145, 1786.4015554789162, 1787.1064467766116, 1810.6650269700017, 115602.0, 116802.24796627973, 122212.0, 124421.0, 131351.34324328316, 10527.368357898551, 11087.279326843729, 11502.309861408343, 11667.124965627612, 11784.88215117855, 14544.709105817825, 14591.270436478346, 14749.336279867432, 14750.778738318933, 14765.409383624534, 7560.470767046254, 8035.477693949992, 8368.623411946477, 8472.44929079608, 8482.406231563855, 8315.708950186714, 8333.210060995158, 8348.874766878502, 8474.703385381483, 8498.575071246536, 4502.707324023928, 4552.226121559276, 4585.72485650862, 4606.378138951266, 4682.133805245972, 1676.8826182167375, 1883.2655264446876, 1931.874428162165, 1932.1884808380514, 1932.4202739178472, 775.8409526047146, 808.5714571277115, 822.4736168851939, 925.3892430995511, 929.5120061967522, 19630.705539416922, 20623.58752824935, 20866.47833804167, 20941.267055653283, 21054.894725526276, 892.4466830565091, 916.505087252876, 928.8560273157672, 955.4649396338073, 981.9852702209473, 10560.683179504627, 11107.83338249927, 11130.610428634958, 11137.721556960978, 11165.83251251232, 487460.0, 488104.0, 492641.0, 578895.0, 585653.0, 74980.0, 80680.0, 112848.43575782068, 123864.0, 126150.0, 949.1505102932974, 955.9235261179089, 996.5166894056376, 1002.5688953749811, 1004.467632154959, 18601.627967440305, 18965.90517047406, 19110.808891910903, 19186.520336991685, 19290.903545482743, 55202.72398637981, 56129.71935140298, 56624.0, 56910.430895690515, 57525.0, 66373.0, 80476.0, 84221.0, 84530.0, 84778.57610711906, 6767.89848152288, 8015.879761803461, 8123.0658474276215, 8208.46644968075, 8245.505269683837, 11627.186096973131, 12533.93733031329, 12616.053795965156, 12624.242545447303, 12814.359282036048, 10787.892121078688, 10825.729356766144, 10876.836847447137, 10953.780924381308, 10999.945000274947, 10640.946795265974, 10711.196660250669, 10898.964598363144, 11036.337819730841, 11181.0, 9886.0, 11146.832797507881, 11148.108151348035, 11262.986331230228, 11646.94176529112, 7986.800329991796, 7997.680092796456, 8201.26188643025, 8390.07709152005, 8391.244787969112, 10416.739581510523, 10858.945705271422, 11042.613508527164, 11129.443527823738, 11135.10919126484], "value": 9181.756232604086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.572376806234, 1299.805029245613, 1344.7915573086173, 1769.59299361147, 1776.3960253513803, 7609.6956121755065, 7893.210678932104, 8100.068492123408, 8550.914490855082, 8581.52801595912, 6855.451563874891, 7396.297351751575, 8336.208060234283, 8336.416450848443, 8338.291245244147, 2277.9886100569474, 2319.3158018384534, 2327.534493101378, 2331.8834058297102, 2348.7064116985375, 1984.6130004649099, 2328.53429314137, 2347.6009078456705, 2350.4006478348083, 2369.360272726363, 2270.126001489422, 2279.452931296485, 2295.5867943770113, 2298.1496846166942, 2313.028528018228, 1975.3283883479614, 2269.580127676377, 2279.338991692407, 2284.1662793080573, 2291.8051965582945, 2287.3709729824263, 2291.0721157931066, 2291.7708229177115, 2298.092253559851, 2310.8613483190893, 8349.33205343571, 8416.957915210445, 8417.326613870875, 8419.368547358912, 8422.957885210595, 5054.368203974504, 5204.609654275944, 5217.452167522393, 5232.189010703347, 5237.764300606482, 3153.4796758534812, 3302.398336806647, 3522.700570451489, 3525.0834782956617, 3525.4359302511475, 1023.4780262066325, 1054.1777413617315, 1067.2742535076145, 1082.7888561730465, 1084.7993121272589, 10932.398718070503, 10970.890291097066, 10981.945090274578, 11049.33703977764, 11094.667159985212, 4527.320901864681, 4595.885102872388, 4682.742449165328, 4705.200115980291, 4762.238041913277, 8241.928549288674, 8347.248747612744, 9469.90530094704, 9488.620455181854, 9500.334976551714, 5206.088934436459, 5207.4011488678525, 5215.713135777492, 5218.712970786643, 5221.817236396708, 4267.189234045583, 4336.588024137702, 4736.313234580966, 4786.042791441726, 4788.353572267769, 3317.883874064396, 3321.9501707474406, 3800.9809950950066, 3817.9236415272094, 3933.115049113984, 1111.2776695148218, 1286.2604002698486, 1287.6137158852307, 1295.591888555102, 1300.7073408483016, 761.219749756493, 868.7480630617176, 869.6695255802755, 879.0374539878823, 887.6183241206344, 4636.721796692209, 5569.303837020372, 5572.024895643327, 5903.787184899034, 6045.697715114226, 827.2513375395276, 865.6191275838611, 866.1381924984555, 897.7800438892513, 922.6171138977384, 3715.758475699071, 3786.072412259014, 3802.1825307559006, 3808.6953043756434, 3830.540335159799, 10005.49972501372, 10372.27394082407, 10395.896041039492, 10409.9479502602, 10434.269601127848, 10346.948265258625, 10347.896521034694, 10375.740606484747, 10381.480925953672, 10382.480875956171, 7682.231776822273, 7857.1749966253865, 7876.133625301212, 8015.238552337519, 8016.118226995026, 5004.199328107486, 5299.5760339172, 5563.109902415594, 5750.338711048115, 5752.626079305, 9283.72148835536, 9407.388519746468, 9496.24030077606, 9515.476648784383, 9533.47565883883, 9148.908510914805, 9375.203107735919, 9514.85727714071, 9598.616055357987, 9640.035996400304, 6632.436242919213, 6826.180858297036, 6988.965055174692, 7020.508564400443, 7130.251323611154, 6512.0, 6589.0, 6936.687849046906, 7683.9231607683205, 7877.606119693878, 7143.285671433023, 7290.343869051599, 7295.197528271779, 7332.120145582564, 7377.741779037708, 6068.241469816273, 7079.1858936223, 7107.969344444923, 7135.703929569791, 7226.494145409771, 5790.652560846363, 6473.029045643003, 6777.051212830109, 6827.180738311435, 6829.112215411965, 4758.619310455086, 4765.237561990065, 4831.637627178046, 4848.9757551212015, 4854.441739200037, 4694.507076756891, 4782.282657601388, 4793.952060479351, 4959.97520012412, 5021.949780502148], "value": 4370.502200272464, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.06202303869514, 307.74918441470214, 308.7823084725269, 313.52031391970286, 316.8890888189134, 4757.9762101189535, 5303.965726683298, 5462.640476107195, 5479.424660410659, 5495.532879705225, 4757.333973243749, 5234.398044224915, 5336.759845806938, 5468.7539060742265, 5502.779888804453, 4217.536071032184, 4232.174725928445, 4241.745495270294, 4250.596193361625, 4257.212415703089, 4016.2369149861433, 4114.650254728352, 4188.664906807463, 4252.170826688797, 4276.379924910886, 3447.9827600862086, 3642.4900513928073, 4109.732867363627, 4162.209180255757, 4169.9791501042455, 4130.938035929464, 4138.0, 4153.190127925056, 4206.242876282268, 4207.221663992141, 3228.515722641599, 3256.772025958184, 3504.8598056077726, 3677.8344974475945, 3687.3915803892323, 5198.9480105198845, 5262.0, 5307.522322990911, 5363.410024897258, 5373.408925018245, 4739.573438390561, 4739.715617062987, 4777.426708794932, 4813.350197723297, 4817.542333478314, 5415.323084614423, 5498.945010549884, 5746.367899531048, 5836.519479221356, 5856.853578660525, 3224.6452890182063, 3985.5488874342072, 3989.3617021276746, 3994.6205110514456, 4003.499562554681, 5238.60710446718, 5808.390119037483, 5956.289888100904, 6071.241094863142, 6200.87598248037, 4081.775502347399, 4086.4483294755423, 4098.508179018478, 4113.218488487178, 4114.732542384735, 3276.852541635632, 3942.1222507569637, 4053.0, 4090.2637525245145, 4091.133878484803, 4043.4137050127565, 4757.191277482836, 4806.389859397141, 4848.9757551212015, 4859.319695242669, 5835.854103647358, 5868.354481007086, 5900.350961394243, 5904.937111320004, 5920.644761314335, 1246.3581255653346, 1261.2810697902291, 1301.3537874588653, 1305.7519071376598, 1311.7769979103575, 887.6183241206214, 888.7822483491586, 901.3059943843335, 903.4482421827346, 923.5705396990431, 4613.861584152481, 4676.205045142334, 4896.877578060506, 5022.8949631081105, 5212.50481204285, 5164.0, 5556.166355158898, 5608.579356548275, 5657.246253661296, 5680.11958146488, 4513.35262629138, 4966.51004698589, 5065.746712664352, 5104.259882317043, 5203.661761985459, 2629.7238789927164, 2639.828411153269, 2942.867570959312, 2963.4221326841057, 2966.391889662614, 5545.556355491551, 5572.4148964358155, 5643.604947653625, 5857.56489660036, 5877.4122587740885, 4840.418090612991, 5480.314960629921, 5574.665520068727, 5676.205331253628, 5829.504492118217, 4999.950020491581, 5314.820923421456, 5767.548791763567, 5784.219130417424, 5886.793962211302, 5300.257963885137, 5702.971485142713, 5746.224259724883, 5746.2529871116485, 5782.930157920798, 5445.495072266644, 5478.342598888159, 5484.451554844643, 5532.446755324436, 5601.523870470893, 4727.770779597261, 4750.904981900412, 5170.794107653279, 5805.3033635962265, 5881.823545293648, 3346.4311067119133, 3398.898033059012, 3757.4363845423404, 3836.8105887175066, 3854.2098869731076, 5296.33165552865, 5738.0, 5876.471117599436, 5954.345022047484, 6035.728392222449, 5677.630953987978, 5722.366297401097, 5788.334341550607, 5854.824355269178, 5870.5010074144175, 4694.882627934329, 5792.247007888947, 5827.3881242470625, 5830.4461076197695, 5854.892238793946, 5355.3305836770405, 5545.667259964415, 5559.583031272751, 5571.860703482445, 5745.482906538432, 5541.251930989265, 5796.058320462692, 5846.707664616837, 5908.615939963888, 5916.7041647918295, 4883.121038213156, 5059.494050595058, 5145.089340970996, 5743.942560574508, 5756.913646295226], "value": 4150.756435274455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7293082766893, 679.5514960126316, 688.887446773461, 717.5858150256315, 784.9097353804315, 13589.7961530577, 13915.37380817863, 13916.652083697913, 14041.648958776022, 14105.435782568698, 13258.204507729519, 13351.599452016431, 13399.93300033501, 14228.573142805732, 14823.629409264773, 647.9935200647992, 671.03036112817, 806.9878951815728, 825.0800357601262, 838.9412741108094, 836.2515548584014, 836.5817091454273, 836.8744688296744, 839.0, 839.2740279658083, 870.3994243971639, 875.4090988582712, 875.8905136857893, 877.662100091463, 880.1286726141107, 854.5983387807752, 854.7606670132373, 860.6858496648741, 867.1805144138791, 870.595173244438, 623.7442648514133, 644.1561554363799, 646.5764923974804, 647.8866198415305, 648.5265755998148, 13630.318484075757, 14286.785698214535, 14308.92845535776, 14517.128972261698, 14535.70928581433, 13365.86634133656, 13387.263700496469, 13486.0, 13543.98420118495, 13872.375743091585, 11304.982551570398, 11356.829647555292, 11543.134264930164, 11554.884451155465, 11664.708382290426, 3585.3904836177912, 3626.220362622049, 3637.854485820564, 3656.469811877263, 3661.4507823826375, 85742.0, 91345.54327228387, 94103.52948235215, 94536.0, 95010.52494737551, 10179.0, 10257.538410771383, 10368.844467332996, 10467.84298235527, 10576.629817956335, 20230.291939782037, 20240.190392384433, 20314.593708125754, 20610.690839637417, 20671.17315307371, 7361.889571656429, 7497.887531687029, 7577.0, 7615.276548727862, 7679.923200768033, 4180.853670121592, 4295.5060168080445, 4329.675274354436, 4369.279068953587, 4386.320120381346, 3459.6713312235297, 3551.183227857607, 3568.072301201706, 3574.982125089358, 3576.4277715565904, 619.4084649160042, 637.6747858592151, 639.7217210513442, 641.5637366590763, 655.0828839624563, 597.698162427971, 598.5869749872573, 627.0312367392389, 644.9226092868886, 645.1838424393146, 8518.296340731878, 8943.463392196489, 8973.461592304351, 9123.498207598646, 9191.816163676824, 513.8432778002744, 537.4383768961445, 547.4279378049947, 553.3028384235811, 610.6854969690613, 4322.054092696279, 4338.175746608134, 4576.610988065985, 4589.839355622537, 4637.652176086807, 84437.57781211054, 106756.0, 110296.79406411826, 110408.47957602248, 114338.42830785793, 73102.17244568928, 86110.0, 91604.54197728969, 93960.06039939514, 97456.0, 64229.0, 79108.0, 80904.59547702341, 81995.18004819876, 83951.74072388919, 7362.77911662651, 8534.871976920227, 8774.912250877409, 8816.206541411304, 8903.510306933182, 53069.469305306455, 57910.7104464475, 57948.0, 58374.29261542636, 60031.39968600258, 79536.4092718154, 79593.60203198947, 80184.0, 82760.0, 83651.0, 8792.0, 9781.875084365389, 11047.447627618747, 11327.943360283476, 11387.202895797214, 12167.187267588733, 12253.835885590855, 12263.0, 12290.631281061582, 12536.247825130522, 11843.1709780318, 11922.344271065174, 11928.821067684165, 11995.64013079609, 12319.322437266037, 11753.236039657395, 11899.940500297444, 11991.280523168638, 11995.520179192734, 12149.212698066194, 11562.364069976233, 11749.647510574696, 11797.35114568707, 11840.526378944745, 11917.463714133059, 10205.336653117523, 10213.438260895426, 10269.537870795682, 10500.369977801356, 10516.000979906896, 9602.279829012712, 10074.44590547527, 10104.242181836538, 10109.03964123407, 10109.545070471993], "value": 7098.522443728824, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 120.0, 120.0, 168.0, 173.0, 140.0, 121.0, 120.0, 121.0, 119.0], "value": 130.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 122.0, 153.0, 112.0, 116.0, 119.0, 120.0, 182.0, 116.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 227.0, 244.0, 194.0, 208.0, 244.0, 194.0, 195.0, 193.0, 196.0], "value": 208.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 86.0, 63.0, 61.0, 58.0, 59.0, 80.0, 59.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 91.0, 72.0, 72.0, 71.0, 87.0, 70.0, 72.0, 89.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 103.0, 135.0, 105.0, 90.0, 99.0, 88.0, 109.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 115.0, 151.0, 153.0, 102.0, 94.0, 93.0, 97.0, 95.0, 105.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 85.0, 87.0, 91.0, 88.0, 138.0, 144.0, 110.0, 90.0], "value": 101.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 56.0, 63.0, 86.0, 56.0, 65.0, 73.0, 91.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 70.0, 73.0, 76.0, 68.0, 70.0, 72.0, 71.0, 73.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 80.0, 107.0, 105.0, 107.0, 73.0, 71.0, 99.0, 99.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 151.0, 157.0, 159.0, 148.0, 149.0, 170.0, 271.0, 184.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 221.0, 170.0, 168.0, 162.0, 166.0, 162.0, 216.0, 230.0, 168.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 65.0, 82.0, 90.0, 61.0, 76.0, 89.0, 91.0, 87.0], "value": 77.9, "unit": "score"}]}]} 11:21:11 INFO - Return code: 0 11:21:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:21:11 ERROR - # TBPL SUCCESS # 11:21:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:21:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:21:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:21:11 INFO - 2016-11-14 11:21:11.175 screenresolution[1671:10756] starting screenresolution argv=screenresolution get 11:21:11 INFO - 2016-11-14 11:21:11.178 screenresolution[1671:10756] Display 0: 1600x1200x32@60 11:21:11 INFO - 2016-11-14 11:21:11.184 screenresolution[1672:10759] starting screenresolution argv=screenresolution list 11:21:11 INFO - Available Modes on Display 0 11:21:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:21:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:21:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:21:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:21:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:21:11 INFO - Intel Iris: 11:21:11 INFO - Chipset Model: Intel Iris 11:21:11 INFO - Type: GPU 11:21:11 INFO - Bus: Built-In 11:21:11 INFO - VRAM (Dynamic, Max): 1536 MB 11:21:11 INFO - Vendor: Intel (0x8086) 11:21:11 INFO - Device ID: 0x0a2e 11:21:11 INFO - Revision ID: 0x0009 11:21:11 INFO - Displays: 11:21:11 INFO - Display: 11:21:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:21:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:21:11 INFO - Display Serial Number: 1600x1200 60 11:21:11 INFO - Main Display: Yes 11:21:11 INFO - Mirror: Off 11:21:11 INFO - Online: Yes 11:21:11 INFO - Rotation: Supported 11:21:11 INFO - Return code: 0 11:21:11 INFO - Running post-action listener: _resource_record_post_action 11:21:11 INFO - [mozharness: 2016-11-14 19:21:11.424210Z] Finished run-tests step (success) 11:21:11 INFO - Running post-run listener: _resource_record_post_run 11:21:11 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37310464; Write bytes: 656247808; Read time: 365; Write time: 1877 11:21:11 INFO - TinderboxPrint: CPU usage
54.4% 11:21:11 INFO - TinderboxPrint: I/O read bytes / time
37,310,464 / 365 11:21:11 INFO - TinderboxPrint: I/O write bytes / time
656,247,808 / 1,877 11:21:11 INFO - TinderboxPrint: CPU idle
2,207.3 (45.6%) 11:21:11 INFO - TinderboxPrint: CPU system
975.6 (20.2%) 11:21:11 INFO - TinderboxPrint: CPU user
1,654.7 (34.2%) 11:21:11 INFO - TinderboxPrint: Swap in / out
391,270,400 / 0 11:21:11 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 311296; Write bytes: 356308992; Read time: 9; Write time: 689 11:21:11 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 33492992; Write bytes: 296685056; Read time: 331; Write time: 1136 11:21:11 INFO - Running post-run listener: _upload_blobber_files 11:21:11 INFO - Blob upload gear active. 11:21:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:21:11 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 11:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:21:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:13 INFO - (blobuploader) - INFO - Done attempting. 11:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:13 INFO - (blobuploader) - INFO - Done attempting. 11:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:16 INFO - (blobuploader) - INFO - Done attempting. 11:21:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:16 INFO - Return code: 0 11:21:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:21:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be28d968fa2c83c403dcf36e732b64eb02a4396bf84157e586befad5eaa0cf06105fc32b4ee4f1458be2873e10675d4be58ede5212788382b317350af4bb47c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/261de0706eaddd1cfe07e14e51678aabe8573fd00d134b570a00d740d9fb77b19dd9f9c1df77cd659c0f481494253504e4b2e90ea112bf2ea069afdc2d1f2c30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c742f4898c5ffba6ad3d676dc0d287b2f982a148679c6d2f3661e5ca9e53bcdc938bdb2e6c60957872f1c988cda0b405dc7830160e021443d61cbfd8fe1ee448"} 11:21:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:21:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:21:16 INFO - Contents: 11:21:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be28d968fa2c83c403dcf36e732b64eb02a4396bf84157e586befad5eaa0cf06105fc32b4ee4f1458be2873e10675d4be58ede5212788382b317350af4bb47c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/261de0706eaddd1cfe07e14e51678aabe8573fd00d134b570a00d740d9fb77b19dd9f9c1df77cd659c0f481494253504e4b2e90ea112bf2ea069afdc2d1f2c30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c742f4898c5ffba6ad3d676dc0d287b2f982a148679c6d2f3661e5ca9e53bcdc938bdb2e6c60957872f1c988cda0b405dc7830160e021443d61cbfd8fe1ee448"} 11:21:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:21:16 INFO - Copying logs to upload dir... 11:21:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:21:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.108372 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 11:21:16.414036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:21:16.418961) ========= 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.t61O9livnz/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.LRMPgFuNux/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be28d968fa2c83c403dcf36e732b64eb02a4396bf84157e586befad5eaa0cf06105fc32b4ee4f1458be2873e10675d4be58ede5212788382b317350af4bb47c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/261de0706eaddd1cfe07e14e51678aabe8573fd00d134b570a00d740d9fb77b19dd9f9c1df77cd659c0f481494253504e4b2e90ea112bf2ea069afdc2d1f2c30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c742f4898c5ffba6ad3d676dc0d287b2f982a148679c6d2f3661e5ca9e53bcdc938bdb2e6c60957872f1c988cda0b405dc7830160e021443d61cbfd8fe1ee448"} build_url:https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010810 build_url: 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be28d968fa2c83c403dcf36e732b64eb02a4396bf84157e586befad5eaa0cf06105fc32b4ee4f1458be2873e10675d4be58ede5212788382b317350af4bb47c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/261de0706eaddd1cfe07e14e51678aabe8573fd00d134b570a00d740d9fb77b19dd9f9c1df77cd659c0f481494253504e4b2e90ea112bf2ea069afdc2d1f2c30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c742f4898c5ffba6ad3d676dc0d287b2f982a148679c6d2f3661e5ca9e53bcdc938bdb2e6c60957872f1c988cda0b405dc7830160e021443d61cbfd8fe1ee448"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:21:16.455576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:21:16.456184) ========= 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.t61O9livnz/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.LRMPgFuNux/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005158 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:21:16.513416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:21:16.513786) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:21:16.514157) ========= ========= Total master_lag: 0.21 =========