builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0291 starttime: 1475619655.42 results: success (0) buildid: 20161004135100 builduid: f763b44f4bbe47ab9514b8753258aef7 revision: 54474ed8388b6f677bb35ab251df6f147c13ec24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.420285) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.420793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.421086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.451625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.452041) ========= 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.cf6atMunOy/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.hNKAVVVrZY/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 15:20:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-10-04 15:20:55 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126502 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.604303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.604715) ========= 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.cf6atMunOy/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.hNKAVVVrZY/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.027558 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:55.653882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 15:20:55.654296) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 54474ed8388b6f677bb35ab251df6f147c13ec24 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 54474ed8388b6f677bb35ab251df6f147c13ec24 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cf6atMunOy/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.hNKAVVVrZY/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 15:20:55,710 truncating revision to first 12 chars 2016-10-04 15:20:55,710 Setting DEBUG logging. 2016-10-04 15:20:55,710 attempt 1/10 2016-10-04 15:20:55,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/54474ed8388b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 15:20:56,601 unpacking tar archive at: autoland-54474ed8388b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.143670 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 15:20:56.824490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:56.824871) ========= script_repo_revision: 54474ed8388b6f677bb35ab251df6f147c13ec24 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:56.825298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:56.825593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 15:20:56.845506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 15:20:56.845947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cf6atMunOy/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.hNKAVVVrZY/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:20:57 INFO - MultiFileLogger online at 20161004 15:20:57 in /builds/slave/test 15:20:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:20:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:20:57 INFO - {'append_to_log': False, 15:20:57 INFO - 'base_work_dir': '/builds/slave/test', 15:20:57 INFO - 'blob_upload_branch': 'Autoland', 15:20:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:20:57 INFO - 'branch': 'Autoland', 15:20:57 INFO - 'buildbot_json_path': 'buildprops.json', 15:20:57 INFO - 'config_files': ('talos/mac_config.py',), 15:20:57 INFO - 'default_actions': ('clobber', 15:20:57 INFO - 'read-buildbot-config', 15:20:57 INFO - 'download-and-extract', 15:20:57 INFO - 'populate-webroot', 15:20:57 INFO - 'create-virtualenv', 15:20:57 INFO - 'install', 15:20:57 INFO - 'run-tests'), 15:20:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:20:57 INFO - 'download_minidump_stackwalk': True, 15:20:57 INFO - 'download_symbols': 'ondemand', 15:20:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:20:57 INFO - 'tooltool.py': '/tools/tooltool.py', 15:20:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:20:57 INFO - '/tools/misc-python/virtualenv.py')}, 15:20:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:20:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:20:57 INFO - 'installer_path': 'installer.exe', 15:20:57 INFO - 'log_level': 'info', 15:20:57 INFO - 'log_name': 'talos', 15:20:57 INFO - 'log_to_console': True, 15:20:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:20:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:20:57 INFO - 'opt_config_files': (), 15:20:57 INFO - 'pip_index': False, 15:20:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:20:57 INFO - 'cmd': ('bash', 15:20:57 INFO - '-c', 15:20:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:20:57 INFO - 'enabled': True, 15:20:57 INFO - 'halt_on_failure': False, 15:20:57 INFO - 'name': 'check_screen_resolution'},), 15:20:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:20:57 INFO - 'cmd': ('bash', 15:20:57 INFO - '-c', 15:20:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:20:57 INFO - 'enabled': True, 15:20:57 INFO - 'halt_on_failure': False, 15:20:57 INFO - 'name': 'check_screen_resolution'},), 15:20:57 INFO - 'run_cmd_checks_enabled': True, 15:20:57 INFO - 'sps_profile': False, 15:20:57 INFO - 'sps_profile_interval': 0, 15:20:57 INFO - 'suite': 'dromaeojs', 15:20:57 INFO - 'system_bits': '32', 15:20:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:20:57 INFO - 'title': 't-yosemite-r7-0291', 15:20:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:20:57 INFO - 'use_talos_json': True, 15:20:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:20:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:20:57 INFO - 'work_dir': 'build'} 15:20:57 INFO - [mozharness: 2016-10-04 22:20:57.023569Z] Running clobber step. 15:20:57 INFO - Running pre-action listener: _resource_record_pre_action 15:20:57 INFO - Running main action method: clobber 15:20:57 INFO - rmtree: /builds/slave/test/build 15:20:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:20:59 INFO - Running post-action listener: _resource_record_post_action 15:20:59 INFO - [mozharness: 2016-10-04 22:20:59.200693Z] Finished clobber step (success) 15:20:59 INFO - [mozharness: 2016-10-04 22:20:59.200853Z] Running read-buildbot-config step. 15:20:59 INFO - Running pre-action listener: _resource_record_pre_action 15:20:59 INFO - Running main action method: read_buildbot_config 15:20:59 INFO - Using buildbot properties: 15:20:59 INFO - { 15:20:59 INFO - "project": "", 15:20:59 INFO - "product": "firefox", 15:20:59 INFO - "script_repo_revision": "production", 15:20:59 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 15:20:59 INFO - "repository": "", 15:20:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 15:20:59 INFO - "buildid": "20161004135100", 15:20:59 INFO - "pgo_build": "False", 15:20:59 INFO - "basedir": "/builds/slave/test", 15:20:59 INFO - "buildnumber": 334, 15:20:59 INFO - "slavename": "t-yosemite-r7-0291", 15:20:59 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:20:59 INFO - "platform": "yosemite_r7", 15:20:59 INFO - "scheduler": "tests-autoland-macosx64-talos", 15:20:59 INFO - "branch": "autoland", 15:20:59 INFO - "repo_path": "integration/autoland", 15:20:59 INFO - "revision": "54474ed8388b6f677bb35ab251df6f147c13ec24", 15:20:59 INFO - "stage_platform": "macosx64", 15:20:59 INFO - "builduid": "f763b44f4bbe47ab9514b8753258aef7", 15:20:59 INFO - "slavebuilddir": "test" 15:20:59 INFO - } 15:20:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:20:59 INFO - Running post-action listener: _resource_record_post_action 15:20:59 INFO - [mozharness: 2016-10-04 22:20:59.203693Z] Finished read-buildbot-config step (success) 15:20:59 INFO - [mozharness: 2016-10-04 22:20:59.203801Z] Running download-and-extract step. 15:20:59 INFO - Running pre-action listener: _resource_record_pre_action 15:20:59 INFO - Running main action method: download_and_extract 15:20:59 INFO - mkdir: /builds/slave/test/build/tests 15:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:59 INFO - trying https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:20:59 INFO - Downloading https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 15:21:00 INFO - Downloaded 1057 bytes. 15:21:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:21:00 INFO - Using the following test package requirements: 15:21:00 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:21:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:21:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:21:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'jsshell-mac.zip'], 15:21:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:21:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:21:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:21:00 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:21:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:21:00 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:21:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:21:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:21:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:21:00 INFO - Fetch https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:21:01 INFO - Http code: 200 15:21:01 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 15:21:01 INFO - x-amz-cf-id: q6uTbCuMLkA7eiQ83i13BHgNTxOlgtnAGLE82H8RVy5BcQKmfLNVWw== 15:21:01 INFO - x-amz-version-id: kJ.HrFD.3CgMBIDC7LjbSfsXkwEZH8Vd 15:21:01 INFO - Expected file size: 16477107 15:21:01 INFO - Obtained file size: 16477107 15:21:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:21:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:21:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:21:08 INFO - Fetch https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:21:08 INFO - Http code: 200 15:21:08 INFO - via: 1.1 3344ddc09ccf1d185bb41add18940cc4.cloudfront.net (CloudFront) 15:21:08 INFO - x-amz-cf-id: gGWg6GnCVl5rfsBko-ynIVYkpDIcc_a4Uwt4rwoeHHsqs1Kh8uWtXg== 15:21:08 INFO - x-amz-version-id: kJ.HrFD.3CgMBIDC7LjbSfsXkwEZH8Vd 15:21:09 INFO - Expected file size: 16477107 15:21:09 INFO - Obtained file size: 16477107 15:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:21:15 INFO - Http code: 200 15:21:15 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 15:21:15 INFO - x-amz-cf-id: GIOr0RL7-JgkAWbvACJEDwhbFsf1QTXn_BJK6q8fkXBe9TLRVU-8ug== 15:21:15 INFO - x-amz-version-id: dMN27TmvmOJeAJXNhMVZ2oI_7r4Unst6 15:21:16 INFO - Expected file size: 14409006 15:21:16 INFO - Obtained file size: 14409006 15:21:16 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')]} 15:21:16 INFO - trying https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:21:16 INFO - Downloading https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 15:21:19 INFO - Downloaded 111695920 bytes. 15:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:21:19 INFO - mkdir: /builds/slave/test/properties 15:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:21:19 INFO - Contents: 15:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:21:20 INFO - Running post-action listener: _resource_record_post_action 15:21:20 INFO - Running post-action listener: set_extra_try_arguments 15:21:20 INFO - [mozharness: 2016-10-04 22:21:20.142136Z] Finished download-and-extract step (success) 15:21:20 INFO - [mozharness: 2016-10-04 22:21:20.142264Z] Running populate-webroot step. 15:21:20 INFO - Running pre-action listener: _resource_record_pre_action 15:21:20 INFO - Running main action method: populate_webroot 15:21:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:21:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:21:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:21:20 INFO - '--tppagecycles', 15:21:20 INFO - '7'], 15:21:20 INFO - 'tests': ['tsvgm']}}, 15:21:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:21:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:21:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:21:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:21:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['damp', 'tps']}, 15:21:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'tests': ['damp', 'tps']}, 15:21:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['dromaeo_dom']}, 15:21:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:21:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['basic_compositor_video']}, 15:21:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:21:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['a11yr', 15:21:20 INFO - 'ts_paint', 15:21:20 INFO - 'tpaint', 15:21:20 INFO - 'sessionrestore', 15:21:20 INFO - 'sessionrestore_no_auto_restore', 15:21:20 INFO - 'tabpaint']}, 15:21:20 INFO - 'other-e10s': {'tests': ['a11yr', 15:21:20 INFO - 'ts_paint', 15:21:20 INFO - 'tpaint', 15:21:20 INFO - 'sessionrestore', 15:21:20 INFO - 'sessionrestore_no_auto_restore', 15:21:20 INFO - 'tabpaint']}, 15:21:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:21:20 INFO - 'ts_paint', 15:21:20 INFO - 'tpaint', 15:21:20 INFO - 'sessionrestore', 15:21:20 INFO - 'sessionrestore_no_auto_restore', 15:21:20 INFO - 'tabpaint']}, 15:21:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:21:20 INFO - 'ts_paint', 15:21:20 INFO - 'tpaint', 15:21:20 INFO - 'sessionrestore', 15:21:20 INFO - 'sessionrestore_no_auto_restore', 15:21:20 INFO - 'tabpaint']}, 15:21:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['a11yr', 15:21:20 INFO - 'ts_paint', 15:21:20 INFO - 'tpaint', 15:21:20 INFO - 'sessionrestore', 15:21:20 INFO - 'sessionrestore_no_auto_restore', 15:21:20 INFO - 'tabpaint']}, 15:21:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['a11yr', 15:21:20 INFO - 'ts_paint', 15:21:20 INFO - 'tpaint', 15:21:20 INFO - 'sessionrestore', 15:21:20 INFO - 'sessionrestore_no_auto_restore', 15:21:20 INFO - 'tabpaint']}, 15:21:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['tsvgx', 15:21:20 INFO - 'tsvgr_opacity', 15:21:20 INFO - 'tart', 15:21:20 INFO - 'tscrollx', 15:21:20 INFO - 'cart']}, 15:21:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:21:20 INFO - 'tsvgr_opacity', 15:21:20 INFO - 'tart', 15:21:20 INFO - 'tscrollx', 15:21:20 INFO - 'cart']}, 15:21:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'talos_options': ['--disable-e10s'], 15:21:20 INFO - 'tests': ['tp5o']}, 15:21:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'tests': ['tp5o']}, 15:21:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'talos_options': ['--disable-e10s', 15:21:20 INFO - '--xperf_path', 15:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:20 INFO - 'tests': ['tp5n']}, 15:21:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:20 INFO - 'talos_options': ['--xperf_path', 15:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:20 INFO - 'tests': ['tp5n']}}, 15:21:20 INFO - 'talos.zip': {'path': '', 15:21:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:21:20 INFO - Running post-action listener: _resource_record_post_action 15:21:20 INFO - [mozharness: 2016-10-04 22:21:20.161123Z] Finished populate-webroot step (success) 15:21:20 INFO - [mozharness: 2016-10-04 22:21:20.161254Z] Running create-virtualenv step. 15:21:20 INFO - Running pre-action listener: _resource_record_pre_action 15:21:20 INFO - Running main action method: create_virtualenv 15:21:20 INFO - Creating virtualenv /builds/slave/test/build/venv 15:21:20 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 15:21:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:21:20 INFO - Using real prefix '/tools/python27' 15:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:21:23 INFO - Installing pip.................done. 15:21:23 INFO - Return code: 0 15:21:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:21:24 INFO - Reading from file tmpfile_stdout 15:21:24 INFO - Output received: 15:21:24 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) 15:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21: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', 'pip>=1.5'] in /builds/slave/test/build 15:21: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 pip>=1.5 15:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:24 INFO - 'HOME': '/Users/cltbld', 15:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:24 INFO - 'LOGNAME': 'cltbld', 15:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:24 INFO - 'MOZ_NO_REMOTE': '1', 15:21:24 INFO - 'NO_EM_RESTART': '1', 15:21:24 INFO - 'PAGER': '/bin/cat', 15:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:24 INFO - 'PWD': '/builds/slave/test', 15:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:24 INFO - 'SHELL': '/bin/bash', 15:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:24 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:24 INFO - 'USER': 'cltbld', 15:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:24 INFO - 'XPC_FLAGS': '0x0', 15:21:24 INFO - 'XPC_SERVICE_NAME': '0', 15:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:24 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 15:21:24 INFO - Cleaning up... 15:21:24 INFO - Return code: 0 15:21:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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', '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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:21: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 psutil>=3.1.1 15:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:24 INFO - 'HOME': '/Users/cltbld', 15:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:24 INFO - 'LOGNAME': 'cltbld', 15:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:24 INFO - 'MOZ_NO_REMOTE': '1', 15:21:24 INFO - 'NO_EM_RESTART': '1', 15:21:24 INFO - 'PAGER': '/bin/cat', 15:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:24 INFO - 'PWD': '/builds/slave/test', 15:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:24 INFO - 'SHELL': '/bin/bash', 15:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:24 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:24 INFO - 'USER': 'cltbld', 15:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:24 INFO - 'XPC_FLAGS': '0x0', 15:21:24 INFO - 'XPC_SERVICE_NAME': '0', 15:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:24 INFO - Downloading/unpacking psutil>=3.1.1 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:28 INFO - Installing collected packages: psutil 15:21:28 INFO - Running setup.py install for psutil 15:21:28 INFO - building 'psutil._psutil_osx' extension 15:21:28 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 15:21:28 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 15:21:28 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 15:21:28 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 15:21:28 INFO - building 'psutil._psutil_posix' extension 15:21:28 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 15:21:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:21:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:21:28 INFO - ^ 15:21:29 INFO - 1 warning generated. 15:21:29 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 15:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:29 INFO - Successfully installed psutil 15:21:29 INFO - Cleaning up... 15:21:29 INFO - Return code: 0 15:21:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:29 INFO - 'HOME': '/Users/cltbld', 15:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:29 INFO - 'LOGNAME': 'cltbld', 15:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:29 INFO - 'MOZ_NO_REMOTE': '1', 15:21:29 INFO - 'NO_EM_RESTART': '1', 15:21:29 INFO - 'PAGER': '/bin/cat', 15:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:29 INFO - 'PWD': '/builds/slave/test', 15:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:29 INFO - 'SHELL': '/bin/bash', 15:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:29 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:29 INFO - 'USER': 'cltbld', 15:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:29 INFO - 'XPC_FLAGS': '0x0', 15:21:29 INFO - 'XPC_SERVICE_NAME': '0', 15:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:21:32 INFO - Installing collected packages: mozsystemmonitor 15:21:32 INFO - Running setup.py install for mozsystemmonitor 15:21:32 INFO - Successfully installed mozsystemmonitor 15:21:32 INFO - Cleaning up... 15:21:32 INFO - Return code: 0 15:21:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:32 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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:32 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 15:21:32 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 15:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:32 INFO - 'HOME': '/Users/cltbld', 15:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:32 INFO - 'LOGNAME': 'cltbld', 15:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:32 INFO - 'MOZ_NO_REMOTE': '1', 15:21:32 INFO - 'NO_EM_RESTART': '1', 15:21:32 INFO - 'PAGER': '/bin/cat', 15:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:32 INFO - 'PWD': '/builds/slave/test', 15:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:32 INFO - 'SHELL': '/bin/bash', 15:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:32 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:32 INFO - 'USER': 'cltbld', 15:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:32 INFO - 'XPC_FLAGS': '0x0', 15:21:32 INFO - 'XPC_SERVICE_NAME': '0', 15:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:21:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:21:34 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 15:21:34 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 15:21:34 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 15:21:34 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 15:21:34 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 15:21:34 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 15:21:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:21:35 INFO - warning: no files found matching '*.txt' 15:21:35 INFO - no previously-included directories found matching 'build' 15:21:35 INFO - no previously-included directories found matching 'dist' 15:21:35 INFO - no previously-included directories found matching '.git*' 15:21:35 INFO - Installing collected packages: jsonschema, functools32 15:21:35 INFO - Running setup.py install for functools32 15:21:35 INFO - warning: no files found matching '*.txt' 15:21:35 INFO - no previously-included directories found matching 'build' 15:21:35 INFO - no previously-included directories found matching 'dist' 15:21:35 INFO - no previously-included directories found matching '.git*' 15:21:35 INFO - Successfully installed jsonschema functools32 15:21:35 INFO - Cleaning up... 15:21:35 INFO - Return code: 0 15:21:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:35 INFO - 'HOME': '/Users/cltbld', 15:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:35 INFO - 'LOGNAME': 'cltbld', 15:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:35 INFO - 'MOZ_NO_REMOTE': '1', 15:21:35 INFO - 'NO_EM_RESTART': '1', 15:21:35 INFO - 'PAGER': '/bin/cat', 15:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:35 INFO - 'PWD': '/builds/slave/test', 15:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:35 INFO - 'SHELL': '/bin/bash', 15:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:35 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:35 INFO - 'USER': 'cltbld', 15:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:35 INFO - 'XPC_FLAGS': '0x0', 15:21:35 INFO - 'XPC_SERVICE_NAME': '0', 15:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:21:35 INFO - Cleaning up... 15:21:35 INFO - Return code: 0 15:21:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:35 INFO - 'HOME': '/Users/cltbld', 15:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:35 INFO - 'LOGNAME': 'cltbld', 15:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:35 INFO - 'MOZ_NO_REMOTE': '1', 15:21:35 INFO - 'NO_EM_RESTART': '1', 15:21:35 INFO - 'PAGER': '/bin/cat', 15:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:35 INFO - 'PWD': '/builds/slave/test', 15:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:35 INFO - 'SHELL': '/bin/bash', 15:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:35 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:35 INFO - 'USER': 'cltbld', 15:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:35 INFO - 'XPC_FLAGS': '0x0', 15:21:35 INFO - 'XPC_SERVICE_NAME': '0', 15:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 INFO - Downloading docopt-0.6.1.tar.gz 15:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:21:39 INFO - Running setup.py install for blobuploader 15:21:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:21:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:21:40 INFO - Running setup.py install for requests 15:21:40 INFO - Running setup.py install for docopt 15:21:40 INFO - Successfully installed blobuploader requests docopt 15:21:40 INFO - Cleaning up... 15:21:40 INFO - Return code: 0 15:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:40 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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:40 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 15:21:40 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 15:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:40 INFO - 'HOME': '/Users/cltbld', 15:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:40 INFO - 'LOGNAME': 'cltbld', 15:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:40 INFO - 'MOZ_NO_REMOTE': '1', 15:21:40 INFO - 'NO_EM_RESTART': '1', 15:21:40 INFO - 'PAGER': '/bin/cat', 15:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:40 INFO - 'PWD': '/builds/slave/test', 15:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:40 INFO - 'SHELL': '/bin/bash', 15:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:40 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:40 INFO - 'USER': 'cltbld', 15:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:40 INFO - 'XPC_FLAGS': '0x0', 15:21:40 INFO - 'XPC_SERVICE_NAME': '0', 15:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-3_OjXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-VkcXBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-uyq4D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Kk9L7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-efnv9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Iz8beL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-VOrXJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-BsZtIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:41 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-EVjVai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ygxh8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-bkC3RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-fYHwFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-3cBvb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ZljsKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-yqz4Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-SUgGP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:42 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-rBZDdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:21:42 INFO - Running setup.py install for manifestparser 15:21:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:21:42 INFO - Running setup.py install for mozcrash 15:21:43 INFO - Running setup.py install for mozdebug 15:21:43 INFO - Running setup.py install for mozdevice 15:21:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:21:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:21:43 INFO - Running setup.py install for mozfile 15:21:43 INFO - Running setup.py install for mozhttpd 15:21:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:21:43 INFO - Running setup.py install for mozinfo 15:21:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:21:43 INFO - Running setup.py install for mozInstall 15:21:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozleak 15:21:44 INFO - Running setup.py install for mozlog 15:21:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for moznetwork 15:21:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozprocess 15:21:44 INFO - Running setup.py install for mozprofile 15:21:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozrunner 15:21:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozscreenshot 15:21:45 INFO - Running setup.py install for moztest 15:21:45 INFO - Running setup.py install for mozversion 15:21:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:21:45 INFO - Cleaning up... 15:21:45 INFO - Return code: 0 15:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:45 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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:45 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 15:21:45 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 15:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:45 INFO - 'HOME': '/Users/cltbld', 15:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:45 INFO - 'LOGNAME': 'cltbld', 15:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:45 INFO - 'MOZ_NO_REMOTE': '1', 15:21:45 INFO - 'NO_EM_RESTART': '1', 15:21:45 INFO - 'PAGER': '/bin/cat', 15:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:45 INFO - 'PWD': '/builds/slave/test', 15:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:45 INFO - 'SHELL': '/bin/bash', 15:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:45 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:45 INFO - 'USER': 'cltbld', 15:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:45 INFO - 'XPC_FLAGS': '0x0', 15:21:45 INFO - 'XPC_SERVICE_NAME': '0', 15:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:45 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-0_hnJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:45 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)) 15:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:45 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-kzYLRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:45 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-cOF3yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-sSS4QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-luSfDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-0oWRAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-K641J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-U_UJof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-LPWweU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-VGHT6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-fLGVDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ati5EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-g226Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ydkJfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-hDFnDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-i745i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pYLXtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:47 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)) 15:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:47 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)) 15:21:47 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)) 15:21:47 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)) 15:21:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:49 INFO - Downloading blessings-1.6.tar.gz 15:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:21:50 INFO - Installing collected packages: blessings 15:21:50 INFO - Running setup.py install for blessings 15:21:50 INFO - Successfully installed blessings 15:21:50 INFO - Cleaning up... 15:21:50 INFO - Return code: 0 15:21:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:50 INFO - Reading from file tmpfile_stdout 15:21:50 INFO - Current package versions: 15:21:50 INFO - blessings == 1.6 15:21:50 INFO - blobuploader == 1.2.4 15:21:50 INFO - docopt == 0.6.1 15:21:50 INFO - functools32 == 3.2.3-2 15:21:50 INFO - jsonschema == 2.5.1 15:21:50 INFO - manifestparser == 1.1 15:21:50 INFO - mozInstall == 1.12 15:21:50 INFO - mozcrash == 0.17 15:21:50 INFO - mozdebug == 0.1 15:21:50 INFO - mozdevice == 0.48 15:21:50 INFO - mozfile == 1.2 15:21:50 INFO - mozhttpd == 0.7 15:21:50 INFO - mozinfo == 0.9 15:21:50 INFO - mozleak == 0.1 15:21:50 INFO - mozlog == 3.4 15:21:50 INFO - moznetwork == 0.27 15:21:50 INFO - mozprocess == 0.23 15:21:50 INFO - mozprofile == 0.28 15:21:50 INFO - mozrunner == 6.12 15:21:50 INFO - mozscreenshot == 0.1 15:21:50 INFO - mozsystemmonitor == 0.3 15:21:50 INFO - moztest == 0.7 15:21:50 INFO - mozversion == 1.4 15:21:50 INFO - psutil == 3.1.1 15:21:50 INFO - requests == 1.2.3 15:21:50 INFO - wsgiref == 0.1.2 15:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:50 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')]} 15:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:51 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')]} 15:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:51 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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:51 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 15:21:51 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 15:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:51 INFO - 'HOME': '/Users/cltbld', 15:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:51 INFO - 'LOGNAME': 'cltbld', 15:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:51 INFO - 'MOZ_NO_REMOTE': '1', 15:21:51 INFO - 'NO_EM_RESTART': '1', 15:21:51 INFO - 'PAGER': '/bin/cat', 15:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:51 INFO - 'PWD': '/builds/slave/test', 15:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:51 INFO - 'SHELL': '/bin/bash', 15:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:51 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:51 INFO - 'USER': 'cltbld', 15:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:51 INFO - 'XPC_FLAGS': '0x0', 15:21:51 INFO - 'XPC_SERVICE_NAME': '0', 15:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 INFO - Cleaning up... 15:21:52 INFO - Return code: 0 15:21:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:52 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 0x10e175490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc91a459720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, '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.cf6atMunOy/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.hNKAVVVrZY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:21:52 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 15:21:52 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 15:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:52 INFO - 'HOME': '/Users/cltbld', 15:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:52 INFO - 'LOGNAME': 'cltbld', 15:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:52 INFO - 'MOZ_NO_REMOTE': '1', 15:21:52 INFO - 'NO_EM_RESTART': '1', 15:21:52 INFO - 'PAGER': '/bin/cat', 15:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:52 INFO - 'PWD': '/builds/slave/test', 15:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:52 INFO - 'SHELL': '/bin/bash', 15:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:21:52 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:52 INFO - 'USER': 'cltbld', 15:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:52 INFO - 'XPC_FLAGS': '0x0', 15:21:52 INFO - 'XPC_SERVICE_NAME': '0', 15:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:21:52 INFO - Cleaning up... 15:21:52 INFO - Return code: 0 15:21:52 INFO - Running post-action listener: _resource_record_post_action 15:21:52 INFO - Running post-action listener: _start_resource_monitoring 15:21:52 INFO - Starting resource monitoring. 15:21:52 INFO - [mozharness: 2016-10-04 22:21:52.738556Z] Finished create-virtualenv step (success) 15:21:52 INFO - [mozharness: 2016-10-04 22:21:52.739545Z] Running install step. 15:21:52 INFO - Running pre-action listener: _resource_record_pre_action 15:21:52 INFO - Running main action method: install 15:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:52 INFO - Reading from file tmpfile_stdout 15:21:52 INFO - Detecting whether we're running mozinstall >=1.0... 15:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:21:53 INFO - Reading from file tmpfile_stdout 15:21:53 INFO - Output received: 15:21:53 INFO - Usage: mozinstall [options] installer 15:21:53 INFO - Options: 15:21:53 INFO - -h, --help show this help message and exit 15:21:53 INFO - -d DEST, --destination=DEST 15:21:53 INFO - Directory to install application into. [default: 15:21:53 INFO - "/builds/slave/test"] 15:21:53 INFO - --app=APP Application being installed. [default: firefox] 15:21:53 INFO - mkdir: /builds/slave/test/build/application 15:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:22:27 INFO - Reading from file tmpfile_stdout 15:22:27 INFO - Output received: 15:22:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:22:27 INFO - Running post-action listener: _resource_record_post_action 15:22:27 INFO - [mozharness: 2016-10-04 22:22:27.039597Z] Finished install step (success) 15:22:27 INFO - [mozharness: 2016-10-04 22:22:27.039764Z] Running run-tests step. 15:22:27 INFO - Running pre-action listener: _resource_record_pre_action 15:22:27 INFO - Running main action method: run_tests 15:22:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:22:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:22:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:22:27 INFO - 2016-10-04 15:22:27.054 screenresolution[1646:7627] starting screenresolution argv=screenresolution get 15:22:27 INFO - 2016-10-04 15:22:27.056 screenresolution[1646:7627] Display 0: 1600x1200x32@60 15:22:27 INFO - 2016-10-04 15:22:27.062 screenresolution[1647:7629] starting screenresolution argv=screenresolution list 15:22:27 INFO - Available Modes on Display 0 15:22:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:22:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:22:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:22:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:22:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:22:27 INFO - Intel Iris: 15:22:27 INFO - Chipset Model: Intel Iris 15:22:27 INFO - Type: GPU 15:22:27 INFO - Bus: Built-In 15:22:27 INFO - VRAM (Dynamic, Max): 1536 MB 15:22:27 INFO - Vendor: Intel (0x8086) 15:22:27 INFO - Device ID: 0x0a2e 15:22:27 INFO - Revision ID: 0x0009 15:22:27 INFO - Displays: 15:22:27 INFO - Display: 15:22:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:22:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:22:27 INFO - Display Serial Number: 1600x1200 60 15:22:27 INFO - Main Display: Yes 15:22:27 INFO - Mirror: Off 15:22:27 INFO - Online: Yes 15:22:27 INFO - Rotation: Supported 15:22:27 INFO - Return code: 0 15:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:22:27 INFO - Python 2.7.3 15:22:27 INFO - Return code: 0 15:22:27 INFO - grabbing minidump binary from tooltool 15:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:27 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 0x10df89d30>, '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 0x10ddafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df81b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:27 INFO - Return code: 0 15:22:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:22:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:22:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:22:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:22:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cf6atMunOy/Render', 15:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:27 INFO - 'HOME': '/Users/cltbld', 15:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:27 INFO - 'LOGNAME': 'cltbld', 15:22:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:27 INFO - 'MOZ_NO_REMOTE': '1', 15:22:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:27 INFO - 'NO_EM_RESTART': '1', 15:22:27 INFO - 'PAGER': '/bin/cat', 15:22:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:27 INFO - 'PWD': '/builds/slave/test', 15:22:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:27 INFO - 'SHELL': '/bin/bash', 15:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNKAVVVrZY/Listeners', 15:22:27 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:27 INFO - 'USER': 'cltbld', 15:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:27 INFO - 'XPC_FLAGS': '0x0', 15:22:27 INFO - 'XPC_SERVICE_NAME': '0', 15:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:22:27 INFO - mozversion application_buildid: 20161004135100 15:22:27 INFO - mozversion application_changeset: 54474ed8388b6f677bb35ab251df6f147c13ec24 15:22:27 INFO - mozversion application_display_name: Nightly 15:22:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:27 INFO - mozversion application_name: Firefox 15:22:27 INFO - mozversion application_remotingname: firefox 15:22:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:22:27 INFO - mozversion application_vendor: Mozilla 15:22:27 INFO - mozversion application_version: 52.0a1 15:22:27 INFO - mozversion platform_buildid: 20161004135100 15:22:27 INFO - mozversion platform_changeset: 54474ed8388b6f677bb35ab251df6f147c13ec24 15:22:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:22:27 INFO - mozversion platform_version: 52.0a1 15:22:27 INFO - using testdate: 1475619747 15:22:27 INFO - actual date: 1475619747 15:22:27 INFO - starting webserver on 'localhost:49280' 15:22:27 INFO - SUITE-START | Running 2 tests 15:22:27 INFO - TEST-START | dromaeo_css 15:22:27 INFO - operating with platform_type : mac_ 15:22:27 INFO - Initialising browser for dromaeo_css test... 15:22:27 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpu_g_vq/profile http://localhost:49280/getInfo.html) 15:22:29 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:22:29 INFO - PROCESS | 1657 | colorDepth:24 15:22:29 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:22:29 INFO - PROCESS | 1657 | __metrics 15:22:30 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:22:30 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:22:30 INFO - TEST-INFO | 1657: exit 0 15:22:30 INFO - Browser initialized. 15:22:30 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:30 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpu_g_vq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:42 INFO - PROCESS | 1659 | RSS: Main: 236158976 15:22:42 INFO - PROCESS | 1659 | 15:23:34 INFO - PROCESS | 1659 | 1475619814084 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] 15:25:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 15:25:47 INFO - PROCESS | 1659 | RSS: Main: 407965696 15:25:47 INFO - PROCESS | 1659 | 15:28:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 15:28:51 INFO - PROCESS | 1659 | RSS: Main: 387878912 15:28:51 INFO - PROCESS | 1659 | 15:31:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 15:31:54 INFO - PROCESS | 1659 | RSS: Main: 344494080 15:31:54 INFO - PROCESS | 1659 | 15:34:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 15:34:57 INFO - PROCESS | 1659 | RSS: Main: 354312192 15:34:57 INFO - PROCESS | 1659 | 15:38:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 15:38:01 INFO - PROCESS | 1659 | RSS: Main: 335568896 15:38:01 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 15:41:04 INFO - PROCESS | 1659 | RSS: Main: 516308992 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | __start_tp_report 15:41:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 15:41:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 15:41:04 INFO - PROCESS | 1659 | |i|pagename|runs| 15:41:04 INFO - PROCESS | 1659 | |0;dojo.html;3228.3220523690024;3235.2720637856482;3237.3687131009465;3254.1864533866533;3282.3271229397974;5500.642458240211;5576.804811831586;5598.552115830734;5658.207850900877;5688.63023903446;5576.637518561291;5613.550915926727;5696.3733989261145;5720.11338242572;5758.3090029196555;4309.900975251307;5028.195488721805;5065.696058236517;5087.313212716292;5124.590032797386;5120.948790512084;5193.195054766517;5193.221016847484;5215.921761173586;5258.684478931257;5098.719570423626;5142.537171654531;5244.895102097956;5257.053730328539;5317.308749862532;5177.870553236162;5194.4026436959475;5199.948000519984;5200.817971370984;5202.869928251786;5110.591152707774;5159.793608255665;5163.096458119814;5166.380034395859;5172.327597412313;5622.269105016322;5634.971825140889;5635.239242702224;5647.830565083054;5647.8588035299035;6091.14723938649;6091.20956991861;6094.729740455602;6121;6123.2652081750475;6150.630962142286;6165.537584681167;6223.688815559204;6236.469900058501;6239.688015599202;5644.74598643062;5682.034054210794;5682.460166284196;5690.118031705134;5697.401772813878;6150.7232174552255;6258.624482531062;6265.843353916098;6268.373162683695;6271.184745982993;5919.1713160157615;5972.58191926561;6005.6396616203165;6008.948434024029;6019.127226552126;6094.692505457607;6094.954753935788;6099.085137229451;6108.304828573744;6111.682900513672;5084.313617661568;6093.847653808691;6103.725332360054;6122.032243765608;6125.632272693312;6130.356312587203;6138.894998900151;6139.250313660675;6140.758623102535;6147.815565533041;4766.976165119221;4801.879953001203;4869.001854619794;4891.730954797449;4928.950710492849;3550.2544465661986;4247.8088486018205;4252.808623611945;4293.227219100592;4342.934855977162;5553.972230138905;5554.944450555524;5557.916631250535;5565.026120428909;5601.80393686219;5929.466348028698;6089.330173680892;6102.72537735803;6107.84730381744;6119.694015299217;5439.592030597721;5479.780808767684;5570.3315602127195;5575.52608028314;5577.9442205577425;5291.894162116813;5361.865953351197;5370.221317908881;5393.298871146726;5426.511613954763;5243.977424402205;6250.437460628384;6253.187085678833;6267.749290028531;6282.089097080806;6079.696015199134;6099.3900609938655;6215.81352559424;6220.066989951543;6236.812895612958;5782.479576838105;6150.384961503813;6233.532485063729;6238.908191066636;6263.843403914939;6149.938500614937;6176.66028368444;6176.8764624706355;6176.907346389898;6186.041163619646;6158.045502946871;6199.039148931923;6226.906596401148;6233.96883015582;6261.843453913689;5797.072468405035;5859.033259512304;5983.58114931968;6011.128386383863;6046.90929636047;5891.204687367322;6063.848403789941;6069.180660610761;6081.361457046946;6128.724207410588;5872.236609240771;5891.734871930687;5897.469227769521;5905;5913.881722365614;5837.270341207349;5914.556408269311;5965.821025369246;5992.43071908168;6002.219711437485;5834.38738932406;5857.121431785095;5859;5888.882222355443;5913.881722365614 15:41:04 INFO - PROCESS | 1659 | |1;ext.html;461.18600669817766;471.55202557570294;475.37488203013027;523.4373048972355;524.9632525723199;30110;30351;30509.694903050964;30545;39708;38763.806180969055;40967.79516102415;41178;41323.79338103305;41370.414993975806;9613.855792163124;9667.226621870268;9691.95154024229;9823.312368134233;9826.115649591535;9585.712428627152;9685.806283874319;9686;9687.418754874694;9697.660581879636;9645.565949532252;9714;9718;9724.951375243149;9807.607695692164;9636.855447168298;9682.70951871445;9700.563474643657;9705.514724263758;9714.90285097147;9545.331826772128;9610.279229057849;9611.086946740119;9636.807263854684;9640.120176565573;38974.415383769265;39215.8039209805;39264.01839954024;39323;39387;2928.6632037315767;3200.471922132845;3276.885309014197;3679.521662183926;3794.4687743715626;30245.848770756227;30611.387772244652;30827.691723082706;31286;31333.843330783428;3188.2029492626843;3207.1982004498877;3251.821149836758;3282.917927051819;3333.633300336961;366898;367100;367346;367355;371400;32358.191045223586;33004.66995330064;33044.66955330464;33103.87578298023;56921;33771.83114084463;34052;34063;34086.82956585251;34123.48814767731;11936.820947685617;14104.788428173586;14141.929290353482;14214.857851421353;14232.359543820552;12089.03287736979;12170.513179472722;12197.573084941985;12232.75534489323;12253.877461225451;6345.365463453618;7597.810054748676;7692;7713.112992005879;7724.729634462767;2733.988424283028;3180.45932191528;3239.303549736818;3240.756943229267;3272.1165285372817;985.261054209343;988.2538683294067;1011.6256984915481;1023.4729114506035;1061.57536985205;28180.29549261244;29281.888948615717;29608.111756647337;29710.55434168446;29885.252868678457;854.5897968974926;1004.9447280399648;1042.457921880633;1047.675220681591;1095.917806164541;12266.386680665932;13871.167729936236;14725.042872213271;14741.41034358635;15019;704171;708464;708807;709242;710882;55479.44520554823;55960.72019639957;55965;56057.71971140118;56082.71958640181;1051.4427353502808;1060.3796778884284;1122.3322123336602;1185.958491452795;1255.6546949588935;25960.610590840774;28877.422451551272;29142.70857291485;30195.245118871324;30757.53863692091;53572;54288;54301.72849135729;54333.72833135809;54481;623042;627181;628707;629812;630733;25614.87192564025;26110.477790444464;26132.60801087947;26204.213873583823;40111.39832902567;44479.77760111179;44692;44820;45209.54790452185;45240.32139517976;32086.6791332093;37755.81122094372;37946.810265948494;38111.28499217597;39199;37114.814425927696;37444;37471.41212873189;38325.4251186238;38350.80824595859;36918.815405922796;37150.88547343584;37545.68590099333;37627;37774.62225377821;31404.528932066496;33370.99887003394;33731.662683373834;34020;34094.31811363808;24071.51856962816;24946;25358.746412536377;25370.746292536838;25542.489150217265 15:41:04 INFO - PROCESS | 1659 | |2;jquery.html;352.4413804120469;371.7936545217405;372.7390826421505;378.62137862137854;400.1576681086313;15538.300776465057;15808.525744227678;17100.91449542752;20498.282560110398;21280.46798830026;19447.319343822932;20111.798882011175;20192.889391083485;20440.488987775312;20697.896510517425;4673.76631168442;5447.291852059237;5661.122526008455;5698.629589076718;5709.857253568653;6171.845703857394;6255.186825712673;6296.464800491964;6297.307296197415;6311.431971122598;5806.419358064181;5946.197263369455;6165.784197553086;6249.625022498664;6269.247690277173;6147.354527774586;6205.348438413992;6208.6585237811905;6212.223472065969;6220.502359811227;5160.200168973777;5217.217417387385;5464.836054918359;5466.426025267329;5471.616986810925;13385.86614133856;13522;13528.864711352859;23912;25115.497690046097;2036.572319812841;2084.3121769815925;2244.394013616331;2262.2195342606774;2642.735726427361;8527.914720852774;9565.421705418597;10474.162067034695;13274.601761947157;14515.70968580633;1764.24137620823;1826.634673065379;1831.7801863776433;1869.2336142181775;1918.2902326139279;91358;109230.45384773026;125143.99999999908;126534;127430;11159;11440.370779607036;11470.139739519569;11473.196876218752;11655.02796786831;14535.127892326283;14572;14575.271236438348;14580.416783328548;14605;7498.762704153863;8177.877331839908;8430.536320502308;8489.74530764078;8564.886564746668;7988.201179881965;8380.329573634095;8398.622062007224;8557.957210213908;8566.82866342682;4388.451443569554;4486.461624605068;4494.213512635276;4555.362249285103;4606.378138951266;1595.920203989796;1830.9816901831077;1882.3552908164052;1891.290765962764;1898.7531620889197;816.1960468938091;842.2630198576246;867.5748883047388;894.3024440936081;919.287552147078;16881.746773798404;20163.798362016485;20834.958252087334;21163.894180529307;21317.68023479649;867.2411639815161;883.0815951410461;889.3596610440472;909.4497828813472;915.208344781759;7406.962965185139;8279.710210142615;9540.236781057498;10991.340519568852;11074.667759967213;584423;586950;589670.6010568369;601378;602341;126534.3673281646;127097;128893.71106289004;131572;131752;939.281449690987;944.8110377924443;977.9951100244454;978.1587834462357;980.4117529482396;17023.31906723717;18366.265349385874;18490.81509184891;18516.888986660844;18579.72130418072;37766.055848602904;49658.75170624124;50762.98474030573;50850.49149508458;51024.74487627538;77405.48539660746;77985.61007194928;78301;79088;79127;6816.216135144522;7798.6604018793005;7871.881921771293;8149.551774652451;8161.79595510117;10679.626213082505;12977.961763058744;13183.945284377034;13295.80056299137;13400.262985535499;8512.70205542803;11055.889441105808;11293.71765705864;11468.483918223534;11542.19204655666;10840.403777792297;11055.447227638426;11093.889061109609;11435.142364322543;11720.941395292968;10515.158787296845;10641.680749577525;11367.488463019019;11664.241824281395;12048.518059277882;7271.636418179176;7339.889901651372;7435.442341824493;7537.359324457482;7601.581912994618;10618.893811061791;11041.44792760375;11067.778644427228;11396.658100257006;11485.885141148481 15:41:04 INFO - PROCESS | 1659 | |3;mootools.html;1337.5786627212422;1508.8415716349782;1525.5957171349592;1707.240278076256;1884.180381534033;7736.419768517362;8193.46742461741;8201.425900186989;8203.26170644642;8203.548804815733;8316.667333306676;8471.830563388728;8514.191151840581;8616.31069514439;8689.522076285803;2333.230034088751;2365.9763402366016;2366.408397900525;2367.147826782357;2369.597168481362;2303.608386574286;2346.9647955280684;2350.1304517328613;2354.09367393553;2354.105439932823;2321.93034208974;2342.063174730113;2352.9882350588223;2355.9882200588972;2357.610994185966;1975.5950030243766;2303.1593468384085;2325.988370058156;2326.7091613548305;2336.1823361823394;2312.09828167015;2322.2336628912585;2323.628219484874;2325;2336.3341447687326;8552.187542183483;8672.826543469095;8673.13268673134;8673.219410253107;8686.174813392781;4389.736615803062;5037.596992240648;5059;5226.163813789775;5235.952809438089;2886.354777776647;2952.3062080411087;3314.7531740418362;3481.529993450877;3488.7034602058857;933.5658918602883;1004.382304882492;1027.244974943416;1034.7051090439263;1051.952662130206;11459.65621031362;11472.598459053894;11475.77048459026;11477.483513241925;11492;4344;4517.841875534341;4600.976995115003;4797.64017698674;4820.493848145894;8961.731148065568;9009.594568244445;9021.32340074497;9025.41334813235;9026.774330641656;5155.226715992631;5169.689818610896;5170.793168273302;5174.482551744795;5175.120229560984;3825.6365645263654;4388.144311859157;4538.704984176018;4785.545373189541;4853.975730121398;3569.589497207802;3624.1120925373452;3703.4259689748133;3714.6285371462636;3717.442383642421;1113.9108871290277;1117.943543351525;1130.5929865248504;1133.5409159290336;1137.5734099712608;764.9923500764921;780.9297163255334;820.4216027700456;882.3867412148495;890.0120865838913;4477.753723545171;5625.296837895263;5639.379668236491;5704.572157088235;5733.827985160452;327.3208093206606;400.62585332310454;419.89502624343913;440.9448818897638;444.9666275029386;3697.815109244527;3876.3604005339366;3901.6878649707955;3929.7838618876235;3985.103351745892;8258.545779982158;10498.002689744462;10510.421926794099;10530.15758739299;10540.156787456985;10463.790724185474;10466.947665261625;10475;10480;10484.161267098614;6671.432928201158;7667.156612772591;7921.881171782428;8026.157253488416;8032.0763112241675;5552.139418390156;5660.490555849993;5696.259486266758;5749.281339832521;5836.095405212199;9426;9556.85664715016;9597.856032159663;9794.608215671578;9892.901070989197;9289.396189247676;9983.500824958577;9994.60021599157;10008.549615267184;10010.249231307535;6353.205849268841;6582.078509008838;6589.143411356685;6814.4548436124;6893.862122757617;6528.510361722985;8071.959640201761;8244.752657420288;8306.626201821053;8319.625616847377;6381.074744162163;6687.866242675216;7254.963725181551;7403.333699967029;7475.551466912003;6205.875882482415;7288.890666639899;7335.669894854851;7343.522671026366;7384.4830861839155;6646.069550263063;6878.243393226841;6912;6940.895886561807;7018.473614478832;4663.766811659336;4748.881277968078;4831.4685384608365;5012.6240531960975;5129.538341549279;4099.590040995877;4862.3922009748785;5026.899462010812;5074.720890351066;5168.198929165986 15:41:04 INFO - PROCESS | 1659 | |4;prototype.html;287.92226098953284;293.8809782038274;302.974247188989;307.271765914782;308.94284557356906;5172.715500647463;5217.947820521794;5255.527002569768;5281.656692314997;5281.788728450857;4125.834966601333;4847.709137451747;4945.802167913288;4975.009996001601;5173.560247378968;3394.083597428693;3516.613172551017;3986.720929534934;3989.8603548875794;3992.301347264224;3303.3648344069597;4009.87723437438;4045.656119229869;4074;4085.816138273785;3331.6002079750465;3845.293763945288;3965.600811509039;3969.960300396988;4060.776657283848;3300.884469043596;3953.446517487554;3958.535341923478;3986.8405263789414;4019.2114509043486;2967.55486676998;3282.3599398117376;3399.286149908522;3480.721542276637;3487.0011789860955;4367.139523612039;4940.110780059588;4957.727324997124;5014.398272207359;5093.5415812576675;4242.681798865066;4561.042181141964;4572.5427457254345;4580.610648094916;4581.358609794632;5387.299651045379;5421.186821976696;5465.415029641399;5473.4149132318;5503.7798488060425;2994.8053376530675;3705.7950519440888;3840.577536470986;3862.633049860287;3873.8837834864717;5261.210818377236;5590.636608620427;5639.577031722637;5719.599628025998;5740.138979153118;3088.7528997680133;3590.281943611288;3765.548134223911;3769.246150769857;3781.5819067849557;3506.7194624429985;3847.672947799412;3854.49891514107;3856.190200057963;3856.2094770571966;4270.636995855387;4493.370928070073;4498.932516012263;4506.977465112719;4518;4521.276595744665;5434.060306277996;5478.506934375925;5509.393966663663;5514.580959804866;1226.6687994241504;1280.7182419867613;1291.438224372401;1374.1892283552552;1381.730562540295;866.9566521674017;886.3263919421287;890.0609856601218;894.5482531321641;895.1764376773384;4187.597154953125;4269.423627810268;4360.520342762357;4363.672724545671;4796.400449943757;4014.136960553495;4311.676624253194;4601.677882548256;4676.906461870743;4744.905101898012;3704.5369328833895;3879.157400234922;4124.876253712393;4191.371294305817;4327.826886924488;2066.6463466429514;2180.6510958246604;2236.3849941265958;2416.6495858100475;2425.2845410603913;4720.622350211975;4758.357621721093;4795.588058985742;4838.225883858566;4951.801927922915;3908.9804550977065;4407.2507673695545;4519.909601807945;4612.95387046132;4804.180676362301;3793.506844110248;4206.41110244566;4402.801873915618;4796.616270698266;4818.831340903122;4083.7748675397856;4111.787022828213;4358.585934336233;4451.777411129366;4473.530279320625;3956.0329752685484;4375.256206444976;4468.709533880287;4535.349044019464;4660.906781864412;3806.6954643628997;3999.5800440954445;4366.318967197588;4455.6212721919;4773.761311934459;2912.3643102991828;3375.9703290495654;3390.4744764561533;3405.812680302607;3422.7432942528912;3780.827943337574;4621.498013145809;4639.512851150581;4639.721616703008;4664.4869064403565;3506.053365591225;3977.244323578511;4160.479940007499;4465.218586747371;4531.365608814703;3955.5648878623906;4144.70987030905;4180.602842729936;4457.8439754608435;4595.517470665532;3998.3802510610903;4151.501819781645;4239.894002649835;4352.78236088188;4424.902568202207;4299.97850010748;5147.768350424165;5180.404253510895;5336.226247194058;5442.863928401822;4841.975790121168;4844.612431005582;5173.560247378864;5248.658837175724;5263.315768950165 15:41:04 INFO - PROCESS | 1659 | |5;yui.html;579.3077272659172;625.5308518611042;701.2706784943659;713.7394850879431;812.4678335690121;14954.177520236382;15561.988470749407;16575.585610359747;17455.389061382855;17461.650766984654;15481.458148964788;15809.525714228563;15829.445969391074;15840.841591584109;15886.285117169726;737.9520331178483;847.5380917400016;875.0287181228831;875.7722992022057;877.2324216310728;687.6011913090396;706.8232941764559;707.8301207710139;714.5105602662167;864.515871112176;731.0897932074574;733.6185183704471;892.1301730812438;923.5474617437475;929.8605209218638;916.9958895009953;917.3303488453466;918.3066784577668;918.3204428722764;918.5499105438354;544.8528897197774;670.5272782688193;683.6205905722322;685.3283781893772;685.8422562810532;12122.333271670055;12543.184692995017;14759.114453132739;15260.31328590216;15318.846811531854;13723.862761372458;14048.92975535126;14124.293785310694;14141.575752727435;14491.3478893449;10356.79286414275;11242.94378528102;11375.146863985152;11912.88087119135;12233.828547586738;3758.361078616642;3767.3783825668734;3774.67915227206;3790.507234059582;3908.394198899175;81069.18930810616;100323.49838250835;102237.4888125562;102540.46189307091;102683.48658256736;10311.84532232017;10459.68620941373;10809.83785243222;10827.945860270649;11172.162087843282;21900.12399504034;22026.33920982373;22294.88852555759;22307.442313941956;22312.553748925257;7737.535747855034;7807.219278072261;7817.374610031297;7886.684532618746;7979.281864632211;4256.59562341577;4336.436263285816;4365.978170109129;4474.261746811805;4491.169133710274;3379.3579219948133;3453.188500702333;3485.703715184238;3492.9825350873084;3507.2459421224557;615.2156001098546;619.5693992675137;623.059180637232;628.7202195023262;629.0689779126918;584.5469760935309;599.6522017229996;654.5320096131289;686.989695154573;688.1638808847175;8802.735917922473;9238.815223695623;9287.257019438428;9426.104520070583;9479.431234125974;491.73732286280784;583.7110630238059;592.7303077099909;635.9872802543923;651.563452486835;4482.238019536687;4538.183127037165;4635.142498637762;4639.327297541838;4790.377250957354;87796.56101719578;88243.67634485487;140144;147702.26148869187;150369;103804;125556;128316.71683283235;129440.35279823729;131099;71500.64249678719;85669.28818914895;107458;111350.44324778486;113091.86908130978;7932.960335198287;8688.218060374596;8860.158284962918;8870.86693699582;8897;54748.72625636846;54971.175432369346;60291.492712682535;61671.6916415415;61843.381566183765;82763.5861820687;90121;91680.54159729158;91791;98115.50942245529;11945.880541194478;13924.2341671205;14099.365528551445;14477;14526;12998.895093917123;14392.784108238175;14519.419223230952;14792.852071479147;15720.528384148494;13317.66705832362;13876.167429954236;14074.507392241223;14092.859071409564;14486.203258820866;13996.230207338695;14262.500812471513;14302.356393962089;14730.484433044792;14803.777943330644;13565.309107553434;13665.31673416345;13872.306384680927;14268.57194284173;14292.285385730464;11238.599588113968;11407.429628518707;11672.299662020307;11934.343611101473;11939.582114625946;11092.279001864854;11490.540378385105;11727.589534366256;11732.472038758448;11809.586664466702 15:41:04 INFO - PROCESS | 1659 | __end_tp_report 15:41:04 INFO - PROCESS | 1659 | __start_cc_report 15:41:04 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1736 15:41:04 INFO - PROCESS | 1659 | __end_cc_report 15:41:04 INFO - PROCESS | 1659 | __startTimestamp1475620864789__endTimestamp 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | ------- Summary: start ------- 15:41:04 INFO - PROCESS | 1659 | Number of tests: 6 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5641.74 Median:5859.00 stddev:656.95 (11.2%) stddev-sans-first:631.10 15:41:04 INFO - PROCESS | 1659 | Values: 3228.3 3235.3 3237.4 3254.2 3282.3 5500.6 5576.8 5598.6 5658.2 5688.6 5576.6 5613.6 5696.4 5720.1 5758.3 4309.9 5028.2 5065.7 5087.3 5124.6 5120.9 5193.2 5193.2 5215.9 5258.7 5098.7 5142.5 5244.9 5257.1 5317.3 5177.9 5194.4 5199.9 5200.8 5202.9 5110.6 5159.8 5163.1 5166.4 5172.3 5622.3 5635.0 5635.2 5647.8 5647.9 6091.1 6091.2 6094.7 6121.0 6123.3 6150.6 6165.5 6223.7 6236.5 6239.7 5644.7 5682.0 5682.5 5690.1 5697.4 6150.7 6258.6 6265.8 6268.4 6271.2 5919.2 5972.6 6005.6 6008.9 6019.1 6094.7 6095.0 6099.1 6108.3 6111.7 5084.3 6093.8 6103.7 6122.0 6125.6 6130.4 6138.9 6139.3 6140.8 6147.8 4767.0 4801.9 4869.0 4891.7 4929.0 3550.3 4247.8 4252.8 4293.2 4342.9 5554.0 5554.9 5557.9 5565.0 5601.8 5929.5 6089.3 6102.7 6107.8 6119.7 5439.6 5479.8 5570.3 5575.5 5577.9 5291.9 5361.9 5370.2 5393.3 5426.5 5244.0 6250.4 6253.2 6267.7 6282.1 6079.7 6099.4 6215.8 6220.1 6236.8 5782.5 6150.4 6233.5 6238.9 6263.8 6149.9 6176.7 6176.9 6176.9 6186.0 6158.0 6199.0 6226.9 6234.0 6261.8 5797.1 5859.0 5983.6 6011.1 6046.9 5891.2 6063.8 6069.2 6081.4 6128.7 5872.2 5891.7 5897.5 5905.0 5913.9 5837.3 5914.6 5965.8 5992.4 6002.2 5834.4 5857.1 5859.0 5888.9 5913.9 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:67804.59 Median:204275.44 stddev:157801.14 (77.2%) stddev-sans-first:158162.81 15:41:04 INFO - PROCESS | 1659 | Values: 461.2 471.6 475.4 523.4 525.0 30110.0 30351.0 30509.7 30545.0 39708.0 38763.8 40967.8 41178.0 41323.8 41370.4 9613.9 9667.2 9692.0 9823.3 9826.1 9585.7 9685.8 9686.0 9687.4 9697.7 9645.6 9714.0 9718.0 9725.0 9807.6 9636.9 9682.7 9700.6 9705.5 9714.9 9545.3 9610.3 9611.1 9636.8 9640.1 38974.4 39215.8 39264.0 39323.0 39387.0 2928.7 3200.5 3276.9 3679.5 3794.5 30245.8 30611.4 30827.7 31286.0 31333.8 3188.2 3207.2 3251.8 3282.9 3333.6 366898.0 367100.0 367346.0 367355.0 371400.0 32358.2 33004.7 33044.7 33103.9 56921.0 33771.8 34052.0 34063.0 34086.8 34123.5 11936.8 14104.8 14141.9 14214.9 14232.4 12089.0 12170.5 12197.6 12232.8 12253.9 6345.4 7597.8 7692.0 7713.1 7724.7 2734.0 3180.5 3239.3 3240.8 3272.1 985.3 988.3 1011.6 1023.5 1061.6 28180.3 29281.9 29608.1 29710.6 29885.3 854.6 1004.9 1042.5 1047.7 1095.9 12266.4 13871.2 14725.0 14741.4 15019.0 704171.0 708464.0 708807.0 709242.0 710882.0 55479.4 55960.7 55965.0 56057.7 56082.7 1051.4 1060.4 1122.3 1186.0 1255.7 25960.6 28877.4 29142.7 30195.2 30757.5 53572.0 54288.0 54301.7 54333.7 54481.0 623042.0 627181.0 628707.0 629812.0 630733.0 25614.9 26110.5 26132.6 26204.2 40111.4 44479.8 44692.0 44820.0 45209.5 45240.3 32086.7 37755.8 37946.8 38111.3 39199.0 37114.8 37444.0 37471.4 38325.4 38350.8 36918.8 37150.9 37545.7 37627.0 37774.6 31404.5 33371.0 33731.7 34020.0 34094.3 24071.5 24946.0 25358.7 25370.7 25542.5 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34370.57 Median:19069.40 stddev:99078.75 (519.6%) stddev-sans-first:99323.77 15:41:04 INFO - PROCESS | 1659 | Values: 352.4 371.8 372.7 378.6 400.2 15538.3 15808.5 17100.9 20498.3 21280.5 19447.3 20111.8 20192.9 20440.5 20697.9 4673.8 5447.3 5661.1 5698.6 5709.9 6171.8 6255.2 6296.5 6297.3 6311.4 5806.4 5946.2 6165.8 6249.6 6269.2 6147.4 6205.3 6208.7 6212.2 6220.5 5160.2 5217.2 5464.8 5466.4 5471.6 13385.9 13522.0 13528.9 23912.0 25115.5 2036.6 2084.3 2244.4 2262.2 2642.7 8527.9 9565.4 10474.2 13274.6 14515.7 1764.2 1826.6 1831.8 1869.2 1918.3 91358.0 109230.5 125144.0 126534.0 127430.0 11159.0 11440.4 11470.1 11473.2 11655.0 14535.1 14572.0 14575.3 14580.4 14605.0 7498.8 8177.9 8430.5 8489.7 8564.9 7988.2 8380.3 8398.6 8558.0 8566.8 4388.5 4486.5 4494.2 4555.4 4606.4 1595.9 1831.0 1882.4 1891.3 1898.8 816.2 842.3 867.6 894.3 919.3 16881.7 20163.8 20835.0 21163.9 21317.7 867.2 883.1 889.4 909.4 915.2 7407.0 8279.7 9540.2 10991.3 11074.7 584423.0 586950.0 589670.6 601378.0 602341.0 126534.4 127097.0 128893.7 131572.0 131752.0 939.3 944.8 978.0 978.2 980.4 17023.3 18366.3 18490.8 18516.9 18579.7 37766.1 49658.8 50763.0 50850.5 51024.7 77405.5 77985.6 78301.0 79088.0 79127.0 6816.2 7798.7 7871.9 8149.6 8161.8 10679.6 12978.0 13183.9 13295.8 13400.3 8512.7 11055.9 11293.7 11468.5 11542.2 10840.4 11055.4 11093.9 11435.1 11720.9 10515.2 10641.7 11367.5 11664.2 12048.5 7271.6 7339.9 7435.4 7537.4 7601.6 10618.9 11041.4 11067.8 11396.7 11485.9 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5459.01 Median:4858.18 stddev:3100.73 (63.8%) stddev-sans-first:3093.96 15:41:04 INFO - PROCESS | 1659 | Values: 1337.6 1508.8 1525.6 1707.2 1884.2 7736.4 8193.5 8201.4 8203.3 8203.5 8316.7 8471.8 8514.2 8616.3 8689.5 2333.2 2366.0 2366.4 2367.1 2369.6 2303.6 2347.0 2350.1 2354.1 2354.1 2321.9 2342.1 2353.0 2356.0 2357.6 1975.6 2303.2 2326.0 2326.7 2336.2 2312.1 2322.2 2323.6 2325.0 2336.3 8552.2 8672.8 8673.1 8673.2 8686.2 4389.7 5037.6 5059.0 5226.2 5236.0 2886.4 2952.3 3314.8 3481.5 3488.7 933.6 1004.4 1027.2 1034.7 1052.0 11459.7 11472.6 11475.8 11477.5 11492.0 4344.0 4517.8 4601.0 4797.6 4820.5 8961.7 9009.6 9021.3 9025.4 9026.8 5155.2 5169.7 5170.8 5174.5 5175.1 3825.6 4388.1 4538.7 4785.5 4854.0 3569.6 3624.1 3703.4 3714.6 3717.4 1113.9 1117.9 1130.6 1133.5 1137.6 765.0 780.9 820.4 882.4 890.0 4477.8 5625.3 5639.4 5704.6 5733.8 327.3 400.6 419.9 440.9 445.0 3697.8 3876.4 3901.7 3929.8 3985.1 8258.5 10498.0 10510.4 10530.2 10540.2 10463.8 10466.9 10475.0 10480.0 10484.2 6671.4 7667.2 7921.9 8026.2 8032.1 5552.1 5660.5 5696.3 5749.3 5836.1 9426.0 9556.9 9597.9 9794.6 9892.9 9289.4 9983.5 9994.6 10008.5 10010.2 6353.2 6582.1 6589.1 6814.5 6893.9 6528.5 8072.0 8244.8 8306.6 8319.6 6381.1 6687.9 7255.0 7403.3 7475.6 6205.9 7288.9 7335.7 7343.5 7384.5 6646.1 6878.2 6912.0 6940.9 7018.5 4663.8 4748.9 4831.5 5012.6 5129.5 4099.6 4862.4 5026.9 5074.7 5168.2 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4022.76 Median:4340.30 stddev:1197.03 (27.6%) stddev-sans-first:1167.10 15:41:04 INFO - PROCESS | 1659 | Values: 287.9 293.9 303.0 307.3 308.9 5172.7 5217.9 5255.5 5281.7 5281.8 4125.8 4847.7 4945.8 4975.0 5173.6 3394.1 3516.6 3986.7 3989.9 3992.3 3303.4 4009.9 4045.7 4074.0 4085.8 3331.6 3845.3 3965.6 3970.0 4060.8 3300.9 3953.4 3958.5 3986.8 4019.2 2967.6 3282.4 3399.3 3480.7 3487.0 4367.1 4940.1 4957.7 5014.4 5093.5 4242.7 4561.0 4572.5 4580.6 4581.4 5387.3 5421.2 5465.4 5473.4 5503.8 2994.8 3705.8 3840.6 3862.6 3873.9 5261.2 5590.6 5639.6 5719.6 5740.1 3088.8 3590.3 3765.5 3769.2 3781.6 3506.7 3847.7 3854.5 3856.2 3856.2 4270.6 4493.4 4498.9 4507.0 4518.0 4521.3 5434.1 5478.5 5509.4 5514.6 1226.7 1280.7 1291.4 1374.2 1381.7 867.0 886.3 890.1 894.5 895.2 4187.6 4269.4 4360.5 4363.7 4796.4 4014.1 4311.7 4601.7 4676.9 4744.9 3704.5 3879.2 4124.9 4191.4 4327.8 2066.6 2180.7 2236.4 2416.6 2425.3 4720.6 4758.4 4795.6 4838.2 4951.8 3909.0 4407.3 4519.9 4613.0 4804.2 3793.5 4206.4 4402.8 4796.6 4818.8 4083.8 4111.8 4358.6 4451.8 4473.5 3956.0 4375.3 4468.7 4535.3 4660.9 3806.7 3999.6 4366.3 4455.6 4773.8 2912.4 3376.0 3390.5 3405.8 3422.7 3780.8 4621.5 4639.5 4639.7 4664.5 3506.1 3977.2 4160.5 4465.2 4531.4 3955.6 4144.7 4180.6 4457.8 4595.5 3998.4 4151.5 4239.9 4352.8 4424.9 4300.0 5147.8 5180.4 5336.2 5442.9 4842.0 4844.6 5173.6 5248.7 5263.3 15:41:04 INFO - PROCESS | 1659 | 15:41:04 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:23294.99 Median:3762.87 stddev:35920.17 (954.6%) stddev-sans-first:35980.44 15:41:04 INFO - PROCESS | 1659 | Values: 579.3 625.5 701.3 713.7 812.5 14954.2 15562.0 16575.6 17455.4 17461.7 15481.5 15809.5 15829.4 15840.8 15886.3 738.0 847.5 875.0 875.8 877.2 687.6 706.8 707.8 714.5 864.5 731.1 733.6 892.1 923.5 929.9 917.0 917.3 918.3 918.3 918.5 544.9 670.5 683.6 685.3 685.8 12122.3 12543.2 14759.1 15260.3 15318.8 13723.9 14048.9 14124.3 14141.6 14491.3 10356.8 11242.9 11375.1 11912.9 12233.8 3758.4 3767.4 3774.7 3790.5 3908.4 81069.2 100323.5 102237.5 102540.5 102683.5 10311.8 10459.7 10809.8 10827.9 11172.2 21900.1 22026.3 22294.9 22307.4 22312.6 7737.5 7807.2 7817.4 7886.7 7979.3 4256.6 4336.4 4366.0 4474.3 4491.2 3379.4 3453.2 3485.7 3493.0 3507.2 615.2 619.6 623.1 628.7 629.1 584.5 599.7 654.5 687.0 688.2 8802.7 9238.8 9287.3 9426.1 9479.4 491.7 583.7 592.7 636.0 651.6 4482.2 4538.2 4635.1 4639.3 4790.4 87796.6 88243.7 140144.0 147702.3 150369.0 103804.0 125556.0 128316.7 129440.4 131099.0 71500.6 85669.3 107458.0 111350.4 113091.9 7933.0 8688.2 8860.2 8870.9 8897.0 54748.7 54971.2 60291.5 61671.7 61843.4 82763.6 90121.0 91680.5 91791.0 98115.5 11945.9 13924.2 14099.4 14477.0 14526.0 12998.9 14392.8 14519.4 14792.9 15720.5 13317.7 13876.2 14074.5 14092.9 14486.2 13996.2 14262.5 14302.4 14730.5 14803.8 13565.3 13665.3 13872.3 14268.6 14292.3 11238.6 11407.4 11672.3 11934.3 11939.6 11092.3 11490.5 11727.6 11732.5 11809.6 15:41:04 INFO - PROCESS | 1659 | -------- Summary: end -------- 15:41:04 INFO - PROCESS | 1659 | 15:41:05 INFO - TEST-INFO | 1659: exit 0 15:41:05 INFO - TEST-OK | dromaeo_css | took 1117994ms 15:41:05 INFO - TEST-START | kraken 15:41:05 INFO - operating with platform_type : mac_ 15:41:05 INFO - Initialising browser for kraken test... 15:41:05 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpD3b5tP/profile http://localhost:49280/getInfo.html) 15:41:07 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 15:41:07 INFO - PROCESS | 1666 | colorDepth:24 15:41:07 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 15:41:07 INFO - PROCESS | 1666 | __metrics 15:41:07 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:41:07 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:08 INFO - TEST-INFO | 1666: exit 0 15:41:08 INFO - Browser initialized. 15:41:08 INFO - Running cycle 1/1 for kraken test... 15:41:08 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpD3b5tP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:20 INFO - PROCESS | 1667 | RSS: Main: 236122112 15:41:20 INFO - PROCESS | 1667 | 15:41:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:24 INFO - PROCESS | 1667 | RSS: Main: 295055360 15:41:24 INFO - PROCESS | 1667 | 15:41:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 15:41:27 INFO - PROCESS | 1667 | RSS: Main: 293941248 15:41:27 INFO - PROCESS | 1667 | 15:41:30 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 15:41:31 INFO - PROCESS | 1667 | RSS: Main: 385974272 15:41:31 INFO - PROCESS | 1667 | 15:41:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 15:41:34 INFO - PROCESS | 1667 | RSS: Main: 285589504 15:41:34 INFO - PROCESS | 1667 | 15:41:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:36 INFO - PROCESS | 1667 | RSS: Main: 291037184 15:41:36 INFO - PROCESS | 1667 | 15:41:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:40 INFO - PROCESS | 1667 | RSS: Main: 328773632 15:41:40 INFO - PROCESS | 1667 | 15:41:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 15:41:43 INFO - PROCESS | 1667 | RSS: Main: 329924608 15:41:43 INFO - PROCESS | 1667 | 15:41:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 15:41:47 INFO - PROCESS | 1667 | RSS: Main: 327696384 15:41:47 INFO - PROCESS | 1667 | 15:41:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:41:49 INFO - PROCESS | 1667 | RSS: Main: 304185344 15:41:49 INFO - PROCESS | 1667 | 15:41:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:41:51 INFO - PROCESS | 1667 | RSS: Main: 306786304 15:41:51 INFO - PROCESS | 1667 | 15:41:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:41:54 INFO - PROCESS | 1667 | RSS: Main: 311037952 15:41:54 INFO - PROCESS | 1667 | 15:41:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:41:58 INFO - PROCESS | 1667 | RSS: Main: 327282688 15:41:58 INFO - PROCESS | 1667 | 15:42:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:02 INFO - PROCESS | 1667 | RSS: Main: 320524288 15:42:02 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 15:42:04 INFO - PROCESS | 1667 | RSS: Main: 364404736 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | __start_tp_report 15:42:04 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 15:42:04 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 15:42:04 INFO - PROCESS | 1667 | |i|pagename|runs| 15:42:04 INFO - PROCESS | 1667 | |0;ai-astar;111;113;113;112;111;114;112;111;110;117 15:42:04 INFO - PROCESS | 1667 | |1;audio-beat-detection;151;114;115;152;114;114;113;112;149;113 15:42:04 INFO - PROCESS | 1667 | |2;audio-dft;182;185;181;186;184;186;178;184;183;184 15:42:04 INFO - PROCESS | 1667 | |3;audio-fft;83;59;58;87;60;59;62;60;102;81 15:42:04 INFO - PROCESS | 1667 | |4;audio-oscillator;86;70;90;69;68;67;91;68;85;124 15:42:04 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;87;84;88;84;100;131;88;85;86;84 15:42:04 INFO - PROCESS | 1667 | |6;imaging-darkroom;93;110;149;118;93;93;93;94;93;93 15:42:04 INFO - PROCESS | 1667 | |7;imaging-desaturate;86;84;86;86;84;86;87;84;84;86 15:42:04 INFO - PROCESS | 1667 | |8;json-parse-financial;57;56;54;53;55;55;56;55;55;54 15:42:04 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;64;69;80;76;72;70;69;71;69;71 15:42:04 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;91;89;85;88;100;109;110;101;91;94 15:42:04 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;141;145;153;159;165;144;147;147;177;143 15:42:04 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;176;173;177;174;176;174;174;173;177;236 15:42:04 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;60;82;90;69;68;69;69;69;69;71 15:42:04 INFO - PROCESS | 1667 | __end_tp_report 15:42:04 INFO - PROCESS | 1667 | __start_cc_report 15:42:04 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1937 15:42:04 INFO - PROCESS | 1667 | __end_cc_report 15:42:04 INFO - PROCESS | 1667 | __startTimestamp1475620924281__endTimestamp 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | ------- Summary: start ------- 15:42:04 INFO - PROCESS | 1667 | Number of tests: 14 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:2.01 (1.8%) stddev-sans-first:2.07 15:42:04 INFO - PROCESS | 1667 | Values: 111.0 113.0 113.0 112.0 111.0 114.0 112.0 111.0 110.0 117.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:114.50 stddev:17.95 (15.7%) stddev-sans-first:16.32 15:42:04 INFO - PROCESS | 1667 | Values: 151.0 114.0 115.0 152.0 114.0 114.0 113.0 112.0 149.0 113.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.45 (1.3%) stddev-sans-first:2.55 15:42:04 INFO - PROCESS | 1667 | Values: 182.0 185.0 181.0 186.0 184.0 186.0 178.0 184.0 183.0 184.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:71.10 Median:61.00 stddev:15.78 (25.9%) stddev-sans-first:16.14 15:42:04 INFO - PROCESS | 1667 | Values: 83.0 59.0 58.0 87.0 60.0 59.0 62.0 60.0 102.0 81.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:77.50 stddev:17.84 (23.0%) stddev-sans-first:18.85 15:42:04 INFO - PROCESS | 1667 | Values: 86.0 70.0 90.0 69.0 68.0 67.0 91.0 68.0 85.0 124.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:85.50 stddev:14.60 (17.1%) stddev-sans-first:15.38 15:42:04 INFO - PROCESS | 1667 | Values: 87.0 84.0 88.0 84.0 100.0 131.0 88.0 85.0 86.0 84.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:93.00 stddev:18.47 (19.9%) stddev-sans-first:19.24 15:42:04 INFO - PROCESS | 1667 | Values: 93.0 110.0 149.0 118.0 93.0 93.0 93.0 94.0 93.0 93.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 15:42:04 INFO - PROCESS | 1667 | Values: 86.0 84.0 86.0 86.0 84.0 86.0 87.0 84.0 84.0 86.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.15 (2.1%) stddev-sans-first:0.97 15:42:04 INFO - PROCESS | 1667 | Values: 57.0 56.0 54.0 53.0 55.0 55.0 56.0 55.0 55.0 54.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:4.33 (6.1%) stddev-sans-first:3.76 15:42:04 INFO - PROCESS | 1667 | Values: 64.0 69.0 80.0 76.0 72.0 70.0 69.0 71.0 69.0 71.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:88.50 stddev:8.78 (9.9%) stddev-sans-first:9.14 15:42:04 INFO - PROCESS | 1667 | Values: 91.0 89.0 85.0 88.0 100.0 109.0 110.0 101.0 91.0 94.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:150.00 stddev:11.59 (7.7%) stddev-sans-first:11.58 15:42:04 INFO - PROCESS | 1667 | Values: 141.0 145.0 153.0 159.0 165.0 144.0 147.0 147.0 177.0 143.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:176.00 stddev:19.38 (11.0%) stddev-sans-first:20.48 15:42:04 INFO - PROCESS | 1667 | Values: 176.0 173.0 177.0 174.0 176.0 174.0 174.0 173.0 177.0 236.0 15:42:04 INFO - PROCESS | 1667 | 15:42:04 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:69.00 stddev:8.36 (12.1%) stddev-sans-first:7.74 15:42:04 INFO - PROCESS | 1667 | Values: 60.0 82.0 90.0 69.0 68.0 69.0 69.0 69.0 69.0 71.0 15:42:04 INFO - PROCESS | 1667 | -------- Summary: end -------- 15:42:04 INFO - PROCESS | 1667 | 15:42:05 INFO - TEST-INFO | 1667: exit 0 15:42:05 INFO - TEST-OK | kraken | took 59639ms 15:42:05 INFO - SUITE-END | took 1177s 15:42:05 INFO - Completed test suite (00:19:37) 15:42:05 INFO - javascript benchmark 15:42:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.3220523690024, 3235.2720637856482, 3237.3687131009465, 3254.1864533866533, 3282.3271229397974, 5500.642458240211, 5576.804811831586, 5598.552115830734, 5658.207850900877, 5688.63023903446, 5576.637518561291, 5613.550915926727, 5696.3733989261145, 5720.11338242572, 5758.3090029196555, 4309.900975251307, 5028.195488721805, 5065.696058236517, 5087.313212716292, 5124.590032797386, 5120.948790512084, 5193.195054766517, 5193.221016847484, 5215.921761173586, 5258.684478931257, 5098.719570423626, 5142.537171654531, 5244.895102097956, 5257.053730328539, 5317.308749862532, 5177.870553236162, 5194.4026436959475, 5199.948000519984, 5200.817971370984, 5202.869928251786, 5110.591152707774, 5159.793608255665, 5163.096458119814, 5166.380034395859, 5172.327597412313, 5622.269105016322, 5634.971825140889, 5635.239242702224, 5647.830565083054, 5647.8588035299035, 6091.14723938649, 6091.20956991861, 6094.729740455602, 6121.0, 6123.2652081750475, 6150.630962142286, 6165.537584681167, 6223.688815559204, 6236.469900058501, 6239.688015599202, 5644.74598643062, 5682.034054210794, 5682.460166284196, 5690.118031705134, 5697.401772813878, 6150.7232174552255, 6258.624482531062, 6265.843353916098, 6268.373162683695, 6271.184745982993, 5919.1713160157615, 5972.58191926561, 6005.6396616203165, 6008.948434024029, 6019.127226552126, 6094.692505457607, 6094.954753935788, 6099.085137229451, 6108.304828573744, 6111.682900513672, 5084.313617661568, 6093.847653808691, 6103.725332360054, 6122.032243765608, 6125.632272693312, 6130.356312587203, 6138.894998900151, 6139.250313660675, 6140.758623102535, 6147.815565533041, 4766.976165119221, 4801.879953001203, 4869.001854619794, 4891.730954797449, 4928.950710492849, 3550.2544465661986, 4247.8088486018205, 4252.808623611945, 4293.227219100592, 4342.934855977162, 5553.972230138905, 5554.944450555524, 5557.916631250535, 5565.026120428909, 5601.80393686219, 5929.466348028698, 6089.330173680892, 6102.72537735803, 6107.84730381744, 6119.694015299217, 5439.592030597721, 5479.780808767684, 5570.3315602127195, 5575.52608028314, 5577.9442205577425, 5291.894162116813, 5361.865953351197, 5370.221317908881, 5393.298871146726, 5426.511613954763, 5243.977424402205, 6250.437460628384, 6253.187085678833, 6267.749290028531, 6282.089097080806, 6079.696015199134, 6099.3900609938655, 6215.81352559424, 6220.066989951543, 6236.812895612958, 5782.479576838105, 6150.384961503813, 6233.532485063729, 6238.908191066636, 6263.843403914939, 6149.938500614937, 6176.66028368444, 6176.8764624706355, 6176.907346389898, 6186.041163619646, 6158.045502946871, 6199.039148931923, 6226.906596401148, 6233.96883015582, 6261.843453913689, 5797.072468405035, 5859.033259512304, 5983.58114931968, 6011.128386383863, 6046.90929636047, 5891.204687367322, 6063.848403789941, 6069.180660610761, 6081.361457046946, 6128.724207410588, 5872.236609240771, 5891.734871930687, 5897.469227769521, 5905.0, 5913.881722365614, 5837.270341207349, 5914.556408269311, 5965.821025369246, 5992.43071908168, 6002.219711437485, 5834.38738932406, 5857.121431785095, 5859.0, 5888.882222355443, 5913.881722365614], "value": 5597.783994662102, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.18600669817766, 471.55202557570294, 475.37488203013027, 523.4373048972355, 524.9632525723199, 30110.0, 30351.0, 30509.694903050964, 30545.0, 39708.0, 38763.806180969055, 40967.79516102415, 41178.0, 41323.79338103305, 41370.414993975806, 9613.855792163124, 9667.226621870268, 9691.95154024229, 9823.312368134233, 9826.115649591535, 9585.712428627152, 9685.806283874319, 9686.0, 9687.418754874694, 9697.660581879636, 9645.565949532252, 9714.0, 9718.0, 9724.951375243149, 9807.607695692164, 9636.855447168298, 9682.70951871445, 9700.563474643657, 9705.514724263758, 9714.90285097147, 9545.331826772128, 9610.279229057849, 9611.086946740119, 9636.807263854684, 9640.120176565573, 38974.415383769265, 39215.8039209805, 39264.01839954024, 39323.0, 39387.0, 2928.6632037315767, 3200.471922132845, 3276.885309014197, 3679.521662183926, 3794.4687743715626, 30245.848770756227, 30611.387772244652, 30827.691723082706, 31286.0, 31333.843330783428, 3188.2029492626843, 3207.1982004498877, 3251.821149836758, 3282.917927051819, 3333.633300336961, 366898.0, 367100.0, 367346.0, 367355.0, 371400.0, 32358.191045223586, 33004.66995330064, 33044.66955330464, 33103.87578298023, 56921.0, 33771.83114084463, 34052.0, 34063.0, 34086.82956585251, 34123.48814767731, 11936.820947685617, 14104.788428173586, 14141.929290353482, 14214.857851421353, 14232.359543820552, 12089.03287736979, 12170.513179472722, 12197.573084941985, 12232.75534489323, 12253.877461225451, 6345.365463453618, 7597.810054748676, 7692.0, 7713.112992005879, 7724.729634462767, 2733.988424283028, 3180.45932191528, 3239.303549736818, 3240.756943229267, 3272.1165285372817, 985.261054209343, 988.2538683294067, 1011.6256984915481, 1023.4729114506035, 1061.57536985205, 28180.29549261244, 29281.888948615717, 29608.111756647337, 29710.55434168446, 29885.252868678457, 854.5897968974926, 1004.9447280399648, 1042.457921880633, 1047.675220681591, 1095.917806164541, 12266.386680665932, 13871.167729936236, 14725.042872213271, 14741.41034358635, 15019.0, 704171.0, 708464.0, 708807.0, 709242.0, 710882.0, 55479.44520554823, 55960.72019639957, 55965.0, 56057.71971140118, 56082.71958640181, 1051.4427353502808, 1060.3796778884284, 1122.3322123336602, 1185.958491452795, 1255.6546949588935, 25960.610590840774, 28877.422451551272, 29142.70857291485, 30195.245118871324, 30757.53863692091, 53572.0, 54288.0, 54301.72849135729, 54333.72833135809, 54481.0, 623042.0, 627181.0, 628707.0, 629812.0, 630733.0, 25614.87192564025, 26110.477790444464, 26132.60801087947, 26204.213873583823, 40111.39832902567, 44479.77760111179, 44692.0, 44820.0, 45209.54790452185, 45240.32139517976, 32086.6791332093, 37755.81122094372, 37946.810265948494, 38111.28499217597, 39199.0, 37114.814425927696, 37444.0, 37471.41212873189, 38325.4251186238, 38350.80824595859, 36918.815405922796, 37150.88547343584, 37545.68590099333, 37627.0, 37774.62225377821, 31404.528932066496, 33370.99887003394, 33731.662683373834, 34020.0, 34094.31811363808, 24071.51856962816, 24946.0, 25358.746412536377, 25370.746292536838, 25542.489150217265], "value": 17959.872382565434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.4413804120469, 371.7936545217405, 372.7390826421505, 378.62137862137854, 400.1576681086313, 15538.300776465057, 15808.525744227678, 17100.91449542752, 20498.282560110398, 21280.46798830026, 19447.319343822932, 20111.798882011175, 20192.889391083485, 20440.488987775312, 20697.896510517425, 4673.76631168442, 5447.291852059237, 5661.122526008455, 5698.629589076718, 5709.857253568653, 6171.845703857394, 6255.186825712673, 6296.464800491964, 6297.307296197415, 6311.431971122598, 5806.419358064181, 5946.197263369455, 6165.784197553086, 6249.625022498664, 6269.247690277173, 6147.354527774586, 6205.348438413992, 6208.6585237811905, 6212.223472065969, 6220.502359811227, 5160.200168973777, 5217.217417387385, 5464.836054918359, 5466.426025267329, 5471.616986810925, 13385.86614133856, 13522.0, 13528.864711352859, 23912.0, 25115.497690046097, 2036.572319812841, 2084.3121769815925, 2244.394013616331, 2262.2195342606774, 2642.735726427361, 8527.914720852774, 9565.421705418597, 10474.162067034695, 13274.601761947157, 14515.70968580633, 1764.24137620823, 1826.634673065379, 1831.7801863776433, 1869.2336142181775, 1918.2902326139279, 91358.0, 109230.45384773026, 125143.99999999908, 126534.0, 127430.0, 11159.0, 11440.370779607036, 11470.139739519569, 11473.196876218752, 11655.02796786831, 14535.127892326283, 14572.0, 14575.271236438348, 14580.416783328548, 14605.0, 7498.762704153863, 8177.877331839908, 8430.536320502308, 8489.74530764078, 8564.886564746668, 7988.201179881965, 8380.329573634095, 8398.622062007224, 8557.957210213908, 8566.82866342682, 4388.451443569554, 4486.461624605068, 4494.213512635276, 4555.362249285103, 4606.378138951266, 1595.920203989796, 1830.9816901831077, 1882.3552908164052, 1891.290765962764, 1898.7531620889197, 816.1960468938091, 842.2630198576246, 867.5748883047388, 894.3024440936081, 919.287552147078, 16881.746773798404, 20163.798362016485, 20834.958252087334, 21163.894180529307, 21317.68023479649, 867.2411639815161, 883.0815951410461, 889.3596610440472, 909.4497828813472, 915.208344781759, 7406.962965185139, 8279.710210142615, 9540.236781057498, 10991.340519568852, 11074.667759967213, 584423.0, 586950.0, 589670.6010568369, 601378.0, 602341.0, 126534.3673281646, 127097.0, 128893.71106289004, 131572.0, 131752.0, 939.281449690987, 944.8110377924443, 977.9951100244454, 978.1587834462357, 980.4117529482396, 17023.31906723717, 18366.265349385874, 18490.81509184891, 18516.888986660844, 18579.72130418072, 37766.055848602904, 49658.75170624124, 50762.98474030573, 50850.49149508458, 51024.74487627538, 77405.48539660746, 77985.61007194928, 78301.0, 79088.0, 79127.0, 6816.216135144522, 7798.6604018793005, 7871.881921771293, 8149.551774652451, 8161.79595510117, 10679.626213082505, 12977.961763058744, 13183.945284377034, 13295.80056299137, 13400.262985535499, 8512.70205542803, 11055.889441105808, 11293.71765705864, 11468.483918223534, 11542.19204655666, 10840.403777792297, 11055.447227638426, 11093.889061109609, 11435.142364322543, 11720.941395292968, 10515.158787296845, 10641.680749577525, 11367.488463019019, 11664.241824281395, 12048.518059277882, 7271.636418179176, 7339.889901651372, 7435.442341824493, 7537.359324457482, 7601.581912994618, 10618.893811061791, 11041.44792760375, 11067.778644427228, 11396.658100257006, 11485.885141148481], "value": 9293.680152698196, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.5786627212422, 1508.8415716349782, 1525.5957171349592, 1707.240278076256, 1884.180381534033, 7736.419768517362, 8193.46742461741, 8201.425900186989, 8203.26170644642, 8203.548804815733, 8316.667333306676, 8471.830563388728, 8514.191151840581, 8616.31069514439, 8689.522076285803, 2333.230034088751, 2365.9763402366016, 2366.408397900525, 2367.147826782357, 2369.597168481362, 2303.608386574286, 2346.9647955280684, 2350.1304517328613, 2354.09367393553, 2354.105439932823, 2321.93034208974, 2342.063174730113, 2352.9882350588223, 2355.9882200588972, 2357.610994185966, 1975.5950030243766, 2303.1593468384085, 2325.988370058156, 2326.7091613548305, 2336.1823361823394, 2312.09828167015, 2322.2336628912585, 2323.628219484874, 2325.0, 2336.3341447687326, 8552.187542183483, 8672.826543469095, 8673.13268673134, 8673.219410253107, 8686.174813392781, 4389.736615803062, 5037.596992240648, 5059.0, 5226.163813789775, 5235.952809438089, 2886.354777776647, 2952.3062080411087, 3314.7531740418362, 3481.529993450877, 3488.7034602058857, 933.5658918602883, 1004.382304882492, 1027.244974943416, 1034.7051090439263, 1051.952662130206, 11459.65621031362, 11472.598459053894, 11475.77048459026, 11477.483513241925, 11492.0, 4344.0, 4517.841875534341, 4600.976995115003, 4797.64017698674, 4820.493848145894, 8961.731148065568, 9009.594568244445, 9021.32340074497, 9025.41334813235, 9026.774330641656, 5155.226715992631, 5169.689818610896, 5170.793168273302, 5174.482551744795, 5175.120229560984, 3825.6365645263654, 4388.144311859157, 4538.704984176018, 4785.545373189541, 4853.975730121398, 3569.589497207802, 3624.1120925373452, 3703.4259689748133, 3714.6285371462636, 3717.442383642421, 1113.9108871290277, 1117.943543351525, 1130.5929865248504, 1133.5409159290336, 1137.5734099712608, 764.9923500764921, 780.9297163255334, 820.4216027700456, 882.3867412148495, 890.0120865838913, 4477.753723545171, 5625.296837895263, 5639.379668236491, 5704.572157088235, 5733.827985160452, 327.3208093206606, 400.62585332310454, 419.89502624343913, 440.9448818897638, 444.9666275029386, 3697.815109244527, 3876.3604005339366, 3901.6878649707955, 3929.7838618876235, 3985.103351745892, 8258.545779982158, 10498.002689744462, 10510.421926794099, 10530.15758739299, 10540.156787456985, 10463.790724185474, 10466.947665261625, 10475.0, 10480.0, 10484.161267098614, 6671.432928201158, 7667.156612772591, 7921.881171782428, 8026.157253488416, 8032.0763112241675, 5552.139418390156, 5660.490555849993, 5696.259486266758, 5749.281339832521, 5836.095405212199, 9426.0, 9556.85664715016, 9597.856032159663, 9794.608215671578, 9892.901070989197, 9289.396189247676, 9983.500824958577, 9994.60021599157, 10008.549615267184, 10010.249231307535, 6353.205849268841, 6582.078509008838, 6589.143411356685, 6814.4548436124, 6893.862122757617, 6528.510361722985, 8071.959640201761, 8244.752657420288, 8306.626201821053, 8319.625616847377, 6381.074744162163, 6687.866242675216, 7254.963725181551, 7403.333699967029, 7475.551466912003, 6205.875882482415, 7288.890666639899, 7335.669894854851, 7343.522671026366, 7384.4830861839155, 6646.069550263063, 6878.243393226841, 6912.0, 6940.895886561807, 7018.473614478832, 4663.766811659336, 4748.881277968078, 4831.4685384608365, 5012.6240531960975, 5129.538341549279, 4099.590040995877, 4862.3922009748785, 5026.899462010812, 5074.720890351066, 5168.198929165986], "value": 4300.364748334682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.92226098953284, 293.8809782038274, 302.974247188989, 307.271765914782, 308.94284557356906, 5172.715500647463, 5217.947820521794, 5255.527002569768, 5281.656692314997, 5281.788728450857, 4125.834966601333, 4847.709137451747, 4945.802167913288, 4975.009996001601, 5173.560247378968, 3394.083597428693, 3516.613172551017, 3986.720929534934, 3989.8603548875794, 3992.301347264224, 3303.3648344069597, 4009.87723437438, 4045.656119229869, 4074.0, 4085.816138273785, 3331.6002079750465, 3845.293763945288, 3965.600811509039, 3969.960300396988, 4060.776657283848, 3300.884469043596, 3953.446517487554, 3958.535341923478, 3986.8405263789414, 4019.2114509043486, 2967.55486676998, 3282.3599398117376, 3399.286149908522, 3480.721542276637, 3487.0011789860955, 4367.139523612039, 4940.110780059588, 4957.727324997124, 5014.398272207359, 5093.5415812576675, 4242.681798865066, 4561.042181141964, 4572.5427457254345, 4580.610648094916, 4581.358609794632, 5387.299651045379, 5421.186821976696, 5465.415029641399, 5473.4149132318, 5503.7798488060425, 2994.8053376530675, 3705.7950519440888, 3840.577536470986, 3862.633049860287, 3873.8837834864717, 5261.210818377236, 5590.636608620427, 5639.577031722637, 5719.599628025998, 5740.138979153118, 3088.7528997680133, 3590.281943611288, 3765.548134223911, 3769.246150769857, 3781.5819067849557, 3506.7194624429985, 3847.672947799412, 3854.49891514107, 3856.190200057963, 3856.2094770571966, 4270.636995855387, 4493.370928070073, 4498.932516012263, 4506.977465112719, 4518.0, 4521.276595744665, 5434.060306277996, 5478.506934375925, 5509.393966663663, 5514.580959804866, 1226.6687994241504, 1280.7182419867613, 1291.438224372401, 1374.1892283552552, 1381.730562540295, 866.9566521674017, 886.3263919421287, 890.0609856601218, 894.5482531321641, 895.1764376773384, 4187.597154953125, 4269.423627810268, 4360.520342762357, 4363.672724545671, 4796.400449943757, 4014.136960553495, 4311.676624253194, 4601.677882548256, 4676.906461870743, 4744.905101898012, 3704.5369328833895, 3879.157400234922, 4124.876253712393, 4191.371294305817, 4327.826886924488, 2066.6463466429514, 2180.6510958246604, 2236.3849941265958, 2416.6495858100475, 2425.2845410603913, 4720.622350211975, 4758.357621721093, 4795.588058985742, 4838.225883858566, 4951.801927922915, 3908.9804550977065, 4407.2507673695545, 4519.909601807945, 4612.95387046132, 4804.180676362301, 3793.506844110248, 4206.41110244566, 4402.801873915618, 4796.616270698266, 4818.831340903122, 4083.7748675397856, 4111.787022828213, 4358.585934336233, 4451.777411129366, 4473.530279320625, 3956.0329752685484, 4375.256206444976, 4468.709533880287, 4535.349044019464, 4660.906781864412, 3806.6954643628997, 3999.5800440954445, 4366.318967197588, 4455.6212721919, 4773.761311934459, 2912.3643102991828, 3375.9703290495654, 3390.4744764561533, 3405.812680302607, 3422.7432942528912, 3780.827943337574, 4621.498013145809, 4639.512851150581, 4639.721616703008, 4664.4869064403565, 3506.053365591225, 3977.244323578511, 4160.479940007499, 4465.218586747371, 4531.365608814703, 3955.5648878623906, 4144.70987030905, 4180.602842729936, 4457.8439754608435, 4595.517470665532, 3998.3802510610903, 4151.501819781645, 4239.894002649835, 4352.78236088188, 4424.902568202207, 4299.97850010748, 5147.768350424165, 5180.404253510895, 5336.226247194058, 5442.863928401822, 4841.975790121168, 4844.612431005582, 5173.560247378864, 5248.658837175724, 5263.315768950165], "value": 3661.333651423564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3077272659172, 625.5308518611042, 701.2706784943659, 713.7394850879431, 812.4678335690121, 14954.177520236382, 15561.988470749407, 16575.585610359747, 17455.389061382855, 17461.650766984654, 15481.458148964788, 15809.525714228563, 15829.445969391074, 15840.841591584109, 15886.285117169726, 737.9520331178483, 847.5380917400016, 875.0287181228831, 875.7722992022057, 877.2324216310728, 687.6011913090396, 706.8232941764559, 707.8301207710139, 714.5105602662167, 864.515871112176, 731.0897932074574, 733.6185183704471, 892.1301730812438, 923.5474617437475, 929.8605209218638, 916.9958895009953, 917.3303488453466, 918.3066784577668, 918.3204428722764, 918.5499105438354, 544.8528897197774, 670.5272782688193, 683.6205905722322, 685.3283781893772, 685.8422562810532, 12122.333271670055, 12543.184692995017, 14759.114453132739, 15260.31328590216, 15318.846811531854, 13723.862761372458, 14048.92975535126, 14124.293785310694, 14141.575752727435, 14491.3478893449, 10356.79286414275, 11242.94378528102, 11375.146863985152, 11912.88087119135, 12233.828547586738, 3758.361078616642, 3767.3783825668734, 3774.67915227206, 3790.507234059582, 3908.394198899175, 81069.18930810616, 100323.49838250835, 102237.4888125562, 102540.46189307091, 102683.48658256736, 10311.84532232017, 10459.68620941373, 10809.83785243222, 10827.945860270649, 11172.162087843282, 21900.12399504034, 22026.33920982373, 22294.88852555759, 22307.442313941956, 22312.553748925257, 7737.535747855034, 7807.219278072261, 7817.374610031297, 7886.684532618746, 7979.281864632211, 4256.59562341577, 4336.436263285816, 4365.978170109129, 4474.261746811805, 4491.169133710274, 3379.3579219948133, 3453.188500702333, 3485.703715184238, 3492.9825350873084, 3507.2459421224557, 615.2156001098546, 619.5693992675137, 623.059180637232, 628.7202195023262, 629.0689779126918, 584.5469760935309, 599.6522017229996, 654.5320096131289, 686.989695154573, 688.1638808847175, 8802.735917922473, 9238.815223695623, 9287.257019438428, 9426.104520070583, 9479.431234125974, 491.73732286280784, 583.7110630238059, 592.7303077099909, 635.9872802543923, 651.563452486835, 4482.238019536687, 4538.183127037165, 4635.142498637762, 4639.327297541838, 4790.377250957354, 87796.56101719578, 88243.67634485487, 140144.0, 147702.26148869187, 150369.0, 103804.0, 125556.0, 128316.71683283235, 129440.35279823729, 131099.0, 71500.64249678719, 85669.28818914895, 107458.0, 111350.44324778486, 113091.86908130978, 7932.960335198287, 8688.218060374596, 8860.158284962918, 8870.86693699582, 8897.0, 54748.72625636846, 54971.175432369346, 60291.492712682535, 61671.6916415415, 61843.381566183765, 82763.5861820687, 90121.0, 91680.54159729158, 91791.0, 98115.50942245529, 11945.880541194478, 13924.2341671205, 14099.365528551445, 14477.0, 14526.0, 12998.895093917123, 14392.784108238175, 14519.419223230952, 14792.852071479147, 15720.528384148494, 13317.66705832362, 13876.167429954236, 14074.507392241223, 14092.859071409564, 14486.203258820866, 13996.230207338695, 14262.500812471513, 14302.356393962089, 14730.484433044792, 14803.777943330644, 13565.309107553434, 13665.31673416345, 13872.306384680927, 14268.57194284173, 14292.285385730464, 11238.599588113968, 11407.429628518707, 11672.299662020307, 11934.343611101473, 11939.582114625946, 11092.279001864854, 11490.540378385105, 11727.589534366256, 11732.472038758448, 11809.586664466702], "value": 7665.975070189088, "unit": "score"}], "name": "dromaeo_css", "value": 6950.9606174790715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 112.0, 111.0, 114.0, 112.0, 111.0, 110.0, 117.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 115.0, 152.0, 114.0, 114.0, 113.0, 112.0, 149.0, 113.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 181.0, 186.0, 184.0, 186.0, 178.0, 184.0, 183.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 87.0, 60.0, 59.0, 62.0, 60.0, 102.0, 81.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 90.0, 69.0, 68.0, 67.0, 91.0, 68.0, 85.0, 124.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 84.0, 100.0, 131.0, 88.0, 85.0, 86.0, 84.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 110.0, 149.0, 118.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 86.0, 84.0, 86.0, 87.0, 84.0, 84.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 53.0, 55.0, 55.0, 56.0, 55.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 80.0, 76.0, 72.0, 70.0, 69.0, 71.0, 69.0, 71.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 85.0, 88.0, 100.0, 109.0, 110.0, 101.0, 91.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 145.0, 153.0, 159.0, 165.0, 144.0, 147.0, 147.0, 177.0, 143.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 177.0, 174.0, 176.0, 174.0, 174.0, 173.0, 177.0, 236.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 82.0, 90.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1479.7999999999997, "alertThreshold": 2.0}]} 15:42:05 INFO - Return code: 0 15:42:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:05 INFO - # TBPL SUCCESS # 15:42:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:42:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:42:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:42:05 INFO - 2016-10-04 15:42:05.580 screenresolution[1671:9837] starting screenresolution argv=screenresolution get 15:42:05 INFO - 2016-10-04 15:42:05.584 screenresolution[1671:9837] Display 0: 1600x1200x32@60 15:42:05 INFO - 2016-10-04 15:42:05.590 screenresolution[1672:9840] starting screenresolution argv=screenresolution list 15:42:05 INFO - Available Modes on Display 0 15:42:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:42:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:42:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:42:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:42:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:42:05 INFO - Intel Iris: 15:42:05 INFO - Chipset Model: Intel Iris 15:42:05 INFO - Type: GPU 15:42:05 INFO - Bus: Built-In 15:42:05 INFO - VRAM (Dynamic, Max): 1536 MB 15:42:05 INFO - Vendor: Intel (0x8086) 15:42:05 INFO - Device ID: 0x0a2e 15:42:05 INFO - Revision ID: 0x0009 15:42:05 INFO - Displays: 15:42:05 INFO - Display: 15:42:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:42:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:42:05 INFO - Display Serial Number: 1600x1200 60 15:42:05 INFO - Main Display: Yes 15:42:05 INFO - Mirror: Off 15:42:05 INFO - Online: Yes 15:42:05 INFO - Rotation: Supported 15:42:05 INFO - Return code: 0 15:42:05 INFO - Running post-action listener: _resource_record_post_action 15:42:05 INFO - [mozharness: 2016-10-04 22:42:05.840805Z] Finished run-tests step (success) 15:42:05 INFO - Running post-run listener: _resource_record_post_run 15:42:05 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37307392; Write bytes: 706018304; Read time: 241; Write time: 1929 15:42:05 INFO - TinderboxPrint: CPU usage
53.7% 15:42:05 INFO - TinderboxPrint: I/O read bytes / time
37,307,392 / 241 15:42:05 INFO - TinderboxPrint: I/O write bytes / time
706,018,304 / 1,929 15:42:05 INFO - TinderboxPrint: CPU idle
2,244.7 (46.3%) 15:42:05 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 15:42:05 INFO - TinderboxPrint: CPU user
1,633.1 (33.7%) 15:42:05 INFO - TinderboxPrint: Swap in / out
444,149,760 / 0 15:42:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 409211392; Write bytes: 402525696; Read time: 29852; Write time: 806 15:42:05 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29977600; Write bytes: 293752320; Read time: 176; Write time: 1089 15:42:06 INFO - Running post-run listener: _upload_blobber_files 15:42:06 INFO - Blob upload gear active. 15:42:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:06 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 15:42:06 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:06 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:06 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:42:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:42:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:07 INFO - (blobuploader) - INFO - Done attempting. 15:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:08 INFO - (blobuploader) - INFO - Done attempting. 15:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:10 INFO - (blobuploader) - INFO - Done attempting. 15:42:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:10 INFO - Return code: 0 15:42:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cc7b09833d8e9192aeb3607e226a4e5ef816cbb1b5f3d4656ba9ed745297e9cff5bd12a15cfc5d5b011a88ee98fbd3dfff6cb404145ec8cb72b14e0804f5ba04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/24df6284e4cfb7e689d6537c84819152f2e82da7a5eb693521a3b139fc342ac536a111fd44e7199b82fa296d81e1ead3150f0f061b27a08f456e1ee3b917782a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abeeb4e7384da9edcc800c346a2e453de61f6fa2a1700d5ab0d01863fb812084304c9ce3f41ca3619d46e8ca3bcaa5a0d18b02cca54aa2245657dbb1d97ab77d"} 15:42:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:10 INFO - Contents: 15:42:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cc7b09833d8e9192aeb3607e226a4e5ef816cbb1b5f3d4656ba9ed745297e9cff5bd12a15cfc5d5b011a88ee98fbd3dfff6cb404145ec8cb72b14e0804f5ba04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/24df6284e4cfb7e689d6537c84819152f2e82da7a5eb693521a3b139fc342ac536a111fd44e7199b82fa296d81e1ead3150f0f061b27a08f456e1ee3b917782a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abeeb4e7384da9edcc800c346a2e453de61f6fa2a1700d5ab0d01863fb812084304c9ce3f41ca3619d46e8ca3bcaa5a0d18b02cca54aa2245657dbb1d97ab77d"} 15:42:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:10 INFO - Copying logs to upload dir... 15:42:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.943521 ========= master_lag: 1.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 15:42:12.346429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 15:42:12.354085) ========= 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.cf6atMunOy/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.hNKAVVVrZY/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cc7b09833d8e9192aeb3607e226a4e5ef816cbb1b5f3d4656ba9ed745297e9cff5bd12a15cfc5d5b011a88ee98fbd3dfff6cb404145ec8cb72b14e0804f5ba04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/24df6284e4cfb7e689d6537c84819152f2e82da7a5eb693521a3b139fc342ac536a111fd44e7199b82fa296d81e1ead3150f0f061b27a08f456e1ee3b917782a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abeeb4e7384da9edcc800c346a2e453de61f6fa2a1700d5ab0d01863fb812084304c9ce3f41ca3619d46e8ca3bcaa5a0d18b02cca54aa2245657dbb1d97ab77d"} build_url:https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/J7S07NO_TwWtTot-LUXMzw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cc7b09833d8e9192aeb3607e226a4e5ef816cbb1b5f3d4656ba9ed745297e9cff5bd12a15cfc5d5b011a88ee98fbd3dfff6cb404145ec8cb72b14e0804f5ba04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/24df6284e4cfb7e689d6537c84819152f2e82da7a5eb693521a3b139fc342ac536a111fd44e7199b82fa296d81e1ead3150f0f061b27a08f456e1ee3b917782a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abeeb4e7384da9edcc800c346a2e453de61f6fa2a1700d5ab0d01863fb812084304c9ce3f41ca3619d46e8ca3bcaa5a0d18b02cca54aa2245657dbb1d97ab77d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 15:42:12.393472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:42:12.393807) ========= 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.cf6atMunOy/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.hNKAVVVrZY/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.005322 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:42:12.442439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 15:42:12.445790) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 15:42:12.446106) ========= ========= Total master_lag: 1.70 =========