builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0084 starttime: 1480090244.78 results: success (0) buildid: 20161125054319 builduid: 3ee5a34bfa2749ab99753cc938a3c966 revision: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.781719) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.782227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.782642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.808029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.808441) ========= 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.XhTodbYg5j/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.HsA0EivxLB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-25 08:10:44-- 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% 8.39M=0.001s 2016-11-25 08:10:44 (8.39 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.915991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.916521) ========= 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.XhTodbYg5j/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.HsA0EivxLB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.020081 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:44.966997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 08:10:44.967586) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 --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 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XhTodbYg5j/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.HsA0EivxLB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-25 08:10:45,040 truncating revision to first 12 chars 2016-11-25 08:10:45,041 Setting DEBUG logging. 2016-11-25 08:10:45,041 attempt 1/10 2016-11-25 08:10:45,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8102d0d48f8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 08:10:46,283 unpacking tar archive at: mozilla-aurora-8102d0d48f8d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.496428 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 08:10:46.489402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:46.489873) ========= script_repo_revision: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:46.490538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:46.491014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 08:10:46.512080) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-25 08:10:46.512603) ========= /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.XhTodbYg5j/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.HsA0EivxLB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:10:46 INFO - MultiFileLogger online at 20161125 08:10:46 in /builds/slave/test 08:10:46 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 08:10:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:46 INFO - {'append_to_log': False, 08:10:46 INFO - 'base_work_dir': '/builds/slave/test', 08:10:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:10:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:46 INFO - 'branch': 'Mozilla-Aurora', 08:10:46 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:46 INFO - 'config_files': ('talos/mac_config.py',), 08:10:46 INFO - 'default_actions': ('clobber', 08:10:46 INFO - 'read-buildbot-config', 08:10:46 INFO - 'download-and-extract', 08:10:46 INFO - 'populate-webroot', 08:10:46 INFO - 'create-virtualenv', 08:10:46 INFO - 'install', 08:10:46 INFO - 'run-tests'), 08:10:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:46 INFO - 'download_minidump_stackwalk': True, 08:10:46 INFO - 'download_symbols': 'ondemand', 08:10:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:46 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:46 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:46 INFO - 'installer_path': 'installer.exe', 08:10:46 INFO - 'log_level': 'info', 08:10:46 INFO - 'log_name': 'talos', 08:10:46 INFO - 'log_to_console': True, 08:10:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:10:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:10:46 INFO - 'opt_config_files': (), 08:10:46 INFO - 'pip_index': False, 08:10:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:46 INFO - 'cmd': ('bash', 08:10:46 INFO - '-c', 08:10:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:46 INFO - 'enabled': True, 08:10:46 INFO - 'halt_on_failure': False, 08:10:46 INFO - 'name': 'check_screen_resolution'},), 08:10:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:46 INFO - 'cmd': ('bash', 08:10:46 INFO - '-c', 08:10:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:46 INFO - 'enabled': True, 08:10:46 INFO - 'halt_on_failure': False, 08:10:46 INFO - 'name': 'check_screen_resolution'},), 08:10:46 INFO - 'run_cmd_checks_enabled': True, 08:10:46 INFO - 'sps_profile': False, 08:10:46 INFO - 'sps_profile_interval': 0, 08:10:46 INFO - 'suite': 'dromaeojs-e10s', 08:10:46 INFO - 'system_bits': '32', 08:10:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:46 INFO - 'title': 't-yosemite-r7-0084', 08:10:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:46 INFO - 'use_talos_json': True, 08:10:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:46 INFO - 'work_dir': 'build'} 08:10:46 INFO - [mozharness: 2016-11-25 16:10:46.709649Z] Running clobber step. 08:10:46 INFO - Running pre-action listener: _resource_record_pre_action 08:10:46 INFO - Running main action method: clobber 08:10:46 INFO - rmtree: /builds/slave/test/build 08:10:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:48 INFO - Running post-action listener: _resource_record_post_action 08:10:48 INFO - [mozharness: 2016-11-25 16:10:48.216075Z] Finished clobber step (success) 08:10:48 INFO - [mozharness: 2016-11-25 16:10:48.216237Z] Running read-buildbot-config step. 08:10:48 INFO - Running pre-action listener: _resource_record_pre_action 08:10:48 INFO - Running main action method: read_buildbot_config 08:10:48 INFO - Using buildbot properties: 08:10:48 INFO - { 08:10:48 INFO - "project": "", 08:10:48 INFO - "product": "firefox", 08:10:48 INFO - "script_repo_revision": "production", 08:10:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:10:48 INFO - "repository": "", 08:10:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:10:48 INFO - "buildid": "20161125054319", 08:10:48 INFO - "pgo_build": "False", 08:10:48 INFO - "basedir": "/builds/slave/test", 08:10:48 INFO - "buildnumber": 40, 08:10:48 INFO - "slavename": "t-yosemite-r7-0084", 08:10:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:10:48 INFO - "platform": "yosemite_r7", 08:10:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:10:48 INFO - "branch": "mozilla-aurora", 08:10:48 INFO - "repo_path": "releases/mozilla-aurora", 08:10:48 INFO - "revision": "8102d0d48f8d7ea0f6fa76710ca8c44c620190e3", 08:10:48 INFO - "stage_platform": "macosx64", 08:10:48 INFO - "builduid": "3ee5a34bfa2749ab99753cc938a3c966", 08:10:48 INFO - "slavebuilddir": "test" 08:10:48 INFO - } 08:10:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:10:48 INFO - Running post-action listener: _resource_record_post_action 08:10:48 INFO - [mozharness: 2016-11-25 16:10:48.219750Z] Finished read-buildbot-config step (success) 08:10:48 INFO - [mozharness: 2016-11-25 16:10:48.219874Z] Running download-and-extract step. 08:10:48 INFO - Running pre-action listener: _resource_record_pre_action 08:10:48 INFO - Running main action method: download_and_extract 08:10:48 INFO - mkdir: /builds/slave/test/build/tests 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:48 INFO - trying https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:10:48 INFO - Downloading https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/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 08:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/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 08:10:48 INFO - Downloaded 1199 bytes. 08:10:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:10:48 INFO - Using the following test package requirements: 08:10:48 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:10:48 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:10:48 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:10:48 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'jsshell-mac.zip'], 08:10:48 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:10:48 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:10:48 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:10:48 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:10:48 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:10:48 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:10:48 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:10:48 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:10:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:10:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:10:48 INFO - Fetch https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:10:49 INFO - Http code: 200 08:10:49 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 08:10:49 INFO - x-amz-cf-id: CoEgSYNvXiOvZPaTX-ISE7RmKMbpkbgtEIQjyZXEo8RAcV_7bEykDQ== 08:10:49 INFO - x-amz-version-id: LqniN7jYANkM4ugMgCsJakVJQLCCG3ow 08:10:49 INFO - Expected file size: 16279025 08:10:49 INFO - Obtained file size: 16279025 08:10:56 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 08:10:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:10:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:10:56 INFO - Fetch https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:10:56 INFO - Http code: 200 08:10:56 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:10:56 INFO - x-amz-cf-id: mVPGuBVNj5na5FihdLCkMSF4tEOAlHy0PiN4ShPKomGONMJvrscs7Q== 08:10:56 INFO - x-amz-version-id: LqniN7jYANkM4ugMgCsJakVJQLCCG3ow 08:10:57 INFO - Expected file size: 16279025 08:10:57 INFO - Obtained file size: 16279025 08:11:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:11:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:11:03 INFO - Fetch https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:11:04 INFO - Http code: 200 08:11:04 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:11:04 INFO - x-amz-cf-id: FNuOaJhJJTbnWWB5RF0wTo2eJTuXTdIusp9wmeQleKHnZRa_Pc33Fg== 08:11:04 INFO - x-amz-version-id: YS9sA_CmRpweOx3N8fNTrnTRWxlMPYm8 08:11:04 INFO - Expected file size: 14409038 08:11:04 INFO - Obtained file size: 14409038 08:11:05 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')]} 08:11:05 INFO - trying https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:11:05 INFO - Downloading https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/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 08:11:07 INFO - Downloaded 109740416 bytes. 08:11:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:11:07 INFO - mkdir: /builds/slave/test/properties 08:11:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:07 INFO - Contents: 08:11:07 INFO - build_url:https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:11:08 INFO - Running post-action listener: _resource_record_post_action 08:11:08 INFO - Running post-action listener: set_extra_try_arguments 08:11:08 INFO - [mozharness: 2016-11-25 16:11:08.576431Z] Finished download-and-extract step (success) 08:11:08 INFO - [mozharness: 2016-11-25 16:11:08.576574Z] Running populate-webroot step. 08:11:08 INFO - Running pre-action listener: _resource_record_pre_action 08:11:08 INFO - Running main action method: populate_webroot 08:11:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:08 INFO - '--tppagecycles', 08:11:08 INFO - '7'], 08:11:08 INFO - 'tests': ['tsvgm']}}, 08:11:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['damp', 'tps']}, 08:11:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'tests': ['damp', 'tps']}, 08:11:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['dromaeo_dom']}, 08:11:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['basic_compositor_video']}, 08:11:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['a11yr', 08:11:08 INFO - 'ts_paint', 08:11:08 INFO - 'tpaint', 08:11:08 INFO - 'sessionrestore', 08:11:08 INFO - 'sessionrestore_no_auto_restore', 08:11:08 INFO - 'tabpaint']}, 08:11:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:08 INFO - 'ts_paint', 08:11:08 INFO - 'tpaint', 08:11:08 INFO - 'sessionrestore', 08:11:08 INFO - 'sessionrestore_no_auto_restore', 08:11:08 INFO - 'tabpaint']}, 08:11:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:08 INFO - 'ts_paint', 08:11:08 INFO - 'tpaint', 08:11:08 INFO - 'sessionrestore', 08:11:08 INFO - 'sessionrestore_no_auto_restore', 08:11:08 INFO - 'tabpaint']}, 08:11:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:08 INFO - 'ts_paint', 08:11:08 INFO - 'tpaint', 08:11:08 INFO - 'sessionrestore', 08:11:08 INFO - 'sessionrestore_no_auto_restore', 08:11:08 INFO - 'tabpaint']}, 08:11:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['a11yr', 08:11:08 INFO - 'ts_paint', 08:11:08 INFO - 'tpaint', 08:11:08 INFO - 'sessionrestore', 08:11:08 INFO - 'sessionrestore_no_auto_restore', 08:11:08 INFO - 'tabpaint']}, 08:11:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['a11yr', 08:11:08 INFO - 'ts_paint', 08:11:08 INFO - 'tpaint', 08:11:08 INFO - 'sessionrestore', 08:11:08 INFO - 'sessionrestore_no_auto_restore', 08:11:08 INFO - 'tabpaint']}, 08:11:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['tsvgx', 08:11:08 INFO - 'tsvgr_opacity', 08:11:08 INFO - 'tart', 08:11:08 INFO - 'tscrollx', 08:11:08 INFO - 'cart']}, 08:11:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:08 INFO - 'tsvgr_opacity', 08:11:08 INFO - 'tart', 08:11:08 INFO - 'tscrollx', 08:11:08 INFO - 'cart']}, 08:11:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'talos_options': ['--disable-e10s'], 08:11:08 INFO - 'tests': ['tp5o']}, 08:11:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'tests': ['tp5o']}, 08:11:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'talos_options': ['--disable-e10s', 08:11:08 INFO - '--xperf_path', 08:11:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:08 INFO - 'tests': ['tp5n']}, 08:11:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:08 INFO - 'talos_options': ['--xperf_path', 08:11:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:08 INFO - 'tests': ['tp5n']}}, 08:11:08 INFO - 'talos.zip': {'path': '', 08:11:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:08 INFO - Running post-action listener: _resource_record_post_action 08:11:08 INFO - [mozharness: 2016-11-25 16:11:08.595225Z] Finished populate-webroot step (success) 08:11:08 INFO - [mozharness: 2016-11-25 16:11:08.595352Z] Running create-virtualenv step. 08:11:08 INFO - Running pre-action listener: _resource_record_pre_action 08:11:08 INFO - Running main action method: create_virtualenv 08:11:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:08 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 08:11:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:08 INFO - Using real prefix '/tools/python27' 08:11:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:12 INFO - Installing pip.................done. 08:11:12 INFO - Return code: 0 08:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:11:12 INFO - Reading from file tmpfile_stdout 08:11:12 INFO - Output received: 08:11:12 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) 08:11:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:12 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')]} 08:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 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')]} 08:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:12 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 08:11:12 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 08:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:12 INFO - 'HOME': '/Users/cltbld', 08:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:12 INFO - 'LOGNAME': 'cltbld', 08:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:12 INFO - 'MOZ_NO_REMOTE': '1', 08:11:12 INFO - 'NO_EM_RESTART': '1', 08:11:12 INFO - 'PAGER': '/bin/cat', 08:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:12 INFO - 'PWD': '/builds/slave/test', 08:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:12 INFO - 'SHELL': '/bin/bash', 08:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:12 INFO - 'USER': 'cltbld', 08:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:12 INFO - 'XPC_FLAGS': '0x0', 08:11:12 INFO - 'XPC_SERVICE_NAME': '0', 08:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:12 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 08:11:12 INFO - Cleaning up... 08:11:12 INFO - Return code: 0 08:11:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:12 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')]} 08:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 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')]} 08:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:12 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 08:11:12 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 08:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:12 INFO - 'HOME': '/Users/cltbld', 08:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:12 INFO - 'LOGNAME': 'cltbld', 08:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:12 INFO - 'MOZ_NO_REMOTE': '1', 08:11:12 INFO - 'NO_EM_RESTART': '1', 08:11:12 INFO - 'PAGER': '/bin/cat', 08:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:12 INFO - 'PWD': '/builds/slave/test', 08:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:12 INFO - 'SHELL': '/bin/bash', 08:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:12 INFO - 'USER': 'cltbld', 08:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:12 INFO - 'XPC_FLAGS': '0x0', 08:11:12 INFO - 'XPC_SERVICE_NAME': '0', 08:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:13 INFO - Downloading/unpacking psutil>=3.1.1 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:16 INFO - Installing collected packages: psutil 08:11:16 INFO - Running setup.py install for psutil 08:11:16 INFO - building 'psutil._psutil_osx' extension 08:11:16 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 08:11:16 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 08:11:16 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 08:11:17 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 08:11:17 INFO - building 'psutil._psutil_posix' extension 08:11:17 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 08:11:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:11:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:11:17 INFO - ^ 08:11:17 INFO - 1 warning generated. 08:11:17 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 08:11:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:17 INFO - Successfully installed psutil 08:11:17 INFO - Cleaning up... 08:11:17 INFO - Return code: 0 08:11:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:17 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')]} 08:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:17 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')]} 08:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:17 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:17 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 08:11:17 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 08:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:17 INFO - 'HOME': '/Users/cltbld', 08:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:17 INFO - 'LOGNAME': 'cltbld', 08:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:17 INFO - 'MOZ_NO_REMOTE': '1', 08:11:17 INFO - 'NO_EM_RESTART': '1', 08:11:17 INFO - 'PAGER': '/bin/cat', 08:11:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:17 INFO - 'PWD': '/builds/slave/test', 08:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:17 INFO - 'SHELL': '/bin/bash', 08:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:17 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:17 INFO - 'USER': 'cltbld', 08:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:17 INFO - 'XPC_FLAGS': '0x0', 08:11:17 INFO - 'XPC_SERVICE_NAME': '0', 08:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:17 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 08:11:17 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 08:11:17 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 08:11:17 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 08:11:17 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 08:11:17 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 08:11:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:20 INFO - Installing collected packages: mozsystemmonitor 08:11:20 INFO - Running setup.py install for mozsystemmonitor 08:11:20 INFO - Successfully installed mozsystemmonitor 08:11:20 INFO - Cleaning up... 08:11:20 INFO - Return code: 0 08:11:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:20 INFO - 'HOME': '/Users/cltbld', 08:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:20 INFO - 'LOGNAME': 'cltbld', 08:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:20 INFO - 'MOZ_NO_REMOTE': '1', 08:11:20 INFO - 'NO_EM_RESTART': '1', 08:11:20 INFO - 'PAGER': '/bin/cat', 08:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:20 INFO - 'PWD': '/builds/slave/test', 08:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:20 INFO - 'SHELL': '/bin/bash', 08:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:20 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:20 INFO - 'USER': 'cltbld', 08:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:20 INFO - 'XPC_FLAGS': '0x0', 08:11:20 INFO - 'XPC_SERVICE_NAME': '0', 08:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:23 INFO - warning: no files found matching '*.txt' 08:11:23 INFO - no previously-included directories found matching 'build' 08:11:23 INFO - no previously-included directories found matching 'dist' 08:11:23 INFO - no previously-included directories found matching '.git*' 08:11:23 INFO - Installing collected packages: jsonschema, functools32 08:11:23 INFO - Running setup.py install for functools32 08:11:23 INFO - warning: no files found matching '*.txt' 08:11:23 INFO - no previously-included directories found matching 'build' 08:11:23 INFO - no previously-included directories found matching 'dist' 08:11:23 INFO - no previously-included directories found matching '.git*' 08:11:24 INFO - Successfully installed jsonschema functools32 08:11:24 INFO - Cleaning up... 08:11:24 INFO - Return code: 0 08:11:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:11:24 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')]} 08:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 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')]} 08:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:24 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 08:11:24 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 08:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:24 INFO - 'HOME': '/Users/cltbld', 08:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:24 INFO - 'LOGNAME': 'cltbld', 08:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:24 INFO - 'MOZ_NO_REMOTE': '1', 08:11:24 INFO - 'NO_EM_RESTART': '1', 08:11:24 INFO - 'PAGER': '/bin/cat', 08:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:24 INFO - 'PWD': '/builds/slave/test', 08:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:24 INFO - 'SHELL': '/bin/bash', 08:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:24 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:24 INFO - 'USER': 'cltbld', 08:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:24 INFO - 'XPC_FLAGS': '0x0', 08:11:24 INFO - 'XPC_SERVICE_NAME': '0', 08:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:11:24 INFO - Cleaning up... 08:11:24 INFO - Return code: 0 08:11:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:24 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')]} 08:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 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')]} 08:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:24 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 08:11:24 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 08:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:24 INFO - 'HOME': '/Users/cltbld', 08:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:24 INFO - 'LOGNAME': 'cltbld', 08:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:24 INFO - 'MOZ_NO_REMOTE': '1', 08:11:24 INFO - 'NO_EM_RESTART': '1', 08:11:24 INFO - 'PAGER': '/bin/cat', 08:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:24 INFO - 'PWD': '/builds/slave/test', 08:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:24 INFO - 'SHELL': '/bin/bash', 08:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:24 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:24 INFO - 'USER': 'cltbld', 08:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:24 INFO - 'XPC_FLAGS': '0x0', 08:11:24 INFO - 'XPC_SERVICE_NAME': '0', 08:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:24 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 08:11:24 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 08:11:24 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 08:11:24 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 08:11:24 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 08:11:24 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 08:11:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:28 INFO - Downloading docopt-0.6.1.tar.gz 08:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:28 INFO - Running setup.py install for blobuploader 08:11:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:28 INFO - Running setup.py install for requests 08:11:29 INFO - Running setup.py install for docopt 08:11:29 INFO - Successfully installed blobuploader requests docopt 08:11:29 INFO - Cleaning up... 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:29 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 08:11:29 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 08:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:29 INFO - 'HOME': '/Users/cltbld', 08:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PAGER': '/bin/cat', 08:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:29 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - 'XPC_FLAGS': '0x0', 08:11:29 INFO - 'XPC_SERVICE_NAME': '0', 08:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:29 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-8zz7sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:29 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JuyHF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:29 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Jk_lJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:29 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-l21ZNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:29 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hiQWwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YIfcQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fH5Ir2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-g5uFzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cScVB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-kDnrtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vTSN05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-T25jEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-NNehlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xcFpEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mWMtQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-SVigyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-1s7l1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:31 INFO - Running setup.py install for manifestparser 08:11:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Running setup.py install for mozcrash 08:11:31 INFO - Running setup.py install for mozdebug 08:11:31 INFO - Running setup.py install for mozdevice 08:11:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Running setup.py install for mozfile 08:11:32 INFO - Running setup.py install for mozhttpd 08:11:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozinfo 08:11:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozInstall 08:11:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozleak 08:11:32 INFO - Running setup.py install for mozlog 08:11:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for moznetwork 08:11:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozprocess 08:11:33 INFO - Running setup.py install for mozprofile 08:11:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozrunner 08:11:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozscreenshot 08:11:33 INFO - Running setup.py install for moztest 08:11:33 INFO - Running setup.py install for mozversion 08:11:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:33 INFO - Cleaning up... 08:11:33 INFO - Return code: 0 08:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:33 INFO - 'HOME': '/Users/cltbld', 08:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:33 INFO - 'LOGNAME': 'cltbld', 08:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:33 INFO - 'MOZ_NO_REMOTE': '1', 08:11:33 INFO - 'NO_EM_RESTART': '1', 08:11:33 INFO - 'PAGER': '/bin/cat', 08:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:33 INFO - 'PWD': '/builds/slave/test', 08:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:33 INFO - 'SHELL': '/bin/bash', 08:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:33 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:33 INFO - 'USER': 'cltbld', 08:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:33 INFO - 'XPC_FLAGS': '0x0', 08:11:33 INFO - 'XPC_SERVICE_NAME': '0', 08:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-HqkkJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wrgoxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hiAZR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Kc0ePc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rhEMY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-kswzAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ferp2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:34 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ztN5R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-7CJUPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-EllKuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZwTeGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-lihQbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qt47n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-RzoJ2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-IYipwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-J1PZOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5BjL7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:38 INFO - Downloading blessings-1.6.tar.gz 08:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:38 INFO - Installing collected packages: blessings 08:11:38 INFO - Running setup.py install for blessings 08:11:38 INFO - Successfully installed blessings 08:11:38 INFO - Cleaning up... 08:11:38 INFO - Return code: 0 08:11:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:39 INFO - Reading from file tmpfile_stdout 08:11:39 INFO - Current package versions: 08:11:39 INFO - blessings == 1.6 08:11:39 INFO - blobuploader == 1.2.4 08:11:39 INFO - docopt == 0.6.1 08:11:39 INFO - functools32 == 3.2.3-2 08:11:39 INFO - jsonschema == 2.5.1 08:11:39 INFO - manifestparser == 1.1 08:11:39 INFO - mozInstall == 1.12 08:11:39 INFO - mozcrash == 1.0 08:11:39 INFO - mozdebug == 0.1 08:11:39 INFO - mozdevice == 0.48 08:11:39 INFO - mozfile == 1.2 08:11:39 INFO - mozhttpd == 0.7 08:11:39 INFO - mozinfo == 0.9 08:11:39 INFO - mozleak == 0.1 08:11:39 INFO - mozlog == 3.4 08:11:39 INFO - moznetwork == 0.27 08:11:39 INFO - mozprocess == 0.23 08:11:39 INFO - mozprofile == 0.28 08:11:39 INFO - mozrunner == 6.13 08:11:39 INFO - mozscreenshot == 0.1 08:11:39 INFO - mozsystemmonitor == 0.3 08:11:39 INFO - moztest == 0.7 08:11:39 INFO - mozversion == 1.4 08:11:39 INFO - psutil == 3.1.1 08:11:39 INFO - requests == 1.2.3 08:11:39 INFO - wsgiref == 0.1.2 08:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:39 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 08:11:39 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 08:11:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:39 INFO - 'HOME': '/Users/cltbld', 08:11:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:39 INFO - 'LOGNAME': 'cltbld', 08:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:39 INFO - 'MOZ_NO_REMOTE': '1', 08:11:39 INFO - 'NO_EM_RESTART': '1', 08:11:39 INFO - 'PAGER': '/bin/cat', 08:11:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:39 INFO - 'PWD': '/builds/slave/test', 08:11:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:39 INFO - 'SHELL': '/bin/bash', 08:11:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:39 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:39 INFO - 'USER': 'cltbld', 08:11:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:39 INFO - 'XPC_FLAGS': '0x0', 08:11:39 INFO - 'XPC_SERVICE_NAME': '0', 08:11:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 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)) 08:11:39 INFO - Cleaning up... 08:11:39 INFO - Return code: 0 08:11:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 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 0x110193490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110109570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91a1c68d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, '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.XhTodbYg5j/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.HsA0EivxLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:11:39 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 08:11:39 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 08:11:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:11:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:39 INFO - 'HOME': '/Users/cltbld', 08:11:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:39 INFO - 'LOGNAME': 'cltbld', 08:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:39 INFO - 'MOZ_NO_REMOTE': '1', 08:11:39 INFO - 'NO_EM_RESTART': '1', 08:11:39 INFO - 'PAGER': '/bin/cat', 08:11:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:39 INFO - 'PWD': '/builds/slave/test', 08:11:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:39 INFO - 'SHELL': '/bin/bash', 08:11:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:11:39 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:11:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:39 INFO - 'USER': 'cltbld', 08:11:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:39 INFO - 'XPC_FLAGS': '0x0', 08:11:39 INFO - 'XPC_SERVICE_NAME': '0', 08:11:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:39 INFO - Cleaning up... 08:11:39 INFO - Return code: 0 08:11:39 INFO - Running post-action listener: _resource_record_post_action 08:11:39 INFO - Running post-action listener: _start_resource_monitoring 08:11:39 INFO - Starting resource monitoring. 08:11:39 INFO - [mozharness: 2016-11-25 16:11:39.719431Z] Finished create-virtualenv step (success) 08:11:39 INFO - [mozharness: 2016-11-25 16:11:39.720422Z] Running install step. 08:11:39 INFO - Running pre-action listener: _resource_record_pre_action 08:11:39 INFO - Running main action method: install 08:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:39 INFO - Reading from file tmpfile_stdout 08:11:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:40 INFO - Reading from file tmpfile_stdout 08:11:40 INFO - Output received: 08:11:40 INFO - Usage: mozinstall [options] installer 08:11:40 INFO - Options: 08:11:40 INFO - -h, --help show this help message and exit 08:11:40 INFO - -d DEST, --destination=DEST 08:11:40 INFO - Directory to install application into. [default: 08:11:40 INFO - "/builds/slave/test"] 08:11:40 INFO - --app=APP Application being installed. [default: firefox] 08:11:40 INFO - mkdir: /builds/slave/test/build/application 08:11:40 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'] 08:11:40 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 08:12:11 INFO - Reading from file tmpfile_stdout 08:12:11 INFO - Output received: 08:12:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:12:11 INFO - Running post-action listener: _resource_record_post_action 08:12:11 INFO - [mozharness: 2016-11-25 16:12:11.008029Z] Finished install step (success) 08:12:11 INFO - [mozharness: 2016-11-25 16:12:11.008199Z] Running run-tests step. 08:12:11 INFO - Running pre-action listener: _resource_record_pre_action 08:12:11 INFO - Running main action method: run_tests 08:12:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:12:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:12:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:12:11 INFO - 2016-11-25 08:12:11.023 screenresolution[1903:14531] starting screenresolution argv=screenresolution get 08:12:11 INFO - 2016-11-25 08:12:11.025 screenresolution[1903:14531] Display 0: 1600x1200x32@60 08:12:11 INFO - 2016-11-25 08:12:11.031 screenresolution[1904:14533] starting screenresolution argv=screenresolution list 08:12:11 INFO - Available Modes on Display 0 08:12:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:12:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:12:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:12:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:12:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:12:11 INFO - Intel Iris: 08:12:11 INFO - Chipset Model: Intel Iris 08:12:11 INFO - Type: GPU 08:12:11 INFO - Bus: Built-In 08:12:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:12:11 INFO - Vendor: Intel (0x8086) 08:12:11 INFO - Device ID: 0x0a2e 08:12:11 INFO - Revision ID: 0x0009 08:12:11 INFO - Displays: 08:12:11 INFO - Display: 08:12:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:12:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:12:11 INFO - Display Serial Number: 1600x1200 60 08:12:11 INFO - Main Display: Yes 08:12:11 INFO - Mirror: Off 08:12:11 INFO - Online: Yes 08:12:11 INFO - Rotation: Supported 08:12:11 INFO - Return code: 0 08:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:11 INFO - Python 2.7.3 08:12:11 INFO - Return code: 0 08:12:11 INFO - grabbing minidump binary from tooltool 08:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:11 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 0x10ffa7d30>, '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 0x10fe0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:11 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 08:12:11 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 08:12:11 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 08:12:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:11 INFO - Return code: 0 08:12:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:12:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:12:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:11 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/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 08:12:11 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/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 08:12:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XhTodbYg5j/Render', 08:12:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:11 INFO - 'HOME': '/Users/cltbld', 08:12:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:11 INFO - 'LOGNAME': 'cltbld', 08:12:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:11 INFO - 'MOZ_NO_REMOTE': '1', 08:12:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:11 INFO - 'NO_EM_RESTART': '1', 08:12:11 INFO - 'PAGER': '/bin/cat', 08:12:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:11 INFO - 'PWD': '/builds/slave/test', 08:12:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:11 INFO - 'SHELL': '/bin/bash', 08:12:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsA0EivxLB/Listeners', 08:12:11 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:12:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:11 INFO - 'USER': 'cltbld', 08:12:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:11 INFO - 'XPC_FLAGS': '0x0', 08:12:11 INFO - 'XPC_SERVICE_NAME': '0', 08:12:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:11 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/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 08:12:11 INFO - mozversion application_buildid: 20161125054319 08:12:11 INFO - mozversion application_changeset: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 08:12:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:12:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:11 INFO - mozversion application_name: Firefox 08:12:11 INFO - mozversion application_remotingname: firefox-dev 08:12:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:12:11 INFO - mozversion application_vendor: Mozilla 08:12:11 INFO - mozversion application_version: 52.0a2 08:12:11 INFO - mozversion platform_buildid: 20161125054319 08:12:11 INFO - mozversion platform_changeset: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 08:12:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:12:11 INFO - mozversion platform_version: 52.0a2 08:12:11 INFO - using testdate: 1480090331 08:12:11 INFO - actual date: 1480090331 08:12:11 INFO - starting webserver on 'localhost:51255' 08:12:11 INFO - SUITE-START | Running 2 tests 08:12:11 INFO - TEST-START | dromaeo_css 08:12:11 INFO - operating with platform_type : mac_ 08:12:11 INFO - Initialising browser for dromaeo_css test... 08:12:11 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpvw1oL8/profile http://localhost:51255/getInfo.html) 08:12:14 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 08:12:14 INFO - PROCESS | 1914 | colorDepth:24 08:12:14 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 08:12:14 INFO - PROCESS | 1914 | __metrics 08:12:14 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:12:15 INFO - TEST-INFO | 1914: exit 0 08:12:15 INFO - Browser initialized. 08:12:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:15 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpvw1oL8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:27 INFO - PROCESS | 1917 | RSS: Main: 229974016 08:12:27 INFO - PROCESS | 1917 | 08:13:17 INFO - PROCESS | 1917 | 1480090397285 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] 08:15:30 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51255/tests/dromaeo/cssquery-ext.html) 08:15:32 INFO - PROCESS | 1917 | RSS: Main: 233787392 08:15:32 INFO - PROCESS | 1917 | 08:18:35 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51255/tests/dromaeo/cssquery-ext.html (next: http://localhost:51255/tests/dromaeo/cssquery-jquery.html) 08:18:35 INFO - PROCESS | 1917 | RSS: Main: 248209408 08:18:35 INFO - PROCESS | 1917 | 08:21:37 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51255/tests/dromaeo/cssquery-mootools.html) 08:21:38 INFO - PROCESS | 1917 | RSS: Main: 250990592 08:21:38 INFO - PROCESS | 1917 | 08:24:40 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51255/tests/dromaeo/cssquery-prototype.html) 08:24:40 INFO - PROCESS | 1917 | RSS: Main: 250200064 08:24:40 INFO - PROCESS | 1917 | 08:27:43 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51255/tests/dromaeo/cssquery-yui.html) 08:27:44 INFO - PROCESS | 1917 | RSS: Main: 254238720 08:27:44 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51255/tests/dromaeo/cssquery-yui.html (next: http://localhost:51255/tests/dromaeo/cssquery-dojo.html) 08:30:46 INFO - PROCESS | 1917 | RSS: Main: 255971328 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | __start_tp_report 08:30:46 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 08:30:46 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 08:30:46 INFO - PROCESS | 1917 | |i|pagename|runs| 08:30:46 INFO - PROCESS | 1917 | |0;dojo.html;3180.650128485867;3336.9332613347747;3395.100298420917;3409.1306716787217;3422.623511413744;5796.362400135981;5802.303723553169;5832.679202643858;5840.3575606683235;5842.503387212092;4615.607673347761;4861.635377346695;4908.650121216659;5768.278965129359;5826.359100498942;5262.710550919707;5315.840524784263;5325.094733895227;5354.5716342692685;5373.785048598052;4111.506619205699;5368;5391.460853914597;5396.5952553558445;5417.295751552293;5299.039355438493;5352.625316227865;5354.598405119632;5361.892762144775;5394.083005888989;4516.164509565724;5322.33470816148;5344.732763361855;5384.057789886754;5438.211459338413;5250.81622143227;5352.063388906926;5353.625246232766;5430.402655707869;5443.700596467193;5879.911801322941;5936.881262374772;5938.940610593882;5946.286445626552;5966.791162309299;6141.670122563582;6153;6155.907661385083;6176.258848938111;6345.302016778151;6294.464970477515;6336.081268216083;6339.429451349401;6344.048392741126;6354.714037868307;5963.19496867926;5966.463018328284;5967.8209653710455;5996.340402555716;6005.879882402328;5181.766820493087;6282.717277722513;6304.432601065926;6315.621062736251;6331.335209802996;6053.909191362133;6098.054801505774;6108.1143234230785;6118;6137.723802428902;6189.535784816067;6202.069689546604;6217.782377616762;6231.4391704745885;6306.369363063657;6238.157848690459;6263.686815659199;6276.560640755195;6309.053641953744;6335.588186767845;6290.716917738713;6327.715252813542;6333.303336632966;6333.493320534439;6342.651154186564;4923.187674033744;4926.285688575136;4938.407391113017;4961.280614310905;4976.477469865612;4423.60187583119;4459.44256967879;4470.128324976598;4480.327950807405;4480.977595112004;5775.451332123442;5892.734826932799;5908.379620139824;5911.320198177179;5945.10823376497;6237.625742455467;6257.0301603250655;6313.147725057059;6337.683115844189;6340.175777148941;5822.417758224228;5839.357670656224;5863.794767183128;5891.175235467038;5904.498117660047;4624.491305956342;5403.243545903577;5434.456554344534;5434.538064264581;5455.372632147274;6209.130721698875;6339.0808332791485;6349.587276826992;6357.268914074941;6361.491080713439;6131.560175786138;6241.251049874044;6257;6316.494680425647;6324.051392291193;5640.717964101696;6090.013714000748;6295.622262664255;6361.650109243851;6381.87236255263;6270.216222972129;6288.339724328879;6289;6292.244930608356;6348.174737284124;4571.51999040096;4986.32684587576;5015.771136071686;5038.420581633012;6293.590916590407;5113.821016264413;6161.784337548164;6180.81457556274;6234.064890266496;6253.593516421418;6154.1999540059505;6165.753369865334;6246.469050130608;6272.435480806566;6297.401746834226;5976.073708575178;6020.247469066367;6103.542234332532;6180.412860778219;6210.285817130907;6113.172264937315;6125.17440701618;6168.753249869955;6201.751929922933;6212.471939884979;5895.056790913605;6144.03390914903;6147.723352449061;6152.138700582012;6172.938270617416 08:30:46 INFO - PROCESS | 1917 | |1;ext.html;435.27961224174004;493.20840051717016;503.3783277652099;515.7988384530034;539.21544153257;31593.368132637333;35583.644163558354;39506.40740388893;39638;39646;40559.391609125814;41076;41233.58766412343;41244.38133427993;41272.58727412725;9203.171714545706;9374.343795934288;9405.435673859556;9418.10527999839;9419.858702119474;9388;9429.905700943005;9465.053494650514;9487.573059212318;9505.619775209017;9505.14453699167;9534.237261019101;9539.236861051135;9548.997355277665;9571.617135314578;9465.337426380156;9528.714138575853;9535.189508891717;9551.331406801526;9551.808963820755;9336.533173341373;9433.962264150938;9439.24486041115;9440.386374885611;9466.05339466048;27174.77713502897;32461.83769081163;34563.308733825186;38040.42939355912;38532.80733596342;2821.0690472144347;2842.8010039297255;3210.4542227821325;3222.1139186723603;3791.6777073948747;25507.489850202892;28540.429191416264;28911.843526259134;29034.564481532794;29396.853015734785;3029.9848500757357;3139.5133754268127;3155.2427417419885;3166.7149956504027;3209.406259841937;429873;442361.57638423523;453360;493431.5328423371;517203;48223.75888120537;60044;60527.69736151291;60528.69735651294;60607.696961515794;54997.90004199894;58600.706996464745;63193.36806631875;63812.68093659502;63846.36153638497;15913.920430397773;16165.110918899338;16398.918005409898;16410.753838692428;16433.014019158887;12625.05312101596;12635.810462843065;12688;12700.745985080432;12743.235405875677;17716.379926702502;18457.446276611725;18472;18526.0736963154;18530.536736581693;2761.585762135696;7336.926630733625;7654.354313822555;7687.2697093776005;7714.729984450517;858.2104463893234;971.5579411367811;975.3952549419264;982.3320142303303;1007.2848277722752;28854.422911541653;29712;29868.850655747017;29910.850445747634;30377.848110759747;1053.4627340056472;1082.4629026781988;1093.8085834978847;1122.7529943412437;1141.8173092305192;13033.543825966046;15032.699346013018;15322.846771532364;15351.846481535265;15783.368665253261;604438;680081;684920;688108;688994;56282;56819.43180568224;56958;56991.715041425356;57050.42949570534;1328.4818920620964;1352.7632664283908;1361.795730640392;1364.5974437541147;1367.7196174784146;28819.279518012216;29535.55696664595;29540.556891647073;29961.700382995892;30107.54838677378;35651;44594.777026114665;44621;44708;45036.77481612571;629930;632574;634107;634932;636095;25245.242642720747;25302.493950120526;25606.359841004123;25629;25738.742612573635;45340.77329613331;46233.53766462292;46334.07331853277;46427;46607.76696116634;37753.43369849509;37875;38199.2360152801;39380.409293860044;39429.81710548688;37887;37893.24213515769;38594;38989.02527436723;39080.609193907694;36367.818160909024;36695.63304367029;36898.26203475862;36926.446103307935;37746.245075098894;24673;33146.66853331436;33768.831155845044;33821;35067;18021;22078.34412419043;24636.630450542896;25112.12107576226;25566 08:30:46 INFO - PROCESS | 1917 | |2;jquery.html;318.6526685912355;369.6691461142278;374.43086508507054;376.9057735566108;392.458407397791;13768.105073170249;15821.288042038108;17325.91337043316;17830.643387132248;19353.612927741437;19003.42989710311;19418.805811941875;19620;19725;19949.301774437896;5076.949230507685;5531.861703457425;5864.354920958691;5883.352831188566;5885;4739.5023522530155;5610.990021796075;5694.259746232984;5737.3688894221605;5779.104238842965;5688.146777983295;5697.430256974311;5698.7435565399655;5709.885802283952;5724.570657200706;5437.918431223535;5643.717814109278;5652.406497317764;5686.687232202227;5697.430256974311;4970.329005584236;5004.074246264417;5014.097462456756;5023.623228257895;5047.0915235257635;23006.88496557523;23544.411389715395;24068.03727850884;24138;24545.754542454524;2077.345636124616;2322;2551.7448255174518;2782.8052036357462;2979.6591533809656;14032.298385080705;15047.946643734944;15251.923740381339;15341.926065175443;15506.844931550653;1800.1539276540004;1817.3963562692768;1893.7538120044444;1901.3440363074717;1916.17604430095;110228.79542409188;110456.4477177617;110643;111678.44160779225;112274.43862780633;10365.429901355497;10435.32170408921;10565.683029509128;10869.347839129678;11041.613543526099;13389.598312050653;13440.865591344156;13442.529511467052;13445.462181512825;13449.193048417126;8149.103598604149;8438.57807109642;8445.915540844635;8531.573421328909;8608.526531040729;8447.408681392244;8460.238578527962;8481.194286542768;8612.311015118776;8628.050914399411;6338.714757835908;6432.903506447407;6472.967635161794;6477.578957367756;6489.383508566679;1857.925682972666;1892.0823400650672;1900.752902122715;1902.3817259390476;1905.7998910114516;851.5997481183833;862.9870551941726;918.4626993208914;993.6720882108887;1021.8927012663712;17128.571785705208;17431.12844357777;18329.541761455803;19754.40736777899;21387.78612213858;893.271983333581;918.7151982885327;938.9812203756023;943.1747221181466;952.5475399185332;10564.683059508227;10609.893901061045;10748.462576871125;10761.085307748928;10779.514921828537;595538;604667;604884;605970;606002;106604.9339506595;108937.91062089277;109312;109341.90658093477;110381.44809276063;992.5483904823288;1027.4862568715641;1048.1981284317503;1073.259450978822;1075.9408232547128;17296.308147673953;17637.382691605733;17929.103544822967;18092.90953545224;18330.541736456697;47305;48851.53445396644;50366.2445063317;51454.48545514497;51967.22049169341;66691.66654166699;69940.6502967482;70394.24014399681;71330.93003604846;71567.64216178886;4564.634829213722;5232.319798426181;5855.043203182366;11479;11503.252288601214;12089.637310880687;12171.965382942195;12458.314792686127;12570;12737.0447216461;9726.416415015121;10490.68866391701;10813.189010824377;11169.776604467703;11171.776564468828;9187.724368268962;9560.426374417557;10797.946010270212;10838.458077095956;11039;5806.216160818235;8491.72624106389;10994.505247263733;11051.778964420506;11514.078873690252;9733.56198971062;10867.945660271647;11770.823437648613;11899.643010709693;12329;6780.72877084911;6831.692573834289;7010.948357746379;7145.606991615511;11122.721931951766 08:30:46 INFO - PROCESS | 1917 | |3;mootools.html;1337.9096036730066;1451.8548145185482;1631.689978904008;1728.4900954218504;1788.4724006418098;7194.6762395692185;7700.807479813007;7980.521168729881;8759.518226497548;8765.47407155571;8227.341812654988;8577.14228577142;8591.012033616136;8664.090270521583;8693.347998900077;2303.9078436862505;2358.7995020423286;2360.2329242996093;2360.280114565057;2365.858048517086;2351.2828587280874;2377.3224630980176;2390.9760902391013;2405.0860672944254;2407.987960060206;1997.8901160436242;2338.918137865175;2344.906203751848;2356.2460012795827;2364.562555927159;2245.371296037112;2248.898799554024;2270.1146552844402;2274.6588011798112;2340.028888011473;2038.7665462395335;2285.9771402285933;2322.477442575424;2359.2214569192124;2366.372911178539;8611.56942152896;8639.39524233304;8663.133686631349;8683.609237584324;8701.956490217508;5167.534921857051;5312.707801070939;5326.573874090063;5341.252224688546;5344.038073146832;3082.7533797296387;3271.983640081808;3328.417526932777;3655.0496870813513;3656.7510980746915;996.2129917365273;1058.402002868377;1097.8682558093;1105.9051538976355;1113.8106521891216;11160.497777599947;11218.32690038592;11254.49354779037;11322.943385283103;11418.657440276806;4142.730722503088;4565.338025986213;4569.588737013618;4599.494055653875;4667.50639795269;8545.188207120314;8758.642410426393;9687.17658998993;9776.169025632758;9806.509674516246;4441.777911104432;5308.522232999048;5349.919751203735;5351.197320401893;5368.785248590091;3590.4434812603567;4384.605385515319;4387.100644367897;4442.911141777146;4900.289458028566;3917.0207448137967;3932.508436445444;3980.7213495055066;4016.116454380032;4016.397540368968;1256.3655354046148;1264.1088032936757;1295.591888555121;1305.145129939891;1317.855035946045;777.4208214879951;778.7702627724835;903.1690844423147;903.9774005649912;905.2215095018411;4766.880827979328;5634.4365563443325;5728.140778883201;5766.596338256366;5868.119782032644;901.9909800902038;921.4793641592613;960.3373672166183;968.4625033106553;995.8904520502739;3721.7766933983507;3867.61323867611;3938.547067087264;3953.7034722395933;3981.402789581586;10134.898651013396;10441.269111162297;10467.738306542398;10485.475726213812;10500.632477863239;9851.753706157404;10328.070473657257;10342.948285258526;10456.477176141163;10467.84298235527;6804.829879253059;8179.263866252066;8209.8358032839;8212.958935205286;8263.132371101068;5307.336582927134;5599.720013999366;5708.686022268815;5789.247397838254;5800.332961709458;9393.765155871159;9433.009533998831;9648.71053868357;9666.984966578408;9702.70891873245;9232.076792320715;9637.807243854942;9668.033196680275;9772.657956971472;9802.36284641496;6126.540509461719;6724.4620430364475;6973.476989225727;7252.673629686571;7431.108267007994;8068.757937261891;8205.179482051746;8243.546604936786;8277.95861020691;8297.95851020741;7217.494775365674;7270;7354.816129596589;7386.926130738839;7489.513181643176;6946.965265173844;7196.4962452627815;7204.387627051549;7225.096862892138;7233.746818861315;6697.598144111174;6831.453483721191;6838.965805170942;6846.623435710884;6862;4839.274108883696;4850.830220942391;4905.4358748742925;4928.630352723631;4984.8753781155765;4723.4331880174595;4725.338452616567;4769.475357710579;4794.904101918012;4900.705957642553 08:30:46 INFO - PROCESS | 1917 | |4;prototype.html;304.33047295948916;305.13037842149873;307.89069880192517;315.8215608181378;318.99362012759747;4633.911030907738;4701.412323459567;4729.787159577819;5297.821307215679;5425.810096646618;4437.578430049149;4470.105978804236;4883.780229889655;4944.884722624742;5197.272381866542;3524.4889491023787;4211.68412369072;4212.935661525861;4220.577942205786;4227.87316380509;3337.2824842658824;3680.9141303315587;3897.9610203897882;4205.222033923734;4221.319462141547;4059.3099173140636;4060.5127384713874;4073.5111786585653;4081.755094694313;4091.672666186713;3738.45792360109;4053.5541090480024;4076.308332042199;4087.4277601135864;4097.487814023247;3542.8937131886087;3553.8272370117797;3570.8214589270433;3587.157018100744;3588.3899737044767;5030.849074527733;5153.6907785532985;5172.215585622954;5206.557442617382;5256.634514468505;4207.969047583331;4393.6704747144095;4638.002829391663;4670.9065818683775;4704.388429504177;5609.747561359749;5708.600397972144;5724.198612194296;5742.138679198112;5802.883942321172;3688.5942546320152;3805.429185622151;3881.4177873319227;3901.804909754501;3921.666658334045;5058.418281897592;5247.827976758486;5691.174779656926;5754.079347304453;5973.6260660048;3899.3566061600086;3913.941290880639;3916.4516967624554;3919.0594257378593;3996.7402118862183;3074.4635675567747;3992.7604343739467;4005.91988160241;4026.617471340218;4041.818118184689;3724.385476396364;4285.46431696038;4697.7651117444675;4703.976480117646;4724.905501889943;4887.902241955141;5399.325084364455;5498.3127109111365;5770.451807078321;5857.765689372377;1114.643314139484;1234.2902830872285;1253.2981530342854;1292.4377895615437;1296.8314119164447;758.4463341760546;876.815868667587;881.7171016171455;887.6538150121457;890.3767362846033;4785.808567657325;5129.64092513528;5144.6913185209005;5171.844844654666;5183.3261675981885;4611.631069514431;4955.826546070943;4997.625178111656;5422.322209723785;5676.687782171937;4374.628156606724;4428.792646985376;4868.440129385166;5081.212412076134;5096.821611243588;2462.8399154055287;2538.8898599215813;2867.555528893025;2878.215506386054;2897.6233089698203;4386.363977223348;5312.317279773767;5388.434214407431;5631.577631677641;5700.942990570041;4522.615577675934;4944.53026962438;5029.968856384432;5724.74238659253;5745.454181852718;4988.700677959261;5156.793728250828;5483.616146869681;5611.6128516623685;5782.848347650456;5012.924806127984;5103.948960510347;5488.4237155098135;5534.86162845916;5559;5382.30030096085;5401.812930370943;5412.185663454903;5508.7521061553125;5537;4980.35255416808;5292.100342941632;5458.563314934875;5673.220122140204;5728.627639203605;3116.937661246717;3420.504026916133;3703.4629978653484;3723.4600982857874;3760.9281354813747;4862.562369386772;5016.344606279846;5083.38999320084;5099.5410413063;5246.449122842047;4474.37358769766;4854.2233242681;4875.7074575525585;5223.138182199895;5425.728713564385;4547.909041819211;4769.9046019080115;5080.669756465818;5338.572914166935;5388.488093631099;4814.614830813596;4935.703857768545;5079;5440.564754819684;5537.833864984057;4801.471838097877;5274.551663108678;5722.7710891563875;5728.8205046199755;5749.665194187278;4275.5724427557;4907.852764417074;5449.264349312792;5659.745311460912;5672.319321681424 08:30:46 INFO - PROCESS | 1917 | |5;yui.html;600.9633382415334;675.1729131813528;691.1180377824471;705.7776800307903;718.996405017975;13778.517751878686;14300.427982880685;14664.266786660677;14671.193084380355;14804.925975370108;12971.156874803131;13378.862796662295;13516.526921557748;13520.256385898772;13581.592552223425;671.1912145864246;818.0183779464667;824.47233770387;828.0270681948716;831.0650518167062;781.9022622172229;808.5512540539997;811.9971834784037;812.1188510466122;815.0219736316444;864.7405778266526;865.3423398217337;865.5758678247645;865.8528050231445;867.2151702709058;839.4711331860949;853.1298075962515;866.6143566113083;866.8309679612478;867.3754896474528;609.8841220168154;630.3224034163293;633.4045996763074;648.6400047973373;650.7494614573424;12256.632301030982;12661.113722039461;12663.176893501894;12676.366181690879;12766.872331276754;11348.148888833288;11389.601363952223;11495.712607184803;11498.540058397653;11626.534938602446;9930.255230857641;10070.546825392876;10089.495525223783;10330.535125919352;10449.216308776797;3312.0726196664973;3524.0837382280533;3577.749557530974;3591.6228795976567;3606.1705807664384;85548;87329.56335218283;87720.56139719325;89232;91161;8472.872906906401;8588.785280368042;8702.086280940537;8752.91247087521;8799.604017819214;18266;18354.174062167236;18379.63240735178;18381.908090459463;19204.903975480032;6404.551681382259;7418.96290518544;7616.276453736886;7669.156392796788;7755.3407960324;4019.31671615826;4105.055837157471;4118.6499147572795;4184.518780340239;4237.279662457389;3342.364950659367;3411.2836304375865;3429.3998550253605;3440.1055725511546;3444.0873168610337;618.9721462534196;634.6350848262175;639.6290151711996;641.6855740687123;644.6035688051815;575.3153747041008;577.9508741756914;659.4658326755343;667.732906837269;685.8662560800595;7377.594232317274;8232.711855085163;8924.598393072327;9018.413803102778;9199.56320773063;488.73957944506657;623.6943897490197;624.1012941364421;631.0943795653252;636.78667646339;3438.346714124308;4001.599840015975;4272.743635381887;4307.870763877088;4366.912661746747;78108.60945695236;92710;96940;99331;100473;60908;63634;84859;86211;88282.55858720666;62376;80441;82081.17918820855;84312.15687843043;86610;7415.592142432002;8258.967629046369;8491.23578877904;9172.54137293146;9367.718968430958;38449.80775096107;38840;54175;55443.72278138583;55968.44031559795;73589;76644;79238.60380698291;79402.20597794179;81365;9830.361026533252;12035.699107522032;12039.518419263131;12313.44589493457;12352.814707779571;13598.11612245201;13601.183928964294;13698.794518082435;13732.725345492834;13861.584152475441;12050.783096853082;12769.361531923552;13064.34678266102;13086.411111499814;13463.99020073518;12507.874921251036;12696.428660710106;12744.808827867775;12764.106512544033;12815.564883522036;12048.397580120783;12090.637280881587;12431.93784031074;12531.937340313605;12949.935250323688;8411.789705257417;8956.193942544942;10378.169746420117;10495.790084198426;11028.062614677843;9064.229540489132;10536.52585633633;10793.244472886823;11131.666050018512;11154.888451115385 08:30:46 INFO - PROCESS | 1917 | __end_tp_report 08:30:46 INFO - PROCESS | 1917 | __start_cc_report 08:30:46 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,372 08:30:46 INFO - PROCESS | 1917 | __end_cc_report 08:30:46 INFO - PROCESS | 1917 | __startTimestamp1480091446954__endTimestamp 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | ------- Summary: start ------- 08:30:46 INFO - PROCESS | 1917 | Number of tests: 6 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5749.58 Median:5996.34 stddev:687.41 (11.5%) stddev-sans-first:659.32 08:30:46 INFO - PROCESS | 1917 | Values: 3180.7 3336.9 3395.1 3409.1 3422.6 5796.4 5802.3 5832.7 5840.4 5842.5 4615.6 4861.6 4908.7 5768.3 5826.4 5262.7 5315.8 5325.1 5354.6 5373.8 4111.5 5368.0 5391.5 5396.6 5417.3 5299.0 5352.6 5354.6 5361.9 5394.1 4516.2 5322.3 5344.7 5384.1 5438.2 5250.8 5352.1 5353.6 5430.4 5443.7 5879.9 5936.9 5938.9 5946.3 5966.8 6141.7 6153.0 6155.9 6176.3 6345.3 6294.5 6336.1 6339.4 6344.0 6354.7 5963.2 5966.5 5967.8 5996.3 6005.9 5181.8 6282.7 6304.4 6315.6 6331.3 6053.9 6098.1 6108.1 6118.0 6137.7 6189.5 6202.1 6217.8 6231.4 6306.4 6238.2 6263.7 6276.6 6309.1 6335.6 6290.7 6327.7 6333.3 6333.5 6342.7 4923.2 4926.3 4938.4 4961.3 4976.5 4423.6 4459.4 4470.1 4480.3 4481.0 5775.5 5892.7 5908.4 5911.3 5945.1 6237.6 6257.0 6313.1 6337.7 6340.2 5822.4 5839.4 5863.8 5891.2 5904.5 4624.5 5403.2 5434.5 5434.5 5455.4 6209.1 6339.1 6349.6 6357.3 6361.5 6131.6 6241.3 6257.0 6316.5 6324.1 5640.7 6090.0 6295.6 6361.7 6381.9 6270.2 6288.3 6289.0 6292.2 6348.2 4571.5 4986.3 5015.8 5038.4 6293.6 5113.8 6161.8 6180.8 6234.1 6253.6 6154.2 6165.8 6246.5 6272.4 6297.4 5976.1 6020.2 6103.5 6180.4 6210.3 6113.2 6125.2 6168.8 6201.8 6212.5 5895.1 6144.0 6147.7 6152.1 6172.9 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:70997.58 Median:38791.51 stddev:160093.55 (412.7%) stddev-sans-first:160455.00 08:30:46 INFO - PROCESS | 1917 | Values: 435.3 493.2 503.4 515.8 539.2 31593.4 35583.6 39506.4 39638.0 39646.0 40559.4 41076.0 41233.6 41244.4 41272.6 9203.2 9374.3 9405.4 9418.1 9419.9 9388.0 9429.9 9465.1 9487.6 9505.6 9505.1 9534.2 9539.2 9549.0 9571.6 9465.3 9528.7 9535.2 9551.3 9551.8 9336.5 9434.0 9439.2 9440.4 9466.1 27174.8 32461.8 34563.3 38040.4 38532.8 2821.1 2842.8 3210.5 3222.1 3791.7 25507.5 28540.4 28911.8 29034.6 29396.9 3030.0 3139.5 3155.2 3166.7 3209.4 429873.0 442361.6 453360.0 493431.5 517203.0 48223.8 60044.0 60527.7 60528.7 60607.7 54997.9 58600.7 63193.4 63812.7 63846.4 15913.9 16165.1 16398.9 16410.8 16433.0 12625.1 12635.8 12688.0 12700.7 12743.2 17716.4 18457.4 18472.0 18526.1 18530.5 2761.6 7336.9 7654.4 7687.3 7714.7 858.2 971.6 975.4 982.3 1007.3 28854.4 29712.0 29868.9 29910.9 30377.8 1053.5 1082.5 1093.8 1122.8 1141.8 13033.5 15032.7 15322.8 15351.8 15783.4 604438.0 680081.0 684920.0 688108.0 688994.0 56282.0 56819.4 56958.0 56991.7 57050.4 1328.5 1352.8 1361.8 1364.6 1367.7 28819.3 29535.6 29540.6 29961.7 30107.5 35651.0 44594.8 44621.0 44708.0 45036.8 629930.0 632574.0 634107.0 634932.0 636095.0 25245.2 25302.5 25606.4 25629.0 25738.7 45340.8 46233.5 46334.1 46427.0 46607.8 37753.4 37875.0 38199.2 39380.4 39429.8 37887.0 37893.2 38594.0 38989.0 39080.6 36367.8 36695.6 36898.3 36926.4 37746.2 24673.0 33146.7 33768.8 33821.0 35067.0 18021.0 22078.3 24636.6 25112.1 25566.0 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:33897.13 Median:23806.22 stddev:99999.02 (420.1%) stddev-sans-first:100247.76 08:30:46 INFO - PROCESS | 1917 | Values: 318.7 369.7 374.4 376.9 392.5 13768.1 15821.3 17325.9 17830.6 19353.6 19003.4 19418.8 19620.0 19725.0 19949.3 5076.9 5531.9 5864.4 5883.4 5885.0 4739.5 5611.0 5694.3 5737.4 5779.1 5688.1 5697.4 5698.7 5709.9 5724.6 5437.9 5643.7 5652.4 5686.7 5697.4 4970.3 5004.1 5014.1 5023.6 5047.1 23006.9 23544.4 24068.0 24138.0 24545.8 2077.3 2322.0 2551.7 2782.8 2979.7 14032.3 15047.9 15251.9 15341.9 15506.8 1800.2 1817.4 1893.8 1901.3 1916.2 110228.8 110456.4 110643.0 111678.4 112274.4 10365.4 10435.3 10565.7 10869.3 11041.6 13389.6 13440.9 13442.5 13445.5 13449.2 8149.1 8438.6 8445.9 8531.6 8608.5 8447.4 8460.2 8481.2 8612.3 8628.1 6338.7 6432.9 6473.0 6477.6 6489.4 1857.9 1892.1 1900.8 1902.4 1905.8 851.6 863.0 918.5 993.7 1021.9 17128.6 17431.1 18329.5 19754.4 21387.8 893.3 918.7 939.0 943.2 952.5 10564.7 10609.9 10748.5 10761.1 10779.5 595538.0 604667.0 604884.0 605970.0 606002.0 106604.9 108937.9 109312.0 109341.9 110381.4 992.5 1027.5 1048.2 1073.3 1075.9 17296.3 17637.4 17929.1 18092.9 18330.5 47305.0 48851.5 50366.2 51454.5 51967.2 66691.7 69940.7 70394.2 71330.9 71567.6 4564.6 5232.3 5855.0 11479.0 11503.3 12089.6 12172.0 12458.3 12570.0 12737.0 9726.4 10490.7 10813.2 11169.8 11171.8 9187.7 9560.4 10797.9 10838.5 11039.0 5806.2 8491.7 10994.5 11051.8 11514.1 9733.6 10867.9 11770.8 11899.6 12329.0 6780.7 6831.7 7010.9 7145.6 11122.7 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5525.50 Median:5237.44 stddev:3072.91 (58.7%) stddev-sans-first:3065.41 08:30:46 INFO - PROCESS | 1917 | Values: 1337.9 1451.9 1631.7 1728.5 1788.5 7194.7 7700.8 7980.5 8759.5 8765.5 8227.3 8577.1 8591.0 8664.1 8693.3 2303.9 2358.8 2360.2 2360.3 2365.9 2351.3 2377.3 2391.0 2405.1 2408.0 1997.9 2338.9 2344.9 2356.2 2364.6 2245.4 2248.9 2270.1 2274.7 2340.0 2038.8 2286.0 2322.5 2359.2 2366.4 8611.6 8639.4 8663.1 8683.6 8702.0 5167.5 5312.7 5326.6 5341.3 5344.0 3082.8 3272.0 3328.4 3655.0 3656.8 996.2 1058.4 1097.9 1105.9 1113.8 11160.5 11218.3 11254.5 11322.9 11418.7 4142.7 4565.3 4569.6 4599.5 4667.5 8545.2 8758.6 9687.2 9776.2 9806.5 4441.8 5308.5 5349.9 5351.2 5368.8 3590.4 4384.6 4387.1 4442.9 4900.3 3917.0 3932.5 3980.7 4016.1 4016.4 1256.4 1264.1 1295.6 1305.1 1317.9 777.4 778.8 903.2 904.0 905.2 4766.9 5634.4 5728.1 5766.6 5868.1 902.0 921.5 960.3 968.5 995.9 3721.8 3867.6 3938.5 3953.7 3981.4 10134.9 10441.3 10467.7 10485.5 10500.6 9851.8 10328.1 10342.9 10456.5 10467.8 6804.8 8179.3 8209.8 8213.0 8263.1 5307.3 5599.7 5708.7 5789.2 5800.3 9393.8 9433.0 9648.7 9667.0 9702.7 9232.1 9637.8 9668.0 9772.7 9802.4 6126.5 6724.5 6973.5 7252.7 7431.1 8068.8 8205.2 8243.5 8278.0 8298.0 7217.5 7270.0 7354.8 7386.9 7489.5 6947.0 7196.5 7204.4 7225.1 7233.7 6697.6 6831.5 6839.0 6846.6 6862.0 4839.3 4850.8 4905.4 4928.6 4984.9 4723.4 4725.3 4769.5 4794.9 4900.7 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4400.94 Median:4879.74 stddev:1327.39 (27.2%) stddev-sans-first:1295.01 08:30:46 INFO - PROCESS | 1917 | Values: 304.3 305.1 307.9 315.8 319.0 4633.9 4701.4 4729.8 5297.8 5425.8 4437.6 4470.1 4883.8 4944.9 5197.3 3524.5 4211.7 4212.9 4220.6 4227.9 3337.3 3680.9 3898.0 4205.2 4221.3 4059.3 4060.5 4073.5 4081.8 4091.7 3738.5 4053.6 4076.3 4087.4 4097.5 3542.9 3553.8 3570.8 3587.2 3588.4 5030.8 5153.7 5172.2 5206.6 5256.6 4208.0 4393.7 4638.0 4670.9 4704.4 5609.7 5708.6 5724.2 5742.1 5802.9 3688.6 3805.4 3881.4 3901.8 3921.7 5058.4 5247.8 5691.2 5754.1 5973.6 3899.4 3913.9 3916.5 3919.1 3996.7 3074.5 3992.8 4005.9 4026.6 4041.8 3724.4 4285.5 4697.8 4704.0 4724.9 4887.9 5399.3 5498.3 5770.5 5857.8 1114.6 1234.3 1253.3 1292.4 1296.8 758.4 876.8 881.7 887.7 890.4 4785.8 5129.6 5144.7 5171.8 5183.3 4611.6 4955.8 4997.6 5422.3 5676.7 4374.6 4428.8 4868.4 5081.2 5096.8 2462.8 2538.9 2867.6 2878.2 2897.6 4386.4 5312.3 5388.4 5631.6 5700.9 4522.6 4944.5 5030.0 5724.7 5745.5 4988.7 5156.8 5483.6 5611.6 5782.8 5012.9 5103.9 5488.4 5534.9 5559.0 5382.3 5401.8 5412.2 5508.8 5537.0 4980.4 5292.1 5458.6 5673.2 5728.6 3116.9 3420.5 3703.5 3723.5 3760.9 4862.6 5016.3 5083.4 5099.5 5246.4 4474.4 4854.2 4875.7 5223.1 5425.7 4547.9 4769.9 5080.7 5338.6 5388.5 4814.6 4935.7 5079.0 5440.6 5537.8 4801.5 5274.6 5722.8 5728.8 5749.7 4275.6 4907.9 5449.3 5659.7 5672.3 08:30:46 INFO - PROCESS | 1917 | 08:30:46 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:18985.30 Median:30758.94 stddev:27464.02 (89.3%) stddev-sans-first:27506.37 08:30:46 INFO - PROCESS | 1917 | Values: 601.0 675.2 691.1 705.8 719.0 13778.5 14300.4 14664.3 14671.2 14804.9 12971.2 13378.9 13516.5 13520.3 13581.6 671.2 818.0 824.5 828.0 831.1 781.9 808.6 812.0 812.1 815.0 864.7 865.3 865.6 865.9 867.2 839.5 853.1 866.6 866.8 867.4 609.9 630.3 633.4 648.6 650.7 12256.6 12661.1 12663.2 12676.4 12766.9 11348.1 11389.6 11495.7 11498.5 11626.5 9930.3 10070.5 10089.5 10330.5 10449.2 3312.1 3524.1 3577.7 3591.6 3606.2 85548.0 87329.6 87720.6 89232.0 91161.0 8472.9 8588.8 8702.1 8752.9 8799.6 18266.0 18354.2 18379.6 18381.9 19204.9 6404.6 7419.0 7616.3 7669.2 7755.3 4019.3 4105.1 4118.6 4184.5 4237.3 3342.4 3411.3 3429.4 3440.1 3444.1 619.0 634.6 639.6 641.7 644.6 575.3 578.0 659.5 667.7 685.9 7377.6 8232.7 8924.6 9018.4 9199.6 488.7 623.7 624.1 631.1 636.8 3438.3 4001.6 4272.7 4307.9 4366.9 78108.6 92710.0 96940.0 99331.0 100473.0 60908.0 63634.0 84859.0 86211.0 88282.6 62376.0 80441.0 82081.2 84312.2 86610.0 7415.6 8259.0 8491.2 9172.5 9367.7 38449.8 38840.0 54175.0 55443.7 55968.4 73589.0 76644.0 79238.6 79402.2 81365.0 9830.4 12035.7 12039.5 12313.4 12352.8 13598.1 13601.2 13698.8 13732.7 13861.6 12050.8 12769.4 13064.3 13086.4 13464.0 12507.9 12696.4 12744.8 12764.1 12815.6 12048.4 12090.6 12431.9 12531.9 12949.9 8411.8 8956.2 10378.2 10495.8 11028.1 9064.2 10536.5 10793.2 11131.7 11154.9 08:30:46 INFO - PROCESS | 1917 | -------- Summary: end -------- 08:30:46 INFO - PROCESS | 1917 | 08:30:47 INFO - TEST-INFO | 1917: exit 0 08:30:47 INFO - TEST-OK | dromaeo_css | took 1115988ms 08:30:47 INFO - TEST-START | kraken 08:30:47 INFO - operating with platform_type : mac_ 08:30:47 INFO - Initialising browser for kraken test... 08:30:47 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpYm6EFb/profile http://localhost:51255/getInfo.html) 08:30:50 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 08:30:50 INFO - PROCESS | 1922 | colorDepth:24 08:30:50 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 08:30:50 INFO - PROCESS | 1922 | __metrics 08:30:50 ERROR - PROCESS | 1922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:30:51 INFO - TEST-INFO | 1922: exit 0 08:30:51 INFO - Browser initialized. 08:30:51 INFO - Running cycle 1/1 for kraken test... 08:30:51 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpYm6EFb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:03 INFO - PROCESS | 1924 | RSS: Main: 230060032 08:31:03 INFO - PROCESS | 1924 | 08:31:06 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51255/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:07 INFO - PROCESS | 1924 | RSS: Main: 241831936 08:31:07 INFO - PROCESS | 1924 | 08:31:09 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51255/tests/kraken/driver.html?testName=audio-dft) 08:31:10 INFO - PROCESS | 1924 | RSS: Main: 249454592 08:31:10 INFO - PROCESS | 1924 | 08:31:13 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51255/tests/kraken/driver.html?testName=audio-fft) 08:31:14 INFO - PROCESS | 1924 | RSS: Main: 253046784 08:31:14 INFO - PROCESS | 1924 | 08:31:16 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51255/tests/kraken/driver.html?testName=audio-oscillator) 08:31:17 INFO - PROCESS | 1924 | RSS: Main: 254382080 08:31:17 INFO - PROCESS | 1924 | 08:31:19 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:19 INFO - PROCESS | 1924 | RSS: Main: 254685184 08:31:19 INFO - PROCESS | 1924 | 08:31:22 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51255/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:23 INFO - PROCESS | 1924 | RSS: Main: 258613248 08:31:23 INFO - PROCESS | 1924 | 08:31:26 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51255/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:26 INFO - PROCESS | 1924 | RSS: Main: 258686976 08:31:26 INFO - PROCESS | 1924 | 08:31:29 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51255/tests/kraken/driver.html?testName=json-parse-financial) 08:31:30 INFO - PROCESS | 1924 | RSS: Main: 258203648 08:31:30 INFO - PROCESS | 1924 | 08:31:31 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:32 INFO - PROCESS | 1924 | RSS: Main: 257097728 08:31:32 INFO - PROCESS | 1924 | 08:31:34 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:35 INFO - PROCESS | 1924 | RSS: Main: 257224704 08:31:35 INFO - PROCESS | 1924 | 08:31:37 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:37 INFO - PROCESS | 1924 | RSS: Main: 257200128 08:31:37 INFO - PROCESS | 1924 | 08:31:40 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:41 INFO - PROCESS | 1924 | RSS: Main: 257351680 08:31:41 INFO - PROCESS | 1924 | 08:31:44 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:45 INFO - PROCESS | 1924 | RSS: Main: 257531904 08:31:45 INFO - PROCESS | 1924 | 08:31:46 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51255/tests/kraken/driver.html?testName=ai-astar) 08:31:47 INFO - PROCESS | 1924 | RSS: Main: 259047424 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | __start_tp_report 08:31:47 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 08:31:47 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 08:31:47 INFO - PROCESS | 1924 | |i|pagename|runs| 08:31:47 INFO - PROCESS | 1924 | |0;ai-astar;107;121;121;118;117;119;119;118;118;118 08:31:47 INFO - PROCESS | 1924 | |1;audio-beat-detection;152;114;116;146;116;116;116;122;177;117 08:31:47 INFO - PROCESS | 1924 | |2;audio-dft;197;231;212;207;196;200;200;195;198;201 08:31:47 INFO - PROCESS | 1924 | |3;audio-fft;87;62;59;79;50;60;73;74;109;82 08:31:47 INFO - PROCESS | 1924 | |4;audio-oscillator;88;79;121;103;79;71;86;71;70;88 08:31:47 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;89;87;89;86;90;85;101;88;88;87 08:31:47 INFO - PROCESS | 1924 | |6;imaging-darkroom;96;110;153;123;96;95;96;94;96;95 08:31:47 INFO - PROCESS | 1924 | |7;imaging-desaturate;87;93;86;86;118;115;90;116;136;89 08:31:47 INFO - PROCESS | 1924 | |8;json-parse-financial;56;56;54;57;55;59;58;60;65;59 08:31:47 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;75;70;68;79;75;70;71;70;71;73 08:31:47 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;87;86;86;84;88;89;86;87;85;91 08:31:47 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;157;156;136;150;151;152;154;173;197;164 08:31:47 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;171;167;170;170;172;170;170;171;172;168 08:31:47 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;68;70;68;66;68;68;68;65;69;68 08:31:47 INFO - PROCESS | 1924 | __end_tp_report 08:31:47 INFO - PROCESS | 1924 | __start_cc_report 08:31:47 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,998 08:31:47 INFO - PROCESS | 1924 | __end_cc_report 08:31:47 INFO - PROCESS | 1924 | __startTimestamp1480091507066__endTimestamp 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | ------- Summary: start ------- 08:31:47 INFO - PROCESS | 1924 | Number of tests: 14 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:117.60 Median:118.50 stddev:3.95 (3.3%) stddev-sans-first:1.39 08:31:47 INFO - PROCESS | 1924 | Values: 107.0 121.0 121.0 118.0 117.0 119.0 119.0 118.0 118.0 118.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:119.50 stddev:21.64 (18.1%) stddev-sans-first:21.32 08:31:47 INFO - PROCESS | 1924 | Values: 152.0 114.0 116.0 146.0 116.0 116.0 116.0 122.0 177.0 117.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:203.70 Median:200.50 stddev:10.91 (5.4%) stddev-sans-first:11.30 08:31:47 INFO - PROCESS | 1924 | Values: 197.0 231.0 212.0 207.0 196.0 200.0 200.0 195.0 198.0 201.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:73.50 Median:73.50 stddev:17.07 (23.2%) stddev-sans-first:17.39 08:31:47 INFO - PROCESS | 1924 | Values: 87.0 62.0 59.0 79.0 50.0 60.0 73.0 74.0 109.0 82.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:79.00 stddev:16.07 (20.3%) stddev-sans-first:17.02 08:31:47 INFO - PROCESS | 1924 | Values: 88.0 79.0 121.0 103.0 79.0 71.0 86.0 71.0 70.0 88.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:88.00 stddev:4.47 (5.1%) stddev-sans-first:4.74 08:31:47 INFO - PROCESS | 1924 | Values: 89.0 87.0 89.0 86.0 90.0 85.0 101.0 88.0 88.0 87.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:105.40 Median:95.50 stddev:19.14 (20.0%) stddev-sans-first:19.99 08:31:47 INFO - PROCESS | 1924 | Values: 96.0 110.0 153.0 123.0 96.0 95.0 96.0 94.0 96.0 95.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:86.50 stddev:17.97 (20.8%) stddev-sans-first:18.27 08:31:47 INFO - PROCESS | 1924 | Values: 87.0 93.0 86.0 86.0 118.0 115.0 90.0 116.0 136.0 89.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:3.14 (5.4%) stddev-sans-first:3.26 08:31:47 INFO - PROCESS | 1924 | Values: 56.0 56.0 54.0 57.0 55.0 59.0 58.0 60.0 65.0 59.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.29 (4.6%) stddev-sans-first:3.33 08:31:47 INFO - PROCESS | 1924 | Values: 75.0 70.0 68.0 79.0 75.0 70.0 71.0 70.0 71.0 73.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:2.02 (2.3%) stddev-sans-first:2.15 08:31:47 INFO - PROCESS | 1924 | Values: 87.0 86.0 86.0 84.0 88.0 89.0 86.0 87.0 85.0 91.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:156.50 stddev:16.42 (10.5%) stddev-sans-first:17.40 08:31:47 INFO - PROCESS | 1924 | Values: 157.0 156.0 136.0 150.0 151.0 152.0 154.0 173.0 197.0 164.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:1.60 (0.9%) stddev-sans-first:1.66 08:31:47 INFO - PROCESS | 1924 | Values: 171.0 167.0 170.0 170.0 172.0 170.0 170.0 171.0 172.0 168.0 08:31:47 INFO - PROCESS | 1924 | 08:31:47 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 08:31:47 INFO - PROCESS | 1924 | Values: 68.0 70.0 68.0 66.0 68.0 68.0 68.0 65.0 69.0 68.0 08:31:47 INFO - PROCESS | 1924 | -------- Summary: end -------- 08:31:47 INFO - PROCESS | 1924 | 08:31:48 INFO - TEST-INFO | 1924: exit 0 08:31:48 INFO - TEST-OK | kraken | took 60667ms 08:31:48 INFO - SUITE-END | took 1176s 08:31:48 INFO - Completed test suite (00:19:37) 08:31:48 INFO - javascript benchmark 08:31:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7088.794226115343, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3180.650128485867, 3336.9332613347747, 3395.100298420917, 3409.1306716787217, 3422.623511413744, 5796.362400135981, 5802.303723553169, 5832.679202643858, 5840.3575606683235, 5842.503387212092, 4615.607673347761, 4861.635377346695, 4908.650121216659, 5768.278965129359, 5826.359100498942, 5262.710550919707, 5315.840524784263, 5325.094733895227, 5354.5716342692685, 5373.785048598052, 4111.506619205699, 5368.0, 5391.460853914597, 5396.5952553558445, 5417.295751552293, 5299.039355438493, 5352.625316227865, 5354.598405119632, 5361.892762144775, 5394.083005888989, 4516.164509565724, 5322.33470816148, 5344.732763361855, 5384.057789886754, 5438.211459338413, 5250.81622143227, 5352.063388906926, 5353.625246232766, 5430.402655707869, 5443.700596467193, 5879.911801322941, 5936.881262374772, 5938.940610593882, 5946.286445626552, 5966.791162309299, 6141.670122563582, 6153.0, 6155.907661385083, 6176.258848938111, 6345.302016778151, 6294.464970477515, 6336.081268216083, 6339.429451349401, 6344.048392741126, 6354.714037868307, 5963.19496867926, 5966.463018328284, 5967.8209653710455, 5996.340402555716, 6005.879882402328, 5181.766820493087, 6282.717277722513, 6304.432601065926, 6315.621062736251, 6331.335209802996, 6053.909191362133, 6098.054801505774, 6108.1143234230785, 6118.0, 6137.723802428902, 6189.535784816067, 6202.069689546604, 6217.782377616762, 6231.4391704745885, 6306.369363063657, 6238.157848690459, 6263.686815659199, 6276.560640755195, 6309.053641953744, 6335.588186767845, 6290.716917738713, 6327.715252813542, 6333.303336632966, 6333.493320534439, 6342.651154186564, 4923.187674033744, 4926.285688575136, 4938.407391113017, 4961.280614310905, 4976.477469865612, 4423.60187583119, 4459.44256967879, 4470.128324976598, 4480.327950807405, 4480.977595112004, 5775.451332123442, 5892.734826932799, 5908.379620139824, 5911.320198177179, 5945.10823376497, 6237.625742455467, 6257.0301603250655, 6313.147725057059, 6337.683115844189, 6340.175777148941, 5822.417758224228, 5839.357670656224, 5863.794767183128, 5891.175235467038, 5904.498117660047, 4624.491305956342, 5403.243545903577, 5434.456554344534, 5434.538064264581, 5455.372632147274, 6209.130721698875, 6339.0808332791485, 6349.587276826992, 6357.268914074941, 6361.491080713439, 6131.560175786138, 6241.251049874044, 6257.0, 6316.494680425647, 6324.051392291193, 5640.717964101696, 6090.013714000748, 6295.622262664255, 6361.650109243851, 6381.87236255263, 6270.216222972129, 6288.339724328879, 6289.0, 6292.244930608356, 6348.174737284124, 4571.51999040096, 4986.32684587576, 5015.771136071686, 5038.420581633012, 6293.590916590407, 5113.821016264413, 6161.784337548164, 6180.81457556274, 6234.064890266496, 6253.593516421418, 6154.1999540059505, 6165.753369865334, 6246.469050130608, 6272.435480806566, 6297.401746834226, 5976.073708575178, 6020.247469066367, 6103.542234332532, 6180.412860778219, 6210.285817130907, 6113.172264937315, 6125.17440701618, 6168.753249869955, 6201.751929922933, 6212.471939884979, 5895.056790913605, 6144.03390914903, 6147.723352449061, 6152.138700582012, 6172.938270617416], "value": 5706.1486760435055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.27961224174004, 493.20840051717016, 503.3783277652099, 515.7988384530034, 539.21544153257, 31593.368132637333, 35583.644163558354, 39506.40740388893, 39638.0, 39646.0, 40559.391609125814, 41076.0, 41233.58766412343, 41244.38133427993, 41272.58727412725, 9203.171714545706, 9374.343795934288, 9405.435673859556, 9418.10527999839, 9419.858702119474, 9388.0, 9429.905700943005, 9465.053494650514, 9487.573059212318, 9505.619775209017, 9505.14453699167, 9534.237261019101, 9539.236861051135, 9548.997355277665, 9571.617135314578, 9465.337426380156, 9528.714138575853, 9535.189508891717, 9551.331406801526, 9551.808963820755, 9336.533173341373, 9433.962264150938, 9439.24486041115, 9440.386374885611, 9466.05339466048, 27174.77713502897, 32461.83769081163, 34563.308733825186, 38040.42939355912, 38532.80733596342, 2821.0690472144347, 2842.8010039297255, 3210.4542227821325, 3222.1139186723603, 3791.6777073948747, 25507.489850202892, 28540.429191416264, 28911.843526259134, 29034.564481532794, 29396.853015734785, 3029.9848500757357, 3139.5133754268127, 3155.2427417419885, 3166.7149956504027, 3209.406259841937, 429873.0, 442361.57638423523, 453360.0, 493431.5328423371, 517203.0, 48223.75888120537, 60044.0, 60527.69736151291, 60528.69735651294, 60607.696961515794, 54997.90004199894, 58600.706996464745, 63193.36806631875, 63812.68093659502, 63846.36153638497, 15913.920430397773, 16165.110918899338, 16398.918005409898, 16410.753838692428, 16433.014019158887, 12625.05312101596, 12635.810462843065, 12688.0, 12700.745985080432, 12743.235405875677, 17716.379926702502, 18457.446276611725, 18472.0, 18526.0736963154, 18530.536736581693, 2761.585762135696, 7336.926630733625, 7654.354313822555, 7687.2697093776005, 7714.729984450517, 858.2104463893234, 971.5579411367811, 975.3952549419264, 982.3320142303303, 1007.2848277722752, 28854.422911541653, 29712.0, 29868.850655747017, 29910.850445747634, 30377.848110759747, 1053.4627340056472, 1082.4629026781988, 1093.8085834978847, 1122.7529943412437, 1141.8173092305192, 13033.543825966046, 15032.699346013018, 15322.846771532364, 15351.846481535265, 15783.368665253261, 604438.0, 680081.0, 684920.0, 688108.0, 688994.0, 56282.0, 56819.43180568224, 56958.0, 56991.715041425356, 57050.42949570534, 1328.4818920620964, 1352.7632664283908, 1361.795730640392, 1364.5974437541147, 1367.7196174784146, 28819.279518012216, 29535.55696664595, 29540.556891647073, 29961.700382995892, 30107.54838677378, 35651.0, 44594.777026114665, 44621.0, 44708.0, 45036.77481612571, 629930.0, 632574.0, 634107.0, 634932.0, 636095.0, 25245.242642720747, 25302.493950120526, 25606.359841004123, 25629.0, 25738.742612573635, 45340.77329613331, 46233.53766462292, 46334.07331853277, 46427.0, 46607.76696116634, 37753.43369849509, 37875.0, 38199.2360152801, 39380.409293860044, 39429.81710548688, 37887.0, 37893.24213515769, 38594.0, 38989.02527436723, 39080.609193907694, 36367.818160909024, 36695.63304367029, 36898.26203475862, 36926.446103307935, 37746.245075098894, 24673.0, 33146.66853331436, 33768.831155845044, 33821.0, 35067.0, 18021.0, 22078.34412419043, 24636.630450542896, 25112.12107576226, 25566.0], "value": 19361.62012903525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6526685912355, 369.6691461142278, 374.43086508507054, 376.9057735566108, 392.458407397791, 13768.105073170249, 15821.288042038108, 17325.91337043316, 17830.643387132248, 19353.612927741437, 19003.42989710311, 19418.805811941875, 19620.0, 19725.0, 19949.301774437896, 5076.949230507685, 5531.861703457425, 5864.354920958691, 5883.352831188566, 5885.0, 4739.5023522530155, 5610.990021796075, 5694.259746232984, 5737.3688894221605, 5779.104238842965, 5688.146777983295, 5697.430256974311, 5698.7435565399655, 5709.885802283952, 5724.570657200706, 5437.918431223535, 5643.717814109278, 5652.406497317764, 5686.687232202227, 5697.430256974311, 4970.329005584236, 5004.074246264417, 5014.097462456756, 5023.623228257895, 5047.0915235257635, 23006.88496557523, 23544.411389715395, 24068.03727850884, 24138.0, 24545.754542454524, 2077.345636124616, 2322.0, 2551.7448255174518, 2782.8052036357462, 2979.6591533809656, 14032.298385080705, 15047.946643734944, 15251.923740381339, 15341.926065175443, 15506.844931550653, 1800.1539276540004, 1817.3963562692768, 1893.7538120044444, 1901.3440363074717, 1916.17604430095, 110228.79542409188, 110456.4477177617, 110643.0, 111678.44160779225, 112274.43862780633, 10365.429901355497, 10435.32170408921, 10565.683029509128, 10869.347839129678, 11041.613543526099, 13389.598312050653, 13440.865591344156, 13442.529511467052, 13445.462181512825, 13449.193048417126, 8149.103598604149, 8438.57807109642, 8445.915540844635, 8531.573421328909, 8608.526531040729, 8447.408681392244, 8460.238578527962, 8481.194286542768, 8612.311015118776, 8628.050914399411, 6338.714757835908, 6432.903506447407, 6472.967635161794, 6477.578957367756, 6489.383508566679, 1857.925682972666, 1892.0823400650672, 1900.752902122715, 1902.3817259390476, 1905.7998910114516, 851.5997481183833, 862.9870551941726, 918.4626993208914, 993.6720882108887, 1021.8927012663712, 17128.571785705208, 17431.12844357777, 18329.541761455803, 19754.40736777899, 21387.78612213858, 893.271983333581, 918.7151982885327, 938.9812203756023, 943.1747221181466, 952.5475399185332, 10564.683059508227, 10609.893901061045, 10748.462576871125, 10761.085307748928, 10779.514921828537, 595538.0, 604667.0, 604884.0, 605970.0, 606002.0, 106604.9339506595, 108937.91062089277, 109312.0, 109341.90658093477, 110381.44809276063, 992.5483904823288, 1027.4862568715641, 1048.1981284317503, 1073.259450978822, 1075.9408232547128, 17296.308147673953, 17637.382691605733, 17929.103544822967, 18092.90953545224, 18330.541736456697, 47305.0, 48851.53445396644, 50366.2445063317, 51454.48545514497, 51967.22049169341, 66691.66654166699, 69940.6502967482, 70394.24014399681, 71330.93003604846, 71567.64216178886, 4564.634829213722, 5232.319798426181, 5855.043203182366, 11479.0, 11503.252288601214, 12089.637310880687, 12171.965382942195, 12458.314792686127, 12570.0, 12737.0447216461, 9726.416415015121, 10490.68866391701, 10813.189010824377, 11169.776604467703, 11171.776564468828, 9187.724368268962, 9560.426374417557, 10797.946010270212, 10838.458077095956, 11039.0, 5806.216160818235, 8491.72624106389, 10994.505247263733, 11051.778964420506, 11514.078873690252, 9733.56198971062, 10867.945660271647, 11770.823437648613, 11899.643010709693, 12329.0, 6780.72877084911, 6831.692573834289, 7010.948357746379, 7145.606991615511, 11122.721931951766], "value": 9366.967420816687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.9096036730066, 1451.8548145185482, 1631.689978904008, 1728.4900954218504, 1788.4724006418098, 7194.6762395692185, 7700.807479813007, 7980.521168729881, 8759.518226497548, 8765.47407155571, 8227.341812654988, 8577.14228577142, 8591.012033616136, 8664.090270521583, 8693.347998900077, 2303.9078436862505, 2358.7995020423286, 2360.2329242996093, 2360.280114565057, 2365.858048517086, 2351.2828587280874, 2377.3224630980176, 2390.9760902391013, 2405.0860672944254, 2407.987960060206, 1997.8901160436242, 2338.918137865175, 2344.906203751848, 2356.2460012795827, 2364.562555927159, 2245.371296037112, 2248.898799554024, 2270.1146552844402, 2274.6588011798112, 2340.028888011473, 2038.7665462395335, 2285.9771402285933, 2322.477442575424, 2359.2214569192124, 2366.372911178539, 8611.56942152896, 8639.39524233304, 8663.133686631349, 8683.609237584324, 8701.956490217508, 5167.534921857051, 5312.707801070939, 5326.573874090063, 5341.252224688546, 5344.038073146832, 3082.7533797296387, 3271.983640081808, 3328.417526932777, 3655.0496870813513, 3656.7510980746915, 996.2129917365273, 1058.402002868377, 1097.8682558093, 1105.9051538976355, 1113.8106521891216, 11160.497777599947, 11218.32690038592, 11254.49354779037, 11322.943385283103, 11418.657440276806, 4142.730722503088, 4565.338025986213, 4569.588737013618, 4599.494055653875, 4667.50639795269, 8545.188207120314, 8758.642410426393, 9687.17658998993, 9776.169025632758, 9806.509674516246, 4441.777911104432, 5308.522232999048, 5349.919751203735, 5351.197320401893, 5368.785248590091, 3590.4434812603567, 4384.605385515319, 4387.100644367897, 4442.911141777146, 4900.289458028566, 3917.0207448137967, 3932.508436445444, 3980.7213495055066, 4016.116454380032, 4016.397540368968, 1256.3655354046148, 1264.1088032936757, 1295.591888555121, 1305.145129939891, 1317.855035946045, 777.4208214879951, 778.7702627724835, 903.1690844423147, 903.9774005649912, 905.2215095018411, 4766.880827979328, 5634.4365563443325, 5728.140778883201, 5766.596338256366, 5868.119782032644, 901.9909800902038, 921.4793641592613, 960.3373672166183, 968.4625033106553, 995.8904520502739, 3721.7766933983507, 3867.61323867611, 3938.547067087264, 3953.7034722395933, 3981.402789581586, 10134.898651013396, 10441.269111162297, 10467.738306542398, 10485.475726213812, 10500.632477863239, 9851.753706157404, 10328.070473657257, 10342.948285258526, 10456.477176141163, 10467.84298235527, 6804.829879253059, 8179.263866252066, 8209.8358032839, 8212.958935205286, 8263.132371101068, 5307.336582927134, 5599.720013999366, 5708.686022268815, 5789.247397838254, 5800.332961709458, 9393.765155871159, 9433.009533998831, 9648.71053868357, 9666.984966578408, 9702.70891873245, 9232.076792320715, 9637.807243854942, 9668.033196680275, 9772.657956971472, 9802.36284641496, 6126.540509461719, 6724.4620430364475, 6973.476989225727, 7252.673629686571, 7431.108267007994, 8068.757937261891, 8205.179482051746, 8243.546604936786, 8277.95861020691, 8297.95851020741, 7217.494775365674, 7270.0, 7354.816129596589, 7386.926130738839, 7489.513181643176, 6946.965265173844, 7196.4962452627815, 7204.387627051549, 7225.096862892138, 7233.746818861315, 6697.598144111174, 6831.453483721191, 6838.965805170942, 6846.623435710884, 6862.0, 4839.274108883696, 4850.830220942391, 4905.4358748742925, 4928.630352723631, 4984.8753781155765, 4723.4331880174595, 4725.338452616567, 4769.475357710579, 4794.904101918012, 4900.705957642553], "value": 4463.363630176852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.33047295948916, 305.13037842149873, 307.89069880192517, 315.8215608181378, 318.99362012759747, 4633.911030907738, 4701.412323459567, 4729.787159577819, 5297.821307215679, 5425.810096646618, 4437.578430049149, 4470.105978804236, 4883.780229889655, 4944.884722624742, 5197.272381866542, 3524.4889491023787, 4211.68412369072, 4212.935661525861, 4220.577942205786, 4227.87316380509, 3337.2824842658824, 3680.9141303315587, 3897.9610203897882, 4205.222033923734, 4221.319462141547, 4059.3099173140636, 4060.5127384713874, 4073.5111786585653, 4081.755094694313, 4091.672666186713, 3738.45792360109, 4053.5541090480024, 4076.308332042199, 4087.4277601135864, 4097.487814023247, 3542.8937131886087, 3553.8272370117797, 3570.8214589270433, 3587.157018100744, 3588.3899737044767, 5030.849074527733, 5153.6907785532985, 5172.215585622954, 5206.557442617382, 5256.634514468505, 4207.969047583331, 4393.6704747144095, 4638.002829391663, 4670.9065818683775, 4704.388429504177, 5609.747561359749, 5708.600397972144, 5724.198612194296, 5742.138679198112, 5802.883942321172, 3688.5942546320152, 3805.429185622151, 3881.4177873319227, 3901.804909754501, 3921.666658334045, 5058.418281897592, 5247.827976758486, 5691.174779656926, 5754.079347304453, 5973.6260660048, 3899.3566061600086, 3913.941290880639, 3916.4516967624554, 3919.0594257378593, 3996.7402118862183, 3074.4635675567747, 3992.7604343739467, 4005.91988160241, 4026.617471340218, 4041.818118184689, 3724.385476396364, 4285.46431696038, 4697.7651117444675, 4703.976480117646, 4724.905501889943, 4887.902241955141, 5399.325084364455, 5498.3127109111365, 5770.451807078321, 5857.765689372377, 1114.643314139484, 1234.2902830872285, 1253.2981530342854, 1292.4377895615437, 1296.8314119164447, 758.4463341760546, 876.815868667587, 881.7171016171455, 887.6538150121457, 890.3767362846033, 4785.808567657325, 5129.64092513528, 5144.6913185209005, 5171.844844654666, 5183.3261675981885, 4611.631069514431, 4955.826546070943, 4997.625178111656, 5422.322209723785, 5676.687782171937, 4374.628156606724, 4428.792646985376, 4868.440129385166, 5081.212412076134, 5096.821611243588, 2462.8399154055287, 2538.8898599215813, 2867.555528893025, 2878.215506386054, 2897.6233089698203, 4386.363977223348, 5312.317279773767, 5388.434214407431, 5631.577631677641, 5700.942990570041, 4522.615577675934, 4944.53026962438, 5029.968856384432, 5724.74238659253, 5745.454181852718, 4988.700677959261, 5156.793728250828, 5483.616146869681, 5611.6128516623685, 5782.848347650456, 5012.924806127984, 5103.948960510347, 5488.4237155098135, 5534.86162845916, 5559.0, 5382.30030096085, 5401.812930370943, 5412.185663454903, 5508.7521061553125, 5537.0, 4980.35255416808, 5292.100342941632, 5458.563314934875, 5673.220122140204, 5728.627639203605, 3116.937661246717, 3420.504026916133, 3703.4629978653484, 3723.4600982857874, 3760.9281354813747, 4862.562369386772, 5016.344606279846, 5083.38999320084, 5099.5410413063, 5246.449122842047, 4474.37358769766, 4854.2233242681, 4875.7074575525585, 5223.138182199895, 5425.728713564385, 4547.909041819211, 4769.9046019080115, 5080.669756465818, 5338.572914166935, 5388.488093631099, 4814.614830813596, 4935.703857768545, 5079.0, 5440.564754819684, 5537.833864984057, 4801.471838097877, 5274.551663108678, 5722.7710891563875, 5728.8205046199755, 5749.665194187278, 4275.5724427557, 4907.852764417074, 5449.264349312792, 5659.745311460912, 5672.319321681424], "value": 3979.202353128426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9633382415334, 675.1729131813528, 691.1180377824471, 705.7776800307903, 718.996405017975, 13778.517751878686, 14300.427982880685, 14664.266786660677, 14671.193084380355, 14804.925975370108, 12971.156874803131, 13378.862796662295, 13516.526921557748, 13520.256385898772, 13581.592552223425, 671.1912145864246, 818.0183779464667, 824.47233770387, 828.0270681948716, 831.0650518167062, 781.9022622172229, 808.5512540539997, 811.9971834784037, 812.1188510466122, 815.0219736316444, 864.7405778266526, 865.3423398217337, 865.5758678247645, 865.8528050231445, 867.2151702709058, 839.4711331860949, 853.1298075962515, 866.6143566113083, 866.8309679612478, 867.3754896474528, 609.8841220168154, 630.3224034163293, 633.4045996763074, 648.6400047973373, 650.7494614573424, 12256.632301030982, 12661.113722039461, 12663.176893501894, 12676.366181690879, 12766.872331276754, 11348.148888833288, 11389.601363952223, 11495.712607184803, 11498.540058397653, 11626.534938602446, 9930.255230857641, 10070.546825392876, 10089.495525223783, 10330.535125919352, 10449.216308776797, 3312.0726196664973, 3524.0837382280533, 3577.749557530974, 3591.6228795976567, 3606.1705807664384, 85548.0, 87329.56335218283, 87720.56139719325, 89232.0, 91161.0, 8472.872906906401, 8588.785280368042, 8702.086280940537, 8752.91247087521, 8799.604017819214, 18266.0, 18354.174062167236, 18379.63240735178, 18381.908090459463, 19204.903975480032, 6404.551681382259, 7418.96290518544, 7616.276453736886, 7669.156392796788, 7755.3407960324, 4019.31671615826, 4105.055837157471, 4118.6499147572795, 4184.518780340239, 4237.279662457389, 3342.364950659367, 3411.2836304375865, 3429.3998550253605, 3440.1055725511546, 3444.0873168610337, 618.9721462534196, 634.6350848262175, 639.6290151711996, 641.6855740687123, 644.6035688051815, 575.3153747041008, 577.9508741756914, 659.4658326755343, 667.732906837269, 685.8662560800595, 7377.594232317274, 8232.711855085163, 8924.598393072327, 9018.413803102778, 9199.56320773063, 488.73957944506657, 623.6943897490197, 624.1012941364421, 631.0943795653252, 636.78667646339, 3438.346714124308, 4001.599840015975, 4272.743635381887, 4307.870763877088, 4366.912661746747, 78108.60945695236, 92710.0, 96940.0, 99331.0, 100473.0, 60908.0, 63634.0, 84859.0, 86211.0, 88282.55858720666, 62376.0, 80441.0, 82081.17918820855, 84312.15687843043, 86610.0, 7415.592142432002, 8258.967629046369, 8491.23578877904, 9172.54137293146, 9367.718968430958, 38449.80775096107, 38840.0, 54175.0, 55443.72278138583, 55968.44031559795, 73589.0, 76644.0, 79238.60380698291, 79402.20597794179, 81365.0, 9830.361026533252, 12035.699107522032, 12039.518419263131, 12313.44589493457, 12352.814707779571, 13598.11612245201, 13601.183928964294, 13698.794518082435, 13732.725345492834, 13861.584152475441, 12050.783096853082, 12769.361531923552, 13064.34678266102, 13086.411111499814, 13463.99020073518, 12507.874921251036, 12696.428660710106, 12744.808827867775, 12764.106512544033, 12815.564883522036, 12048.397580120783, 12090.637280881587, 12431.93784031074, 12531.937340313605, 12949.935250323688, 8411.789705257417, 8956.193942544942, 10378.169746420117, 10495.790084198426, 11028.062614677843, 9064.229540489132, 10536.52585633633, 10793.244472886823, 11131.666050018512, 11154.888451115385], "value": 6903.120865109869, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 121.0, 121.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 116.0, 146.0, 116.0, 116.0, 116.0, 122.0, 177.0, 117.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 231.0, 212.0, 207.0, 196.0, 200.0, 200.0, 195.0, 198.0, 201.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 62.0, 59.0, 79.0, 50.0, 60.0, 73.0, 74.0, 109.0, 82.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 121.0, 103.0, 79.0, 71.0, 86.0, 71.0, 70.0, 88.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 90.0, 85.0, 101.0, 88.0, 88.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 110.0, 153.0, 123.0, 96.0, 95.0, 96.0, 94.0, 96.0, 95.0], "value": 105.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 86.0, 86.0, 118.0, 115.0, 90.0, 116.0, 136.0, 89.0], "value": 101.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 57.0, 55.0, 59.0, 58.0, 60.0, 65.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 68.0, 79.0, 75.0, 70.0, 71.0, 70.0, 71.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 84.0, 88.0, 89.0, 86.0, 87.0, 85.0, 91.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 136.0, 150.0, 151.0, 152.0, 154.0, 173.0, 197.0, 164.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 170.0, 170.0, 172.0, 170.0, 170.0, 171.0, 172.0, 168.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 66.0, 68.0, 68.0, 68.0, 65.0, 69.0, 68.0], "value": 67.8, "unit": "score"}]}]} 08:31:48 INFO - Return code: 0 08:31:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:48 ERROR - # TBPL SUCCESS # 08:31:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:31:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:31:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:31:48 INFO - 2016-11-25 08:31:48.904 screenresolution[1929:17451] starting screenresolution argv=screenresolution get 08:31:48 INFO - 2016-11-25 08:31:48.907 screenresolution[1929:17451] Display 0: 1600x1200x32@60 08:31:48 INFO - 2016-11-25 08:31:48.913 screenresolution[1930:17454] starting screenresolution argv=screenresolution list 08:31:48 INFO - Available Modes on Display 0 08:31:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:31:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:31:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:31:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:31:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:31:49 INFO - Intel Iris: 08:31:49 INFO - Chipset Model: Intel Iris 08:31:49 INFO - Type: GPU 08:31:49 INFO - Bus: Built-In 08:31:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:31:49 INFO - Vendor: Intel (0x8086) 08:31:49 INFO - Device ID: 0x0a2e 08:31:49 INFO - Revision ID: 0x0009 08:31:49 INFO - Displays: 08:31:49 INFO - Display: 08:31:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:31:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:31:49 INFO - Display Serial Number: 1600x1200 60 08:31:49 INFO - Main Display: Yes 08:31:49 INFO - Mirror: Off 08:31:49 INFO - Online: Yes 08:31:49 INFO - Rotation: Supported 08:31:49 INFO - Return code: 0 08:31:49 INFO - Running post-action listener: _resource_record_post_action 08:31:49 INFO - [mozharness: 2016-11-25 16:31:49.147052Z] Finished run-tests step (success) 08:31:49 INFO - Running post-run listener: _resource_record_post_run 08:31:49 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 651264; Write bytes: 661050880; Read time: 8; Write time: 1905 08:31:49 INFO - TinderboxPrint: CPU usage
54.6% 08:31:49 INFO - TinderboxPrint: I/O read bytes / time
651,264 / 8 08:31:49 INFO - TinderboxPrint: I/O write bytes / time
661,050,880 / 1,905 08:31:49 INFO - TinderboxPrint: CPU idle
2,196.3 (45.4%) 08:31:49 INFO - TinderboxPrint: CPU system
981.3 (20.3%) 08:31:49 INFO - TinderboxPrint: CPU user
1,656.2 (34.3%) 08:31:49 INFO - TinderboxPrint: Swap in / out
348,569,600 / 0 08:31:49 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 347445760; Write bytes: 345110528; Read time: 26808; Write time: 682 08:31:49 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 585728; Write bytes: 308690432; Read time: 8; Write time: 1190 08:31:49 INFO - Running post-run listener: _upload_blobber_files 08:31:49 INFO - Blob upload gear active. 08:31:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:49 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 08:31:49 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'] 08:31:49 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 08:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:50 INFO - (blobuploader) - INFO - Done attempting. 08:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:51 INFO - (blobuploader) - INFO - Done attempting. 08:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:53 INFO - (blobuploader) - INFO - Done attempting. 08:31:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:53 INFO - Return code: 0 08:31:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c71c487bbd5e2c7cffbfcb617d00d96f400961314c21ede6a574baa993ef1383efb5d7726e153e74bd02decc2d197ce6b5a65c0fb7e4c5559ad755dedb215c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e48b4340b67a1dda1b09201360675caa656ed663c571377c234ceb57a9731a1dcedcb69dea4c3faed3c0fbd53cfe5ee793be8d5946234c37eb4c95075837ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84273ea9eadfd7640235c8677a2bfef6aa46c300e61c05651b8e9def3ccb8143af7556bb6bd16ae8adbdd5e6ae6bd25bb3e72020856f83d3eb5452ae64a6d6"} 08:31:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:53 INFO - Contents: 08:31:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c71c487bbd5e2c7cffbfcb617d00d96f400961314c21ede6a574baa993ef1383efb5d7726e153e74bd02decc2d197ce6b5a65c0fb7e4c5559ad755dedb215c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e48b4340b67a1dda1b09201360675caa656ed663c571377c234ceb57a9731a1dcedcb69dea4c3faed3c0fbd53cfe5ee793be8d5946234c37eb4c95075837ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84273ea9eadfd7640235c8677a2bfef6aa46c300e61c05651b8e9def3ccb8143af7556bb6bd16ae8adbdd5e6ae6bd25bb3e72020856f83d3eb5452ae64a6d6"} 08:31:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:53 INFO - Copying logs to upload dir... 08:31:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.509347 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-25 08:31:54.544976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 08:31:54.548139) ========= 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.XhTodbYg5j/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.HsA0EivxLB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/c71c487bbd5e2c7cffbfcb617d00d96f400961314c21ede6a574baa993ef1383efb5d7726e153e74bd02decc2d197ce6b5a65c0fb7e4c5559ad755dedb215c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e48b4340b67a1dda1b09201360675caa656ed663c571377c234ceb57a9731a1dcedcb69dea4c3faed3c0fbd53cfe5ee793be8d5946234c37eb4c95075837ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84273ea9eadfd7640235c8677a2bfef6aa46c300e61c05651b8e9def3ccb8143af7556bb6bd16ae8adbdd5e6ae6bd25bb3e72020856f83d3eb5452ae64a6d6"} build_url:https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/SSuycGrkR2mqV4eRXAsbsw/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/c71c487bbd5e2c7cffbfcb617d00d96f400961314c21ede6a574baa993ef1383efb5d7726e153e74bd02decc2d197ce6b5a65c0fb7e4c5559ad755dedb215c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e48b4340b67a1dda1b09201360675caa656ed663c571377c234ceb57a9731a1dcedcb69dea4c3faed3c0fbd53cfe5ee793be8d5946234c37eb4c95075837ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84273ea9eadfd7640235c8677a2bfef6aa46c300e61c05651b8e9def3ccb8143af7556bb6bd16ae8adbdd5e6ae6bd25bb3e72020856f83d3eb5452ae64a6d6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 08:31:54.590112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:31:54.590509) ========= 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.XhTodbYg5j/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.HsA0EivxLB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005369 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:31:54.639500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 08:31:54.642453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 08:31:54.642885) ========= ========= Total master_lag: 0.68 =========