builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1483701412.07 results: success (0) buildid: 20170106004019 builduid: 347bfca608cb4444ab20c93bf36104fa revision: 87a48d902eb2655d031216b91375097c6faf454e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.067259) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.067726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.068054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.095688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.096059) ========= 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.NL417SswkX/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.ALbaXzaAI4/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-06 03:16:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.4M=0.001s 2017-01-06 03:16:52 (21.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.456192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.576891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.577177) ========= 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.NL417SswkX/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.ALbaXzaAI4/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.032539 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:52.671116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 03:16:52.671479) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87a48d902eb2655d031216b91375097c6faf454e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87a48d902eb2655d031216b91375097c6faf454e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NL417SswkX/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.ALbaXzaAI4/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-06 03:16:52,772 truncating revision to first 12 chars 2017-01-06 03:16:52,772 Setting DEBUG logging. 2017-01-06 03:16:52,773 attempt 1/10 2017-01-06 03:16:52,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/87a48d902eb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 03:16:53,551 unpacking tar archive at: mozilla-aurora-87a48d902eb2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.059326 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 03:16:53.757526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:53.757845) ========= script_repo_revision: 87a48d902eb2655d031216b91375097c6faf454e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:53.758223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:53.758496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 03:16:53.777973) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-06 03:16:53.778366) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NL417SswkX/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.ALbaXzaAI4/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:16:53 INFO - MultiFileLogger online at 20170106 03:16:53 in /builds/slave/test 03:16:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:16:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:53 INFO - {'append_to_log': False, 03:16:53 INFO - 'base_work_dir': '/builds/slave/test', 03:16:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:53 INFO - 'branch': 'Mozilla-Aurora', 03:16:53 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:53 INFO - 'config_files': ('talos/mac_config.py',), 03:16:53 INFO - 'default_actions': ('clobber', 03:16:53 INFO - 'read-buildbot-config', 03:16:53 INFO - 'download-and-extract', 03:16:53 INFO - 'populate-webroot', 03:16:53 INFO - 'create-virtualenv', 03:16:53 INFO - 'install', 03:16:53 INFO - 'run-tests'), 03:16:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:53 INFO - 'download_minidump_stackwalk': True, 03:16:53 INFO - 'download_symbols': 'ondemand', 03:16:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:53 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:53 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:53 INFO - 'installer_path': 'installer.exe', 03:16:53 INFO - 'log_level': 'info', 03:16:53 INFO - 'log_name': 'talos', 03:16:53 INFO - 'log_to_console': True, 03:16:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:16:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:16:53 INFO - 'opt_config_files': (), 03:16:53 INFO - 'pip_index': False, 03:16:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:16:53 INFO - 'cmd': ('bash', 03:16:53 INFO - '-c', 03:16:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:16:53 INFO - 'enabled': True, 03:16:53 INFO - 'halt_on_failure': False, 03:16:53 INFO - 'name': 'check_screen_resolution'},), 03:16:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:16:53 INFO - 'cmd': ('bash', 03:16:53 INFO - '-c', 03:16:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:16:53 INFO - 'enabled': True, 03:16:53 INFO - 'halt_on_failure': False, 03:16:53 INFO - 'name': 'check_screen_resolution'},), 03:16:53 INFO - 'run_cmd_checks_enabled': True, 03:16:53 INFO - 'sps_profile': False, 03:16:53 INFO - 'sps_profile_interval': 0, 03:16:53 INFO - 'suite': 'dromaeojs', 03:16:53 INFO - 'system_bits': '32', 03:16:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:53 INFO - 'title': 't-yosemite-r7-0277', 03:16:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:53 INFO - 'use_talos_json': True, 03:16:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:53 INFO - 'work_dir': 'build'} 03:16:53 INFO - [mozharness: 2017-01-06 11:16:53.985521Z] Running clobber step. 03:16:53 INFO - Running pre-action listener: _resource_record_pre_action 03:16:53 INFO - Running main action method: clobber 03:16:53 INFO - rmtree: /builds/slave/test/build 03:16:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:56 INFO - Running post-action listener: _resource_record_post_action 03:16:56 INFO - [mozharness: 2017-01-06 11:16:56.423510Z] Finished clobber step (success) 03:16:56 INFO - [mozharness: 2017-01-06 11:16:56.423631Z] Running read-buildbot-config step. 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: read_buildbot_config 03:16:56 INFO - Using buildbot properties: 03:16:56 INFO - { 03:16:56 INFO - "project": "", 03:16:56 INFO - "product": "firefox", 03:16:56 INFO - "script_repo_revision": "production", 03:16:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:16:56 INFO - "repository": "", 03:16:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:16:56 INFO - "buildid": "20170106004019", 03:16:56 INFO - "stage_platform": "macosx64", 03:16:56 INFO - "basedir": "/builds/slave/test", 03:16:56 INFO - "nightly_build": "True", 03:16:56 INFO - "buildnumber": 30, 03:16:56 INFO - "slavename": "t-yosemite-r7-0277", 03:16:56 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:16:56 INFO - "platform": "yosemite_r7", 03:16:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:16:56 INFO - "branch": "mozilla-aurora", 03:16:56 INFO - "repo_path": "releases/mozilla-aurora", 03:16:56 INFO - "revision": "87a48d902eb2655d031216b91375097c6faf454e", 03:16:56 INFO - "pgo_build": "False", 03:16:56 INFO - "builduid": "347bfca608cb4444ab20c93bf36104fa", 03:16:56 INFO - "slavebuilddir": "test" 03:16:56 INFO - } 03:16:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:16:56 INFO - Running post-action listener: _resource_record_post_action 03:16:56 INFO - [mozharness: 2017-01-06 11:16:56.427343Z] Finished read-buildbot-config step (success) 03:16:56 INFO - [mozharness: 2017-01-06 11:16:56.427472Z] Running download-and-extract step. 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: download_and_extract 03:16:56 INFO - mkdir: /builds/slave/test/build/tests 03:16:56 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')]} 03:16:56 INFO - trying https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 03:16:57 INFO - Downloaded 1199 bytes. 03:16:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:16:57 INFO - Using the following test package requirements: 03:16:57 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:16:57 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:16:57 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:16:57 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'jsshell-mac.zip'], 03:16:57 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:16:57 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:16:57 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:16:57 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:16:57 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:16:57 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:16:57 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:16:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:16:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:16:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:16:57 INFO - Fetch https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:16:57 INFO - Http code: 200 03:16:57 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 03:16:57 INFO - x-amz-cf-id: X28ejcyQdjUePyM2SrCisq_s9iJEqXFHcfYJR5Fno2RhoQ0rRQTNfw== 03:16:57 INFO - x-amz-version-id: KXSlDBLfIww1zD84rswlqSRas1CMR59f 03:16:58 INFO - Expected file size: 16269635 03:16:58 INFO - Obtained file size: 16269635 03:17:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:17:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:17:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:17:05 INFO - Fetch https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:17:05 INFO - Http code: 200 03:17:05 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 03:17:05 INFO - x-amz-cf-id: qBTJywEgb0VTlSRzPQLfDtzquYsP-Xq3Vbd8dCM0srL3fXrMCOmrew== 03:17:05 INFO - x-amz-version-id: KXSlDBLfIww1zD84rswlqSRas1CMR59f 03:17:06 INFO - Expected file size: 16269635 03:17:06 INFO - Obtained file size: 16269635 03:17:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:17:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:17:12 INFO - Fetch https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:17:13 INFO - Http code: 200 03:17:13 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 03:17:13 INFO - x-amz-cf-id: CvY9BgysABQO-yhKSE0nkwIIw_3GMVU1313W2Fe0rxw16WsB82Qffw== 03:17:13 INFO - x-amz-version-id: fa9kNbHrmdQxm_E4n2L1aE_UreasGnSE 03:17:14 INFO - Expected file size: 14409038 03:17:14 INFO - Obtained file size: 14409038 03:17:14 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')]} 03:17:14 INFO - trying https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:17:14 INFO - Downloading https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 03:17:17 INFO - Downloaded 109965632 bytes. 03:17:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:17:17 INFO - mkdir: /builds/slave/test/properties 03:17:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:17 INFO - Contents: 03:17:17 INFO - build_url:https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:17:17 INFO - Running post-action listener: _resource_record_post_action 03:17:17 INFO - Running post-action listener: set_extra_try_arguments 03:17:17 INFO - [mozharness: 2017-01-06 11:17:17.825274Z] Finished download-and-extract step (success) 03:17:17 INFO - [mozharness: 2017-01-06 11:17:17.825396Z] Running populate-webroot step. 03:17:17 INFO - Running pre-action listener: _resource_record_pre_action 03:17:17 INFO - Running main action method: populate_webroot 03:17:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:17 INFO - '--tppagecycles', 03:17:17 INFO - '7'], 03:17:17 INFO - 'tests': ['tsvgm']}}, 03:17:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:17:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:17:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['damp', 'tps']}, 03:17:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'tests': ['damp', 'tps']}, 03:17:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['dromaeo_dom']}, 03:17:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['basic_compositor_video']}, 03:17:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:17:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['a11yr', 03:17:17 INFO - 'ts_paint', 03:17:17 INFO - 'tpaint', 03:17:17 INFO - 'sessionrestore', 03:17:17 INFO - 'sessionrestore_no_auto_restore', 03:17:17 INFO - 'tabpaint']}, 03:17:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:17:17 INFO - 'ts_paint', 03:17:17 INFO - 'tpaint', 03:17:17 INFO - 'sessionrestore', 03:17:17 INFO - 'sessionrestore_no_auto_restore', 03:17:17 INFO - 'tabpaint']}, 03:17:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:17:17 INFO - 'ts_paint', 03:17:17 INFO - 'tpaint', 03:17:17 INFO - 'sessionrestore', 03:17:17 INFO - 'sessionrestore_no_auto_restore', 03:17:17 INFO - 'tabpaint']}, 03:17:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:17:17 INFO - 'ts_paint', 03:17:17 INFO - 'tpaint', 03:17:17 INFO - 'sessionrestore', 03:17:17 INFO - 'sessionrestore_no_auto_restore', 03:17:17 INFO - 'tabpaint']}, 03:17:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['a11yr', 03:17:17 INFO - 'ts_paint', 03:17:17 INFO - 'tpaint', 03:17:17 INFO - 'sessionrestore', 03:17:17 INFO - 'sessionrestore_no_auto_restore', 03:17:17 INFO - 'tabpaint']}, 03:17:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['a11yr', 03:17:17 INFO - 'ts_paint', 03:17:17 INFO - 'tpaint', 03:17:17 INFO - 'sessionrestore', 03:17:17 INFO - 'sessionrestore_no_auto_restore', 03:17:17 INFO - 'tabpaint']}, 03:17:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['tsvgx', 03:17:17 INFO - 'tsvgr_opacity', 03:17:17 INFO - 'tart', 03:17:17 INFO - 'tscrollx', 03:17:17 INFO - 'cart']}, 03:17:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:17:17 INFO - 'tsvgr_opacity', 03:17:17 INFO - 'tart', 03:17:17 INFO - 'tscrollx', 03:17:17 INFO - 'cart']}, 03:17:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'talos_options': ['--disable-e10s'], 03:17:17 INFO - 'tests': ['tp5o']}, 03:17:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'tests': ['tp5o']}, 03:17:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'talos_options': ['--disable-e10s', 03:17:17 INFO - '--xperf_path', 03:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:17 INFO - 'tests': ['tp5n']}, 03:17:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:17 INFO - 'talos_options': ['--xperf_path', 03:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:17 INFO - 'tests': ['tp5n']}}, 03:17:17 INFO - 'talos.zip': {'path': '', 03:17:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:17 INFO - Running post-action listener: _resource_record_post_action 03:17:17 INFO - [mozharness: 2017-01-06 11:17:17.844128Z] Finished populate-webroot step (success) 03:17:17 INFO - [mozharness: 2017-01-06 11:17:17.844259Z] Running create-virtualenv step. 03:17:17 INFO - Running pre-action listener: _resource_record_pre_action 03:17:17 INFO - Running main action method: create_virtualenv 03:17:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:17 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 03:17:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:17 INFO - Using real prefix '/tools/python27' 03:17:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:21 INFO - Installing pip.................done. 03:17:21 INFO - Return code: 0 03:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:17:21 INFO - Reading from file tmpfile_stdout 03:17:21 INFO - Output received: 03:17:21 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) 03:17:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17:21 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')]} 03:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:21 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')]} 03:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:21 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:21 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 03:17:21 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 03:17:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:21 INFO - 'HOME': '/Users/cltbld', 03:17:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:21 INFO - 'LOGNAME': 'cltbld', 03:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:21 INFO - 'MOZ_NO_REMOTE': '1', 03:17:21 INFO - 'NO_EM_RESTART': '1', 03:17:21 INFO - 'PAGER': '/bin/cat', 03:17:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:21 INFO - 'PWD': '/builds/slave/test', 03:17:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:21 INFO - 'SHELL': '/bin/bash', 03:17:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:21 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:21 INFO - 'USER': 'cltbld', 03:17:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:21 INFO - 'XPC_FLAGS': '0x0', 03:17:21 INFO - 'XPC_SERVICE_NAME': '0', 03:17:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:22 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 03:17:22 INFO - Cleaning up... 03:17:22 INFO - Return code: 0 03:17:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:17:22 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')]} 03:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:22 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')]} 03:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:22 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:22 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 03:17:22 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 03:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:22 INFO - 'HOME': '/Users/cltbld', 03:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:22 INFO - 'LOGNAME': 'cltbld', 03:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:22 INFO - 'MOZ_NO_REMOTE': '1', 03:17:22 INFO - 'NO_EM_RESTART': '1', 03:17:22 INFO - 'PAGER': '/bin/cat', 03:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:22 INFO - 'PWD': '/builds/slave/test', 03:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:22 INFO - 'SHELL': '/bin/bash', 03:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:22 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:22 INFO - 'USER': 'cltbld', 03:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:22 INFO - 'XPC_FLAGS': '0x0', 03:17:22 INFO - 'XPC_SERVICE_NAME': '0', 03:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:22 INFO - Downloading/unpacking psutil>=3.1.1 03:17:22 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 03:17:22 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 03:17:22 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 03:17:22 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 03:17:22 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 03:17:22 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 03:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:26 INFO - Installing collected packages: psutil 03:17:26 INFO - Running setup.py install for psutil 03:17:26 INFO - building 'psutil._psutil_osx' extension 03:17:26 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 03:17:27 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 03:17:27 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 03:17:27 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 03:17:27 INFO - building 'psutil._psutil_posix' extension 03:17:27 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 03:17:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:17:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:17:27 INFO - ^ 03:17:27 INFO - 1 warning generated. 03:17:27 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 03:17:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:27 INFO - Successfully installed psutil 03:17:27 INFO - Cleaning up... 03:17:27 INFO - Return code: 0 03:17:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:27 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:27 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 03:17:27 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 03:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:27 INFO - 'HOME': '/Users/cltbld', 03:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:27 INFO - 'LOGNAME': 'cltbld', 03:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:27 INFO - 'MOZ_NO_REMOTE': '1', 03:17:27 INFO - 'NO_EM_RESTART': '1', 03:17:27 INFO - 'PAGER': '/bin/cat', 03:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:27 INFO - 'PWD': '/builds/slave/test', 03:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:27 INFO - 'SHELL': '/bin/bash', 03:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:27 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:27 INFO - 'USER': 'cltbld', 03:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:27 INFO - 'XPC_FLAGS': '0x0', 03:17:27 INFO - 'XPC_SERVICE_NAME': '0', 03:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:30 INFO - Installing collected packages: mozsystemmonitor 03:17:30 INFO - Running setup.py install for mozsystemmonitor 03:17:30 INFO - Successfully installed mozsystemmonitor 03:17:30 INFO - Cleaning up... 03:17:30 INFO - Return code: 0 03:17:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17:30 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')]} 03:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:30 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')]} 03:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:30 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:30 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 03:17:30 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 03:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:30 INFO - 'HOME': '/Users/cltbld', 03:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:30 INFO - 'LOGNAME': 'cltbld', 03:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:30 INFO - 'MOZ_NO_REMOTE': '1', 03:17:30 INFO - 'NO_EM_RESTART': '1', 03:17:30 INFO - 'PAGER': '/bin/cat', 03:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:30 INFO - 'PWD': '/builds/slave/test', 03:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:30 INFO - 'SHELL': '/bin/bash', 03:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:30 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:30 INFO - 'USER': 'cltbld', 03:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:30 INFO - 'XPC_FLAGS': '0x0', 03:17:30 INFO - 'XPC_SERVICE_NAME': '0', 03:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:17:31 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 03:17:31 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 03:17:31 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 03:17:31 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 03:17:31 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 03:17:31 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 03:17:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:34 INFO - warning: no files found matching '*.txt' 03:17:34 INFO - no previously-included directories found matching 'build' 03:17:34 INFO - no previously-included directories found matching 'dist' 03:17:34 INFO - no previously-included directories found matching '.git*' 03:17:34 INFO - Installing collected packages: jsonschema, functools32 03:17:34 INFO - Running setup.py install for functools32 03:17:34 INFO - warning: no files found matching '*.txt' 03:17:34 INFO - no previously-included directories found matching 'build' 03:17:34 INFO - no previously-included directories found matching 'dist' 03:17:34 INFO - no previously-included directories found matching '.git*' 03:17:34 INFO - Successfully installed jsonschema functools32 03:17:34 INFO - Cleaning up... 03:17:34 INFO - Return code: 0 03:17:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:17:34 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')]} 03:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 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')]} 03:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:34 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 03:17:34 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 03:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:34 INFO - 'HOME': '/Users/cltbld', 03:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:34 INFO - 'LOGNAME': 'cltbld', 03:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:34 INFO - 'MOZ_NO_REMOTE': '1', 03:17:34 INFO - 'NO_EM_RESTART': '1', 03:17:34 INFO - 'PAGER': '/bin/cat', 03:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:34 INFO - 'PWD': '/builds/slave/test', 03:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:34 INFO - 'SHELL': '/bin/bash', 03:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:34 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:34 INFO - 'USER': 'cltbld', 03:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:34 INFO - 'XPC_FLAGS': '0x0', 03:17:34 INFO - 'XPC_SERVICE_NAME': '0', 03:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:17:34 INFO - Cleaning up... 03:17:34 INFO - Return code: 0 03:17:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:34 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')]} 03:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 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')]} 03:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:34 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 03:17:34 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 03:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:34 INFO - 'HOME': '/Users/cltbld', 03:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:34 INFO - 'LOGNAME': 'cltbld', 03:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:34 INFO - 'MOZ_NO_REMOTE': '1', 03:17:34 INFO - 'NO_EM_RESTART': '1', 03:17:34 INFO - 'PAGER': '/bin/cat', 03:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:34 INFO - 'PWD': '/builds/slave/test', 03:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:34 INFO - 'SHELL': '/bin/bash', 03:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:34 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:34 INFO - 'USER': 'cltbld', 03:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:34 INFO - 'XPC_FLAGS': '0x0', 03:17:34 INFO - 'XPC_SERVICE_NAME': '0', 03:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:37 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:38 INFO - Downloading docopt-0.6.1.tar.gz 03:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:38 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:38 INFO - Running setup.py install for blobuploader 03:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:39 INFO - Running setup.py install for requests 03:17:39 INFO - Running setup.py install for docopt 03:17:39 INFO - Successfully installed blobuploader requests docopt 03:17:39 INFO - Cleaning up... 03:17:39 INFO - Return code: 0 03:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:39 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 03:17:39 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 03:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:39 INFO - 'HOME': '/Users/cltbld', 03:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:39 INFO - 'LOGNAME': 'cltbld', 03:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:39 INFO - 'MOZ_NO_REMOTE': '1', 03:17:39 INFO - 'NO_EM_RESTART': '1', 03:17:39 INFO - 'PAGER': '/bin/cat', 03:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:39 INFO - 'PWD': '/builds/slave/test', 03:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:39 INFO - 'SHELL': '/bin/bash', 03:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:39 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:39 INFO - 'USER': 'cltbld', 03:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:39 INFO - 'XPC_FLAGS': '0x0', 03:17:39 INFO - 'XPC_SERVICE_NAME': '0', 03:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-WHdJ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-DeCiQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Bdk_s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-IIDpC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mJv_Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-r4vF_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-FlttO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-r8DWNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-rxqQY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-q6N2sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3sAP5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-IhamkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-hWvJSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-pvdMKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-OfYx6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NlTkwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:41 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-VDE0yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:41 INFO - Running setup.py install for manifestparser 03:17:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:41 INFO - Running setup.py install for mozcrash 03:17:42 INFO - Running setup.py install for mozdebug 03:17:42 INFO - Running setup.py install for mozdevice 03:17:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Running setup.py install for mozfile 03:17:42 INFO - Running setup.py install for mozhttpd 03:17:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Running setup.py install for mozinfo 03:17:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Running setup.py install for mozInstall 03:17:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:42 INFO - Running setup.py install for mozleak 03:17:43 INFO - Running setup.py install for mozlog 03:17:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:43 INFO - Running setup.py install for moznetwork 03:17:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:43 INFO - Running setup.py install for mozprocess 03:17:43 INFO - Running setup.py install for mozprofile 03:17:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:43 INFO - Running setup.py install for mozrunner 03:17:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:43 INFO - Running setup.py install for mozscreenshot 03:17:44 INFO - Running setup.py install for moztest 03:17:44 INFO - Running setup.py install for mozversion 03:17:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:44 INFO - Cleaning up... 03:17:44 INFO - Return code: 0 03:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:44 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 03:17:44 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 03:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:44 INFO - 'HOME': '/Users/cltbld', 03:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:44 INFO - 'LOGNAME': 'cltbld', 03:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:44 INFO - 'MOZ_NO_REMOTE': '1', 03:17:44 INFO - 'NO_EM_RESTART': '1', 03:17:44 INFO - 'PAGER': '/bin/cat', 03:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:44 INFO - 'PWD': '/builds/slave/test', 03:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:44 INFO - 'SHELL': '/bin/bash', 03:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:44 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:44 INFO - 'USER': 'cltbld', 03:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:44 INFO - 'XPC_FLAGS': '0x0', 03:17:44 INFO - 'XPC_SERVICE_NAME': '0', 03:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:44 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-tZshYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:44 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)) 03:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:44 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Hd76QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:44 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-polgmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Q7uxSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-2TxsnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-DX4oR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qVawyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QCKfm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-SfntkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NjZLAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-15uPeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qD8Hi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:45 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)) 03:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-LYOWiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:46 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)) 03:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-TRZdAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-m4WTT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:46 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)) 03:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-6oKUsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-RJDDQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:46 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)) 03:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:17:46 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)) 03:17:46 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)) 03:17:46 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)) 03:17:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:49 INFO - Downloading blessings-1.6.tar.gz 03:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:49 INFO - Installing collected packages: blessings 03:17:49 INFO - Running setup.py install for blessings 03:17:49 INFO - Successfully installed blessings 03:17:49 INFO - Cleaning up... 03:17:49 INFO - Return code: 0 03:17:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:49 INFO - Reading from file tmpfile_stdout 03:17:49 INFO - Current package versions: 03:17:49 INFO - blessings == 1.6 03:17:49 INFO - blobuploader == 1.2.4 03:17:49 INFO - docopt == 0.6.1 03:17:49 INFO - functools32 == 3.2.3-2 03:17:49 INFO - jsonschema == 2.5.1 03:17:49 INFO - manifestparser == 1.1 03:17:49 INFO - mozInstall == 1.12 03:17:49 INFO - mozcrash == 1.0 03:17:49 INFO - mozdebug == 0.1 03:17:49 INFO - mozdevice == 0.48 03:17:49 INFO - mozfile == 1.2 03:17:49 INFO - mozhttpd == 0.7 03:17:49 INFO - mozinfo == 0.9 03:17:49 INFO - mozleak == 0.1 03:17:49 INFO - mozlog == 3.4 03:17:49 INFO - moznetwork == 0.27 03:17:49 INFO - mozprocess == 0.23 03:17:49 INFO - mozprofile == 0.28 03:17:49 INFO - mozrunner == 6.13 03:17:49 INFO - mozscreenshot == 0.1 03:17:49 INFO - mozsystemmonitor == 0.3 03:17:49 INFO - moztest == 0.8 03:17:49 INFO - mozversion == 1.4 03:17:49 INFO - psutil == 3.1.1 03:17:49 INFO - requests == 1.2.3 03:17:49 INFO - wsgiref == 0.1.2 03:17:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:49 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 03:17:49 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 03:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:49 INFO - 'HOME': '/Users/cltbld', 03:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:49 INFO - 'LOGNAME': 'cltbld', 03:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:49 INFO - 'MOZ_NO_REMOTE': '1', 03:17:49 INFO - 'NO_EM_RESTART': '1', 03:17:49 INFO - 'PAGER': '/bin/cat', 03:17:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:49 INFO - 'PWD': '/builds/slave/test', 03:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:49 INFO - 'SHELL': '/bin/bash', 03:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:49 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:49 INFO - 'USER': 'cltbld', 03:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:49 INFO - 'XPC_FLAGS': '0x0', 03:17:49 INFO - 'XPC_SERVICE_NAME': '0', 03:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 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)) 03:17:50 INFO - Cleaning up... 03:17:50 INFO - Return code: 0 03:17:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:50 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 0x106ec2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9198ccf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, '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.NL417SswkX/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.ALbaXzaAI4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:17:50 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 03:17:50 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 03:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:50 INFO - 'HOME': '/Users/cltbld', 03:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:50 INFO - 'LOGNAME': 'cltbld', 03:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:50 INFO - 'MOZ_NO_REMOTE': '1', 03:17:50 INFO - 'NO_EM_RESTART': '1', 03:17:50 INFO - 'PAGER': '/bin/cat', 03:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:50 INFO - 'PWD': '/builds/slave/test', 03:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:50 INFO - 'SHELL': '/bin/bash', 03:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:17:50 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:50 INFO - 'USER': 'cltbld', 03:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:50 INFO - 'XPC_FLAGS': '0x0', 03:17:50 INFO - 'XPC_SERVICE_NAME': '0', 03:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:50 INFO - Cleaning up... 03:17:50 INFO - Return code: 0 03:17:50 INFO - Running post-action listener: _resource_record_post_action 03:17:50 INFO - Running post-action listener: _start_resource_monitoring 03:17:50 INFO - Starting resource monitoring. 03:17:50 INFO - [mozharness: 2017-01-06 11:17:50.322235Z] Finished create-virtualenv step (success) 03:17:50 INFO - [mozharness: 2017-01-06 11:17:50.323291Z] Running install step. 03:17:50 INFO - Running pre-action listener: _resource_record_pre_action 03:17:50 INFO - Running main action method: install 03:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:50 INFO - Reading from file tmpfile_stdout 03:17:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:50 INFO - Reading from file tmpfile_stdout 03:17:50 INFO - Output received: 03:17:50 INFO - Usage: mozinstall [options] installer 03:17:50 INFO - Options: 03:17:50 INFO - -h, --help show this help message and exit 03:17:50 INFO - -d DEST, --destination=DEST 03:17:50 INFO - Directory to install application into. [default: 03:17:50 INFO - "/builds/slave/test"] 03:17:50 INFO - --app=APP Application being installed. [default: firefox] 03:17:50 INFO - mkdir: /builds/slave/test/build/application 03:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:18:21 INFO - Reading from file tmpfile_stdout 03:18:21 INFO - Output received: 03:18:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:18:21 INFO - Running post-action listener: _resource_record_post_action 03:18:21 INFO - [mozharness: 2017-01-06 11:18:21.955774Z] Finished install step (success) 03:18:21 INFO - [mozharness: 2017-01-06 11:18:21.955934Z] Running run-tests step. 03:18:21 INFO - Running pre-action listener: _resource_record_pre_action 03:18:21 INFO - Running main action method: run_tests 03:18:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:18:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:18:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:18:21 INFO - 2017-01-06 03:18:21.970 screenresolution[1636:10160] starting screenresolution argv=screenresolution get 03:18:21 INFO - 2017-01-06 03:18:21.973 screenresolution[1636:10160] Display 0: 1600x1200x32@60 03:18:21 INFO - 2017-01-06 03:18:21.978 screenresolution[1637:10162] starting screenresolution argv=screenresolution list 03:18:21 INFO - Available Modes on Display 0 03:18:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:18:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:18:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:18:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:18:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:18:22 INFO - Intel Iris: 03:18:22 INFO - Chipset Model: Intel Iris 03:18:22 INFO - Type: GPU 03:18:22 INFO - Bus: Built-In 03:18:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:18:22 INFO - Vendor: Intel (0x8086) 03:18:22 INFO - Device ID: 0x0a2e 03:18:22 INFO - Revision ID: 0x0009 03:18:22 INFO - Displays: 03:18:22 INFO - Display: 03:18:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:18:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:18:22 INFO - Display Serial Number: 1600x1200 60 03:18:22 INFO - Main Display: Yes 03:18:22 INFO - Mirror: Off 03:18:22 INFO - Online: Yes 03:18:22 INFO - Rotation: Supported 03:18:22 INFO - Return code: 0 03:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:22 INFO - Python 2.7.3 03:18:22 INFO - Return code: 0 03:18:22 INFO - grabbing minidump binary from tooltool 03:18:22 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')]} 03:18:22 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 0x106cd6d30>, '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 0x106b3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:22 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 03:18:22 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 03:18:22 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 03:18:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:22 INFO - Return code: 0 03:18:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:18:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:18:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 03:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 03:18:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NL417SswkX/Render', 03:18:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:18:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:18:22 INFO - 'HOME': '/Users/cltbld', 03:18:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:18:22 INFO - 'LOGNAME': 'cltbld', 03:18:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:22 INFO - 'MOZ_NO_REMOTE': '1', 03:18:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:22 INFO - 'NO_EM_RESTART': '1', 03:18:22 INFO - 'PAGER': '/bin/cat', 03:18:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:22 INFO - 'PWD': '/builds/slave/test', 03:18:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:18:22 INFO - 'SHELL': '/bin/bash', 03:18:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ALbaXzaAI4/Listeners', 03:18:22 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:18:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:18:22 INFO - 'USER': 'cltbld', 03:18:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:18:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:22 INFO - 'XPC_FLAGS': '0x0', 03:18:22 INFO - 'XPC_SERVICE_NAME': '0', 03:18:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:18:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 03:18:22 INFO - mozversion application_buildid: 20170106004019 03:18:22 INFO - mozversion application_changeset: 87a48d902eb2655d031216b91375097c6faf454e 03:18:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:18:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:22 INFO - mozversion application_name: Firefox 03:18:22 INFO - mozversion application_remotingname: firefox-dev 03:18:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:22 INFO - mozversion application_vendor: Mozilla 03:18:22 INFO - mozversion application_version: 52.0a2 03:18:22 INFO - mozversion platform_buildid: 20170106004019 03:18:22 INFO - mozversion platform_changeset: 87a48d902eb2655d031216b91375097c6faf454e 03:18:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:22 INFO - mozversion platform_version: 52.0a2 03:18:22 INFO - using testdate: 1483701502 03:18:22 INFO - actual date: 1483701502 03:18:22 INFO - starting webserver on 'localhost:49248' 03:18:22 INFO - SUITE-START | Running 2 tests 03:18:22 INFO - TEST-START | dromaeo_css 03:18:22 INFO - operating with platform_type : mac_ 03:18:22 INFO - Initialising browser for dromaeo_css test... 03:18:22 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpGkRziq/profile http://localhost:49248/getInfo.html) 03:18:25 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 03:18:25 INFO - PROCESS | 1647 | colorDepth:24 03:18:25 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 03:18:25 INFO - PROCESS | 1647 | __metrics 03:18:25 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:18:25 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:18:26 INFO - TEST-INFO | 1647: exit 0 03:18:26 INFO - Browser initialized. 03:18:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:26 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpGkRziq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:38 INFO - PROCESS | 1651 | RSS: Main: 222478336 03:18:38 INFO - PROCESS | 1651 | 03:21:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 03:21:44 INFO - PROCESS | 1651 | RSS: Main: 373997568 03:21:44 INFO - PROCESS | 1651 | 03:24:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 03:24:48 INFO - PROCESS | 1651 | RSS: Main: 347676672 03:24:48 INFO - PROCESS | 1651 | 03:27:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 03:27:50 INFO - PROCESS | 1651 | RSS: Main: 343764992 03:27:50 INFO - PROCESS | 1651 | 03:30:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 03:30:53 INFO - PROCESS | 1651 | RSS: Main: 311611392 03:30:53 INFO - PROCESS | 1651 | 03:33:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 03:33:58 INFO - PROCESS | 1651 | RSS: Main: 307372032 03:33:58 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 03:37:01 INFO - PROCESS | 1651 | RSS: Main: 414896128 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | __start_tp_report 03:37:01 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 03:37:01 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 03:37:01 INFO - PROCESS | 1651 | |i|pagename|runs| 03:37:01 INFO - PROCESS | 1651 | |0;dojo.html;3261.2336101016263;3320.468725003999;3325.7173140283076;3330.0009997000893;3376.307856889338;5596.804111856086;5612.494875461208;5647.265855438797;5683.5169010634145;5695.943040569593;5609.887802243963;5678.659280443177;5687.488126068653;5700.458456446641;5717.285339332583;4342.3052311630145;4695.577398034176;5124.231365295198;5132.127538318495;5281.841544753664;5141.280220769096;5146.3309769729885;5150.896982060356;5187.48125187482;5242.868928276805;5138.075146473633;5139.48605139485;5170.586353091744;5181.481851814826;5195.818146364878;5166.767495462713;5175.663581867167;5217.608679349064;5224.08578498765;5274.340707411574;4998.350214472095;5148.124818780816;5175.870603234912;5183.2743415921805;5194.480551944813;5567.832965011056;5574.16387541872;5605.663660180402;5606.187102870102;5611.9438805612235;6122.265328160604;6176.8764624707255;6209.596376235575;6210.192674952273;6250.249970003629;6232.781852635181;6271.968640156816;6310.211223597051;6319.178506794087;6325.9051114233325;5642.463965923272;5685.886282274331;5706.629069110494;5733.598648094677;5807.738651760596;6278.751833631035;6324.873502530016;6326.145970294044;6335.556511044183;6367.872642547216;6119.326874043852;6123.877522449526;6136.294326152461;6147.846303842351;6148.938510614926;6089.604175728564;6105.542084343603;6109.890546867989;6142.450882883642;6197.597156184924;6115.127601665894;6186.536009799283;6191.040388739752;6196.287426945869;6211.16149319845;6146.815595532141;6207.34822843604;6218.689065546704;6221.9377806221355;6228.28374736902;4816.133096042746;4867.878303042452;4908.386451693538;4910.189818679878;4937.333459982929;4375.6280716138845;4376.846810361622;4420.734755914656;4421.115776844644;4431.135928493913;5712.000399929995;5717.542596592346;5719.227904232958;5726.627769194989;5754.309482862;6249.781257656051;6270.498360131179;6286.654234017082;6300.621962682254;6301.7164227609865;5546.084895992116;5621.325440947113;5622;5626.943730562642;5685.260916080883;5350.4649535046965;5371.57027437804;5395.163749618815;5412.702301373383;5435.320584926884;6300.369963003846;6307.810765677037;6319.96840015797;6321.146645202839;6330.746770129143;5837.912431313449;6132.6920582337325;6282.183316169052;6283.403076707706;6314.116023756769;5576.888462230814;6136.969315153396;6234.251889773256;6259.561830671809;6290.182276304051;6110.816675499742;6162.168107305636;6168.074788781719;6173.783917562864;6189.535784816067;6067.484263837623;6071.544634152545;6210.130581718473;6235.158253635883;6281.654509002049;5947.940520594739;6046.969765151146;6051.273847138372;6065.545084118797;6092.786752463642;6085.361037091218;6101.328853826164;6102.694865256808;6130.509559235161;6133.26400831903;5915.378885217162;5924;5945.613535120204;5948.375420580776;5952.494038006818;5869.4717475427415;5963.761449541969;5986.730597123053;5991.011483105413;6020.157177995172;5890.263717035371;5895.7052147391605;5905.616134951214;5914.645121292736;5936.940630593639 03:37:01 INFO - PROCESS | 1651 | |1;ext.html;442.2702540807667;474.0660898030878;501.3006855436666;503.1120073071033;529.1110933631497;29807.55288670669;39035.21929561407;39954.800225998864;40096.39855402164;41692;40959.795201024026;41274.58725412745;41456.58543414565;41458.75623731285;41562.79218603903;9192.908070919306;9354.906450935472;9362.2042126419;9363.4381937084;9364.672236471724;9328.347015708903;9432.575534100948;9438.764030899249;9451.385659932117;9452.385594936342;9328.860067098998;9463.384879982814;9480.573374198178;9480.668176613819;9486.952565237165;7640.465167438281;9334;9396.248300135972;9406.059394060607;9421.38760980541;9230;9294.581743821544;9296.628134874596;9308.90691093094;9310.53447327631;38821.805890970645;39164.60835391638;39184.80407597944;39215.41176882349;39216.80391598052;3131.5772370729887;3234.822084785336;3271.4275001874576;3436.244026314207;3612.7651702639505;29082.563761543595;30055.248618784488;30072.947446839473;30313.393732125456;30443.391132177232;3143.1513491357205;3160.7945483543726;3192.6488086310487;3204.3270913108277;3296.4066468035744;474988;475358;475984.6200768974;476891.61758676905;486041;33606.8319658405;34273.65726342754;34606.653933460344;57436;58014.709926450945;35648.10879728028;35655.4651680225;35825;35886.641133588855;35927.281454370765;14190.787138192936;14301.28493575317;14305.427782888568;14307.9984401093;14310.356033978496;12069.33618650965;12145.635630931087;12168.965637920699;12177.660457349684;12187.573434929735;7823.139454659983;7825.569593672289;7829.960850195713;7894.684212631545;7901.644426000844;3080.8767649294227;3213.951790723141;3221.5677163741225;3239.076863094054;3263.3310171414805;894.7092195036639;1010.6715317521688;1014.8731408573929;1040.5889673578895;1059.1368035051407;25028.24915252545;29313.706862931525;29332.560011599842;29777.957771477893;30193.69806301953;857.773384060799;868.4572142410993;923.5751554284969;1030.7062487191115;1038.5845661735216;9708.660196893075;12737.554185603645;15307.46423875159;15425.537233883002;16333.509994700178;688906;692455;694298;694795;695935;56999.71500142556;57432.42567574354;57546.7122664384;57736.71131644315;58007;1206.7526157137765;1258.1821815819608;1334.0661536924385;1334.6863487080723;1372.61566761305;28777;29314.267143321587;29595.40809183847;29801.850990745774;30888.536671950387;49194.75402623107;49684.751576241884;49703;49758.50241497539;49844;391928;433714;470989;472540;475065.62467187445;40057;40603.79698101491;40909.38635920523;40944.1811163781;41064.384034238916;44561.10877782491;44569.88575285644;44801;44987;45226.77386613178;36782.44826327661;37240.25519489649;39254.60745392624;39463.21073578455;41337.75986720403;37282.813585932985;37504;38196;38536;38668;36673.81663091668;36728.63271367252;36746.816265919566;36917.446238306984;37299.62700372961;32396.190095247806;33969.70708212789;34282.65717342795;34779.478307825906;34821.12947176341;24984.750152498244;25112.121075762992;25119.87440062788;25580.488390232462;25655.615165772157 03:37:01 INFO - PROCESS | 1651 | |2;jquery.html;330.93546758382115;345.0390662006313;382.07537758624125;384.181692993923;405.24826446940926;14470;14865.182414967172;15294.770578441332;19169;19537.609247815035;19192.232310707554;19419.32032378867;19691.113899874505;19707.113179906904;19974.60050798983;5457.508824205831;5674.09214525676;5781.537477001851;5787.189793428924;5788.507976821975;4763.928541071869;5616.073347897592;6315.526335524831;6393.0730044143575;6433.935660643404;6098.268207815068;6379.266384365811;6398.264199617034;6401.391867772578;6403.135576697133;6270.3729627037155;6279.089532017854;6308.116863639094;6308.369163083701;6319.494440444753;5282.181261904411;5484.890302193974;5498.202760599731;5512.448755124456;5538.47384498476;24009.519809603884;24618.50762984748;24820.50358992828;24879.004839806385;24991.62512562313;1708.3935203003005;2101.506146055676;2125.8724476531456;2126.138913739938;2312.2138472919287;9884.308098433112;10163.729533808273;10244.180465562811;11240.775184496346;15142.697146057017;1784.5984653453;1793.488855676139;1847.7228415737613;1887.2733997410958;1931;113238.30142547868;115827;117956.41021794922;118920;121298.78701213052;11308.321500709984;11388;11422.371769552754;11426.542938282542;11632.941835290769;14297.213653248964;14328.713425731426;14334;14350.49773257931;14370.856291437161;6224.875502489925;6780.457563394916;8039.517628942165;8316.334693224528;8341.708040218564;7610.086789585285;8050.557219352875;8231.259186673227;8234.423590348739;8362.581870906552;3909.198614284065;4332.981749288914;4456.331550267421;4461.397711308997;4473.753943533137;1892.5930924851223;1935.129191863667;1936.6804477261094;1942.854285928561;1944.8055194480721;655.8557117434157;699.7096205074939;752.443192037888;798.9121196668361;810.4731924249285;19164.137613807412;19695.901520492305;20192.798072019094;20260.594788104154;20374.898125509277;779.7796448558101;918.8989211186764;919.2875521470913;926.2266007883493;940.6895724410928;9971.850422243671;10726.875195216684;10740.113248471927;10813.783724325469;10822.997745417122;606660.7668731574;608891;610049;618673;624350;96901.53775533619;105833;112824;116860;135444.32277838746;863.210162701134;911.3984770051734;924.4545718026532;925.9166774873414;955.8709574207533;10129;17805;18584.25662973466;19116.617667646846;19118;53118.46881531135;54629;55089.44910550843;55256.72371638116;55800.72099639476;73469.14349831692;76544;77595;78403.2159678396;79173.60413197897;5426.403095659553;6336.398042185985;6878.968154776823;7006.194287656985;8215.301699355621;10667.41329226869;10685.51915163804;11183.72040698989;12346.691332716395;12500.624981250578;10648.201384896009;11040.392778397265;11090.168237382068;11121.88878111241;11279.605213817476;10333.793324133325;10461.006204410569;10768.51541680642;10813.24307298513;10911.563537458413;10727.624533141303;10859.728506787393;11064;11064.502097405797;11337.206395552232;6984.126984126984;7293.562386256842;7352.5220860643885;7452.403807695479;8189.222023907958;9050.91075223976;10839.99460099884;10929.344239345664;10950.288231264942;11005.559777609125 03:37:01 INFO - PROCESS | 1651 | |3;mootools.html;1440.762274224753;1454.0040072550303;1586.8095828500582;1725.1891610942869;1780.1989104902789;7916.525008499494;8336.458130221547;8336.833263334738;8345.874811877828;8353.4987900726;7283.599402032886;7570;7571.31858132768;7858.724944626939;8107.148749381304;2277.4078739527718;2325.837191396603;2326.8603883766946;2337.8714170720605;2340.730815956161;2104.8000439958178;2348.43637526994;2354.30547988343;2354.505553833697;2357.8231632627535;2289.404754763765;2291.232437133562;2315.6642286868396;2317.7102862142233;2331.079223706635;2272.102519504803;2296.3914562641;2300.2869110575775;2301.42464383904;2305.619572770491;2301.2981040782556;2330.1844354475966;2333.6382860656627;2337.3922780077132;2338.263447014185;8193.34453243745;8194.01671799382;8286;8289.917100828974;8315.584220788936;5053.545180933696;5214.791408343662;5219.71291578963;5220.634555581111;5231.921521177185;2788.6793018802896;3020.9848950755327;3355.798652080883;3457.7233821294235;3512.8946131615835;1050.1913526584487;1074.2533938912459;1089.3246187363884;1094.7263184203948;1095.1074873977682;9114.361994660376;10403.375797452178;10743.785124297548;10903.945480272627;10921.180911431595;4289.699721019499;4360.41134446852;4469.307257375112;4485.663575231871;4489.371487991619;8582.356323275779;8589.871151932726;8594.613242404106;8604.440711353742;8611.483311001235;5064.797408103708;5066.240063990431;5066.594672426197;5069.417017043013;5069.822556210515;3717.5353080864893;4252.064545799919;4705.106029854385;4757.904841903142;4759.619230461555;3643.198496330803;3648.7445878788762;3714.0714821294678;3737.7383583149463;3756.924861502809;1118.983215251772;1132.2810015640127;1138.7836311100864;1154.492023509653;1157.9247348922293;776.5762472397497;859.1880672764178;880.366136381804;891.2290868398788;902.1429641840278;5302.09864323066;5559;5668.716564171775;5710.486056254957;5723.771049157987;935.1536859142487;970.1365784451843;1001.2890847498358;1003.4430890855499;1030.845373194012;3567.1795487038125;3601.2437388148783;3766.9434958475645;3782.432635104701;3843.616957486376;9551;9971.850422243671;9983.051610097029;10016.54925528353;10032.398056116657;8450.323974082059;9507.524623768784;9897.851532227023;9914.950425247827;9938.155256803253;7530.962345188349;7763.378929685611;7769.300762931476;7781.455298129076;7795.688172473037;5204.531592156724;5263.421023687315;5353.437889021597;5720.771169153188;5798.072308430631;9031.819363612822;9368.4378937264;9401.952990235006;9484.288678349289;9485.762855928657;9131.726048218565;9438.150566449052;9443.763905902408;9551.235901128031;9665.936746957688;6844.691988860413;7017.193022802239;7073.717051318095;7099.503034787722;7210.567365958059;7818.452708310591;7887.290143887078;7894.328982036362;7900.960495197717;7912.564808935564;6978.092847929736;7077.079979602619;7107.964460177666;7153.2131465537705;7221.53060051095;6705.966470167813;6723.798286051427;6906.482013849082;6949.930500694928;6970.51206415546;6383.9361606383345;6539.803805885831;6601.603903765789;6620.106285651375;6678.465722742072;4792.664513484023;4810.158222311012;4860;4863.10032643962;4893.535114164149;4711.505291944297;4765.070811191785;4873.87815304606;4932.161532539549;4958.8760280993265 03:37:01 INFO - PROCESS | 1651 | |4;prototype.html;252.96711427514427;284.15747309228135;299.8275991305;306.6396983544335;311.10712255825786;5071.340725705658;5160.122779127543;5177.326947496825;5224.4775522447735;5340.679559226449;4401.899525118721;4606.57768542199;5300.257963885049;5302.655327403716;5312.335958005239;3937.739923224562;4134.4625198724125;4140.917181656365;4146.730462519941;4149.340263894452;3805.1058001369656;3829.8276577554075;3875.922481550367;3925.411188321746;4146.958530414702;3811.2568049230413;3982.900427489307;3987.381955796842;4041.979790101045;4060.5736397678115;3056.404001219763;3569.8750543730976;3965.325894597925;4001.7398869073418;4007.198560287954;3484.0418884806627;3486.093615659947;3490.947635785465;3513.578370595519;3514.6309637488207;4131.975332087286;4200.22295875261;4540.887482566759;4566.589006989387;5114.386273647149;4545.636349092098;4551.8634440966825;4558.475775285851;4571.519990400993;4584.908301833978;5265.921011184835;5327.280817089682;5532.75102620379;5560.4161563035705;5573.359063707685;3685.3182161300247;3785.712857628392;3821.407681809324;3822.7515211511163;3862.092408284051;4539.137563862889;5790.323144803038;5801.071828507418;5812.505936995318;5814.325410311262;3229.709326160657;3807.562130354989;3828.4831547741255;3830.6552410283207;3872.7676339419727;3755.9201454807344;3892.260470510594;3899.6100389960775;3909.9638595772144;3917.804109794556;4271.551487093872;4378.868633940987;4418.889527761831;4421.469423669116;4503.482099558527;4871.658983871095;5612.102063669793;5614.606977511535;5618.016847051749;5666.858328541737;1095.9669812497862;1227.7176249462673;1265.3609926986812;1270.3711662726826;1289.052546378411;752.8706939590614;769.8960640313486;815.6207363575966;862.9309655227567;876.9783202569063;4368.209034295924;4827.841318083705;4890.58430033444;4903.215485522299;4907.386576677915;4277.022369196677;5397.379301380313;5419.241306217133;5427.6200665953;5434.212039254286;4189.832406703697;4561.566651168134;4636.6058884995155;4862;4928.539671597138;2400.7719266669637;2552.2726023083333;2612.3077384493126;2683;2808.5787131929965;5058.797648094035;5371.516563509303;5496.0107180707855;5550.639208451437;5565.749541270652;4668.762777863869;5154.30416893722;5245.3214971208845;5503.2020357048;5575;4617.861464156081;4860.854174374775;5119.129747942859;5235.900460903177;5570.108782594765;4753.239481682914;5059.569936555286;5096.317605869355;5099.736168852012;5243.7976050058305;4413.646908247397;5012.9170560106;5274.91864167837;5356.973215133899;5367.946320536745;5360.785568577213;5583.469570390806;5590;5599.692016939108;5606.299212598426;3173.286010647586;3571.0893722101737;3649.6532829381167;3650.653187947247;3772.6038765929184;5019.7741101651245;5248.8425347239645;5353.946460535345;5388.919166212431;5418.701971391612;4444.955550444454;4497;5298.54962328191;5492.80775172867;5601.439856014529;4991.57571606403;5083.83071893474;5148.150555158507;5431.198161287036;5581.293072859741;4848.781804818721;5067.619928505451;5200.349956255468;5231.55531779803;5726.312842458931;4273.978075760906;5528.889422211614;5537.889242215214;5627.971860140673;5648.237487939075;4910.107870555276;5069.7211653357945;5254.605904557097;5465.9726701366235;5520.944790552204 03:37:01 INFO - PROCESS | 1651 | |5;yui.html;631.8799428108659;676.5703778100906;734.5555938657109;743.4238465189476;754.724525548175;13739.313034348292;13848.307584620767;14209.147451152925;14552.417903283882;14863.10821350717;12895.161814482051;12995.090343675947;12997.545085921995;12997.675058123552;13026.478940842355;796.8366484870617;811.4644334739073;823;826.68999125328;827.4662842466605;645.2643985856128;664.3821246240994;667.1393901866586;801.9799505012393;839.4375768235267;866.4714524140269;872.1932212703256;874.0909454167689;874.2350443362059;876.1763941894599;870.4516154822485;871.2855458524012;871.8082021955191;871.8169184471269;875.295387213293;502.9069622119919;519.4805194805194;624.7657128576784;641.5445034025847;645.7998020613625;14343.78484322736;14346.713065738732;14349.210793406359;14349.641258968504;14361.856381436157;11899.226550274205;12067;12129.878701212963;12297.385130743427;12339.876601233962;11994.70013249667;12141.15011949164;12263.202891812003;12281.877181228163;12331.75336493265;4197.9370309445385;4226.9855234743745;4293;4349.652027837766;4459.687821852472;92654.61018084666;93822;97305;98117;99800.50299245518;9420.105090016437;9951.900480995242;10148.949255253676;10220.744481387876;10456.163506919429;19303.8069619302;19324.516887077934;19346.903265483583;19395.612087758167;19633.509162271057;7103.89344159838;7177.282271772781;7206.243344448862;7326.853462930711;7327.523710958771;3951.2887680217264;3984.641382275609;4079;4084.611961863618;4264.637505812041;3192.345569158317;3287.72054375376;3289.7368210543577;3290.851911663933;3291.325278317987;594.1325664529749;616.5992105131611;628.355935166458;632.7310892870512;635.9109724638554;592.6444133519853;596.7702434562638;597.3011576455557;600.4985836826299;619.7985654662252;7393.9260607393235;8436.704715334934;8540.957295213484;8614.91385086141;8817.559122044;548.5556699073684;585.6047168161474;602.2802750712856;623.7130919776954;639.0095352204158;4174.906613930999;4199.853005144805;4228.23891699497;4230.64039556635;4263.76549289792;92386;117710;121053.39473302577;122199.16701249489;125040;102246.97753022524;105028.42457363146;105034;106250;107405.4629726862;68684.6565767178;69201;70534.64732676304;72373;92764.53617732003;9209.85911291829;9337.953310233406;9558.95220523893;9742.657133604102;9747.025297470196;41300.793496032325;42040.15919681528;49310.50689493203;50148.498515014384;51047.74476127596;52898.47101528935;53170.73414632902;62353.37646623476;70560;72809;12130.878691212974;12152.21010634306;12171.513139474677;12405.689857753629;12484.93757531243;13358.866411335763;13904.389834488316;14436.206008669624;14438.927805360907;14775.92612036933;10371.636992705218;12907.935460322638;13049.217046977212;13069.411876465392;13396;11129.610463633733;11316.49075791575;11341;11483.885161148282;11555.364454955059;11621.709457263298;12384.380780961095;12731.299778512272;12961.805572916226;13182.604521863976;10683.30558513694;10942.288751231144;11226.03544379714;11605.76788464243;12017.09871759604;10119;11312.15158863072;11352.94323528377;11491.367974761468;11546.538138474367 03:37:01 INFO - PROCESS | 1651 | __end_tp_report 03:37:01 INFO - PROCESS | 1651 | __start_cc_report 03:37:01 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1904 03:37:01 INFO - PROCESS | 1651 | __end_cc_report 03:37:01 INFO - PROCESS | 1651 | __startTimestamp1483702621400__endTimestamp 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | ------- Summary: start ------- 03:37:01 INFO - PROCESS | 1651 | Number of tests: 6 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5703.69 Median:5915.38 stddev:651.85 (11.0%) stddev-sans-first:625.05 03:37:01 INFO - PROCESS | 1651 | Values: 3261.2 3320.5 3325.7 3330.0 3376.3 5596.8 5612.5 5647.3 5683.5 5695.9 5609.9 5678.7 5687.5 5700.5 5717.3 4342.3 4695.6 5124.2 5132.1 5281.8 5141.3 5146.3 5150.9 5187.5 5242.9 5138.1 5139.5 5170.6 5181.5 5195.8 5166.8 5175.7 5217.6 5224.1 5274.3 4998.4 5148.1 5175.9 5183.3 5194.5 5567.8 5574.2 5605.7 5606.2 5611.9 6122.3 6176.9 6209.6 6210.2 6250.2 6232.8 6272.0 6310.2 6319.2 6325.9 5642.5 5685.9 5706.6 5733.6 5807.7 6278.8 6324.9 6326.1 6335.6 6367.9 6119.3 6123.9 6136.3 6147.8 6148.9 6089.6 6105.5 6109.9 6142.5 6197.6 6115.1 6186.5 6191.0 6196.3 6211.2 6146.8 6207.3 6218.7 6221.9 6228.3 4816.1 4867.9 4908.4 4910.2 4937.3 4375.6 4376.8 4420.7 4421.1 4431.1 5712.0 5717.5 5719.2 5726.6 5754.3 6249.8 6270.5 6286.7 6300.6 6301.7 5546.1 5621.3 5622.0 5626.9 5685.3 5350.5 5371.6 5395.2 5412.7 5435.3 6300.4 6307.8 6320.0 6321.1 6330.7 5837.9 6132.7 6282.2 6283.4 6314.1 5576.9 6137.0 6234.3 6259.6 6290.2 6110.8 6162.2 6168.1 6173.8 6189.5 6067.5 6071.5 6210.1 6235.2 6281.7 5947.9 6047.0 6051.3 6065.5 6092.8 6085.4 6101.3 6102.7 6130.5 6133.3 5915.4 5924.0 5945.6 5948.4 5952.5 5869.5 5963.8 5986.7 5991.0 6020.2 5890.3 5895.7 5905.6 5914.6 5936.9 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:66120.00 Median:215571.71 stddev:147738.47 (68.5%) stddev-sans-first:148070.62 03:37:01 INFO - PROCESS | 1651 | Values: 442.3 474.1 501.3 503.1 529.1 29807.6 39035.2 39954.8 40096.4 41692.0 40959.8 41274.6 41456.6 41458.8 41562.8 9192.9 9354.9 9362.2 9363.4 9364.7 9328.3 9432.6 9438.8 9451.4 9452.4 9328.9 9463.4 9480.6 9480.7 9487.0 7640.5 9334.0 9396.2 9406.1 9421.4 9230.0 9294.6 9296.6 9308.9 9310.5 38821.8 39164.6 39184.8 39215.4 39216.8 3131.6 3234.8 3271.4 3436.2 3612.8 29082.6 30055.2 30072.9 30313.4 30443.4 3143.2 3160.8 3192.6 3204.3 3296.4 474988.0 475358.0 475984.6 476891.6 486041.0 33606.8 34273.7 34606.7 57436.0 58014.7 35648.1 35655.5 35825.0 35886.6 35927.3 14190.8 14301.3 14305.4 14308.0 14310.4 12069.3 12145.6 12169.0 12177.7 12187.6 7823.1 7825.6 7830.0 7894.7 7901.6 3080.9 3214.0 3221.6 3239.1 3263.3 894.7 1010.7 1014.9 1040.6 1059.1 25028.2 29313.7 29332.6 29778.0 30193.7 857.8 868.5 923.6 1030.7 1038.6 9708.7 12737.6 15307.5 15425.5 16333.5 688906.0 692455.0 694298.0 694795.0 695935.0 56999.7 57432.4 57546.7 57736.7 58007.0 1206.8 1258.2 1334.1 1334.7 1372.6 28777.0 29314.3 29595.4 29801.9 30888.5 49194.8 49684.8 49703.0 49758.5 49844.0 391928.0 433714.0 470989.0 472540.0 475065.6 40057.0 40603.8 40909.4 40944.2 41064.4 44561.1 44569.9 44801.0 44987.0 45226.8 36782.4 37240.3 39254.6 39463.2 41337.8 37282.8 37504.0 38196.0 38536.0 38668.0 36673.8 36728.6 36746.8 36917.4 37299.6 32396.2 33969.7 34282.7 34779.5 34821.1 24984.8 25112.1 25119.9 25580.5 25655.6 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34708.53 Median:12661.28 stddev:102036.62 (805.9%) stddev-sans-first:102290.21 03:37:01 INFO - PROCESS | 1651 | Values: 330.9 345.0 382.1 384.2 405.2 14470.0 14865.2 15294.8 19169.0 19537.6 19192.2 19419.3 19691.1 19707.1 19974.6 5457.5 5674.1 5781.5 5787.2 5788.5 4763.9 5616.1 6315.5 6393.1 6433.9 6098.3 6379.3 6398.3 6401.4 6403.1 6270.4 6279.1 6308.1 6308.4 6319.5 5282.2 5484.9 5498.2 5512.4 5538.5 24009.5 24618.5 24820.5 24879.0 24991.6 1708.4 2101.5 2125.9 2126.1 2312.2 9884.3 10163.7 10244.2 11240.8 15142.7 1784.6 1793.5 1847.7 1887.3 1931.0 113238.3 115827.0 117956.4 118920.0 121298.8 11308.3 11388.0 11422.4 11426.5 11632.9 14297.2 14328.7 14334.0 14350.5 14370.9 6224.9 6780.5 8039.5 8316.3 8341.7 7610.1 8050.6 8231.3 8234.4 8362.6 3909.2 4333.0 4456.3 4461.4 4473.8 1892.6 1935.1 1936.7 1942.9 1944.8 655.9 699.7 752.4 798.9 810.5 19164.1 19695.9 20192.8 20260.6 20374.9 779.8 918.9 919.3 926.2 940.7 9971.9 10726.9 10740.1 10813.8 10823.0 606660.8 608891.0 610049.0 618673.0 624350.0 96901.5 105833.0 112824.0 116860.0 135444.3 863.2 911.4 924.5 925.9 955.9 10129.0 17805.0 18584.3 19116.6 19118.0 53118.5 54629.0 55089.4 55256.7 55800.7 73469.1 76544.0 77595.0 78403.2 79173.6 5426.4 6336.4 6879.0 7006.2 8215.3 10667.4 10685.5 11183.7 12346.7 12500.6 10648.2 11040.4 11090.2 11121.9 11279.6 10333.8 10461.0 10768.5 10813.2 10911.6 10727.6 10859.7 11064.0 11064.5 11337.2 6984.1 7293.6 7352.5 7452.4 8189.2 9050.9 10840.0 10929.3 10950.3 11005.6 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5343.75 Median:5209.66 stddev:2897.64 (55.6%) stddev-sans-first:2890.92 03:37:01 INFO - PROCESS | 1651 | Values: 1440.8 1454.0 1586.8 1725.2 1780.2 7916.5 8336.5 8336.8 8345.9 8353.5 7283.6 7570.0 7571.3 7858.7 8107.1 2277.4 2325.8 2326.9 2337.9 2340.7 2104.8 2348.4 2354.3 2354.5 2357.8 2289.4 2291.2 2315.7 2317.7 2331.1 2272.1 2296.4 2300.3 2301.4 2305.6 2301.3 2330.2 2333.6 2337.4 2338.3 8193.3 8194.0 8286.0 8289.9 8315.6 5053.5 5214.8 5219.7 5220.6 5231.9 2788.7 3021.0 3355.8 3457.7 3512.9 1050.2 1074.3 1089.3 1094.7 1095.1 9114.4 10403.4 10743.8 10903.9 10921.2 4289.7 4360.4 4469.3 4485.7 4489.4 8582.4 8589.9 8594.6 8604.4 8611.5 5064.8 5066.2 5066.6 5069.4 5069.8 3717.5 4252.1 4705.1 4757.9 4759.6 3643.2 3648.7 3714.1 3737.7 3756.9 1119.0 1132.3 1138.8 1154.5 1157.9 776.6 859.2 880.4 891.2 902.1 5302.1 5559.0 5668.7 5710.5 5723.8 935.2 970.1 1001.3 1003.4 1030.8 3567.2 3601.2 3766.9 3782.4 3843.6 9551.0 9971.9 9983.1 10016.5 10032.4 8450.3 9507.5 9897.9 9915.0 9938.2 7531.0 7763.4 7769.3 7781.5 7795.7 5204.5 5263.4 5353.4 5720.8 5798.1 9031.8 9368.4 9402.0 9484.3 9485.8 9131.7 9438.2 9443.8 9551.2 9665.9 6844.7 7017.2 7073.7 7099.5 7210.6 7818.5 7887.3 7894.3 7901.0 7912.6 6978.1 7077.1 7108.0 7153.2 7221.5 6706.0 6723.8 6906.5 6949.9 6970.5 6383.9 6539.8 6601.6 6620.1 6678.5 4792.7 4810.2 4860.0 4863.1 4893.5 4711.5 4765.1 4873.9 4932.2 4958.9 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4350.89 Median:4854.82 stddev:1325.40 (27.3%) stddev-sans-first:1292.94 03:37:01 INFO - PROCESS | 1651 | Values: 253.0 284.2 299.8 306.6 311.1 5071.3 5160.1 5177.3 5224.5 5340.7 4401.9 4606.6 5300.3 5302.7 5312.3 3937.7 4134.5 4140.9 4146.7 4149.3 3805.1 3829.8 3875.9 3925.4 4147.0 3811.3 3982.9 3987.4 4042.0 4060.6 3056.4 3569.9 3965.3 4001.7 4007.2 3484.0 3486.1 3490.9 3513.6 3514.6 4132.0 4200.2 4540.9 4566.6 5114.4 4545.6 4551.9 4558.5 4571.5 4584.9 5265.9 5327.3 5532.8 5560.4 5573.4 3685.3 3785.7 3821.4 3822.8 3862.1 4539.1 5790.3 5801.1 5812.5 5814.3 3229.7 3807.6 3828.5 3830.7 3872.8 3755.9 3892.3 3899.6 3910.0 3917.8 4271.6 4378.9 4418.9 4421.5 4503.5 4871.7 5612.1 5614.6 5618.0 5666.9 1096.0 1227.7 1265.4 1270.4 1289.1 752.9 769.9 815.6 862.9 877.0 4368.2 4827.8 4890.6 4903.2 4907.4 4277.0 5397.4 5419.2 5427.6 5434.2 4189.8 4561.6 4636.6 4862.0 4928.5 2400.8 2552.3 2612.3 2683.0 2808.6 5058.8 5371.5 5496.0 5550.6 5565.7 4668.8 5154.3 5245.3 5503.2 5575.0 4617.9 4860.9 5119.1 5235.9 5570.1 4753.2 5059.6 5096.3 5099.7 5243.8 4413.6 5012.9 5274.9 5357.0 5367.9 5360.8 5583.5 5590.0 5599.7 5606.3 3173.3 3571.1 3649.7 3650.7 3772.6 5019.8 5248.8 5353.9 5388.9 5418.7 4445.0 4497.0 5298.5 5492.8 5601.4 4991.6 5083.8 5148.2 5431.2 5581.3 4848.8 5067.6 5200.3 5231.6 5726.3 4274.0 5528.9 5537.9 5628.0 5648.2 4910.1 5069.7 5254.6 5466.0 5520.9 03:37:01 INFO - PROCESS | 1651 | 03:37:01 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20255.73 Median:23133.57 stddev:30645.55 (132.5%) stddev-sans-first:30696.09 03:37:01 INFO - PROCESS | 1651 | Values: 631.9 676.6 734.6 743.4 754.7 13739.3 13848.3 14209.1 14552.4 14863.1 12895.2 12995.1 12997.5 12997.7 13026.5 796.8 811.5 823.0 826.7 827.5 645.3 664.4 667.1 802.0 839.4 866.5 872.2 874.1 874.2 876.2 870.5 871.3 871.8 871.8 875.3 502.9 519.5 624.8 641.5 645.8 14343.8 14346.7 14349.2 14349.6 14361.9 11899.2 12067.0 12129.9 12297.4 12339.9 11994.7 12141.2 12263.2 12281.9 12331.8 4197.9 4227.0 4293.0 4349.7 4459.7 92654.6 93822.0 97305.0 98117.0 99800.5 9420.1 9951.9 10148.9 10220.7 10456.2 19303.8 19324.5 19346.9 19395.6 19633.5 7103.9 7177.3 7206.2 7326.9 7327.5 3951.3 3984.6 4079.0 4084.6 4264.6 3192.3 3287.7 3289.7 3290.9 3291.3 594.1 616.6 628.4 632.7 635.9 592.6 596.8 597.3 600.5 619.8 7393.9 8436.7 8541.0 8614.9 8817.6 548.6 585.6 602.3 623.7 639.0 4174.9 4199.9 4228.2 4230.6 4263.8 92386.0 117710.0 121053.4 122199.2 125040.0 102247.0 105028.4 105034.0 106250.0 107405.5 68684.7 69201.0 70534.6 72373.0 92764.5 9209.9 9338.0 9559.0 9742.7 9747.0 41300.8 42040.2 49310.5 50148.5 51047.7 52898.5 53170.7 62353.4 70560.0 72809.0 12130.9 12152.2 12171.5 12405.7 12484.9 13358.9 13904.4 14436.2 14438.9 14775.9 10371.6 12907.9 13049.2 13069.4 13396.0 11129.6 11316.5 11341.0 11483.9 11555.4 11621.7 12384.4 12731.3 12961.8 13182.6 10683.3 10942.3 11226.0 11605.8 12017.1 10119.0 11312.2 11352.9 11491.4 11546.5 03:37:01 INFO - PROCESS | 1651 | -------- Summary: end -------- 03:37:01 INFO - PROCESS | 1651 | 03:37:02 INFO - TEST-INFO | 1651: exit 0 03:37:02 INFO - TEST-OK | dromaeo_css | took 1119492ms 03:37:02 INFO - TEST-START | kraken 03:37:02 INFO - operating with platform_type : mac_ 03:37:02 INFO - Initialising browser for kraken test... 03:37:02 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpe3thdS/profile http://localhost:49248/getInfo.html) 03:37:04 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 03:37:04 INFO - PROCESS | 1679 | colorDepth:24 03:37:04 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 03:37:04 INFO - PROCESS | 1679 | __metrics 03:37:04 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:37:04 INFO - PROCESS | 1679 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:05 INFO - TEST-INFO | 1679: exit 0 03:37:05 INFO - Browser initialized. 03:37:05 INFO - Running cycle 1/1 for kraken test... 03:37:05 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpe3thdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:18 INFO - PROCESS | 1681 | RSS: Main: 222920704 03:37:18 INFO - PROCESS | 1681 | 03:37:20 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:21 INFO - PROCESS | 1681 | RSS: Main: 272601088 03:37:21 INFO - PROCESS | 1681 | 03:37:24 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 03:37:25 INFO - PROCESS | 1681 | RSS: Main: 284487680 03:37:25 INFO - PROCESS | 1681 | 03:37:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 03:37:28 INFO - PROCESS | 1681 | RSS: Main: 382050304 03:37:28 INFO - PROCESS | 1681 | 03:37:30 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 03:37:31 INFO - PROCESS | 1681 | RSS: Main: 282550272 03:37:31 INFO - PROCESS | 1681 | 03:37:33 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:34 INFO - PROCESS | 1681 | RSS: Main: 283500544 03:37:34 INFO - PROCESS | 1681 | 03:37:36 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:37 INFO - PROCESS | 1681 | RSS: Main: 326737920 03:37:37 INFO - PROCESS | 1681 | 03:37:40 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:41 INFO - PROCESS | 1681 | RSS: Main: 325709824 03:37:41 INFO - PROCESS | 1681 | 03:37:44 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 03:37:44 INFO - PROCESS | 1681 | RSS: Main: 324710400 03:37:44 INFO - PROCESS | 1681 | 03:37:46 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:46 INFO - PROCESS | 1681 | RSS: Main: 298745856 03:37:46 INFO - PROCESS | 1681 | 03:37:48 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:49 INFO - PROCESS | 1681 | RSS: Main: 303517696 03:37:49 INFO - PROCESS | 1681 | 03:37:51 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:52 INFO - PROCESS | 1681 | RSS: Main: 304771072 03:37:52 INFO - PROCESS | 1681 | 03:37:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:56 INFO - PROCESS | 1681 | RSS: Main: 324001792 03:37:56 INFO - PROCESS | 1681 | 03:37:59 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:59 INFO - PROCESS | 1681 | RSS: Main: 317370368 03:37:59 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 03:38:01 INFO - PROCESS | 1681 | RSS: Main: 361017344 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | __start_tp_report 03:38:01 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 03:38:01 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 03:38:01 INFO - PROCESS | 1681 | |i|pagename|runs| 03:38:01 INFO - PROCESS | 1681 | |0;ai-astar;116;116;117;116;117;114;116;114;115;115 03:38:01 INFO - PROCESS | 1681 | |1;audio-beat-detection;148;110;112;143;114;110;110;113;180;137 03:38:01 INFO - PROCESS | 1681 | |2;audio-dft;181;183;183;187;181;186;183;184;185;184 03:38:01 INFO - PROCESS | 1681 | |3;audio-fft;80;60;60;89;62;59;50;59;101;82 03:38:01 INFO - PROCESS | 1681 | |4;audio-oscillator;89;70;93;85;101;100;111;66;68;91 03:38:01 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;89;86;89;87;89;85;89;86;89;86 03:38:01 INFO - PROCESS | 1681 | |6;imaging-darkroom;98;97;99;98;97;99;98;98;98;97 03:38:01 INFO - PROCESS | 1681 | |7;imaging-desaturate;82;81;81;81;83;83;101;130;122;84 03:38:01 INFO - PROCESS | 1681 | |8;json-parse-financial;56;56;54;53;58;58;60;59;59;58 03:38:01 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;66;67;76;76;99;100;78;72;71;72 03:38:01 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;85;84;84;85;82;82;83;83;84;84 03:38:01 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;141;154;150;144;142;144;143;142;185;157 03:38:01 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;214;168;164;164;167;165;163;166;160;224 03:38:01 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;68;68;68;69;67;64;66;67;66;65 03:38:01 INFO - PROCESS | 1681 | __end_tp_report 03:38:01 INFO - PROCESS | 1681 | __start_cc_report 03:38:01 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,2087 03:38:01 INFO - PROCESS | 1681 | __end_cc_report 03:38:01 INFO - PROCESS | 1681 | __startTimestamp1483702681661__endTimestamp 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | ------- Summary: start ------- 03:38:01 INFO - PROCESS | 1681 | Number of tests: 14 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 03:38:01 INFO - PROCESS | 1681 | Values: 116.0 116.0 117.0 116.0 117.0 114.0 116.0 114.0 115.0 115.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:125.50 stddev:23.71 (18.9%) stddev-sans-first:23.98 03:38:01 INFO - PROCESS | 1681 | Values: 148.0 110.0 112.0 143.0 114.0 110.0 110.0 113.0 180.0 137.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.95 (1.1%) stddev-sans-first:1.80 03:38:01 INFO - PROCESS | 1681 | Values: 181.0 183.0 183.0 187.0 181.0 186.0 183.0 184.0 185.0 184.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:70.20 Median:61.00 stddev:16.57 (27.2%) stddev-sans-first:17.19 03:38:01 INFO - PROCESS | 1681 | Values: 80.0 60.0 60.0 89.0 62.0 59.0 50.0 59.0 101.0 82.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:77.50 stddev:15.24 (19.7%) stddev-sans-first:16.15 03:38:01 INFO - PROCESS | 1681 | Values: 89.0 70.0 93.0 85.0 101.0 100.0 111.0 66.0 68.0 91.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:89.00 stddev:1.65 (1.9%) stddev-sans-first:1.66 03:38:01 INFO - PROCESS | 1681 | Values: 89.0 86.0 89.0 87.0 89.0 85.0 89.0 86.0 89.0 86.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:98.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:38:01 INFO - PROCESS | 1681 | Values: 98.0 97.0 99.0 98.0 97.0 99.0 98.0 98.0 98.0 97.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:81.50 stddev:18.58 (22.8%) stddev-sans-first:19.29 03:38:01 INFO - PROCESS | 1681 | Values: 82.0 81.0 81.0 81.0 83.0 83.0 101.0 130.0 122.0 84.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:2.28 (3.9%) stddev-sans-first:2.39 03:38:01 INFO - PROCESS | 1681 | Values: 56.0 56.0 54.0 53.0 58.0 58.0 60.0 59.0 59.0 58.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:74.00 stddev:12.10 (16.4%) stddev-sans-first:12.07 03:38:01 INFO - PROCESS | 1681 | Values: 66.0 67.0 76.0 76.0 99.0 100.0 78.0 72.0 71.0 72.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.07 (1.3%) stddev-sans-first:1.01 03:38:01 INFO - PROCESS | 1681 | Values: 85.0 84.0 84.0 85.0 82.0 82.0 83.0 83.0 84.0 84.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:147.00 stddev:13.41 (9.1%) stddev-sans-first:13.81 03:38:01 INFO - PROCESS | 1681 | Values: 141.0 154.0 150.0 144.0 142.0 144.0 143.0 142.0 185.0 157.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:166.50 stddev:23.15 (13.9%) stddev-sans-first:19.93 03:38:01 INFO - PROCESS | 1681 | Values: 214.0 168.0 164.0 164.0 167.0 165.0 163.0 166.0 160.0 224.0 03:38:01 INFO - PROCESS | 1681 | 03:38:01 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.55 (2.3%) stddev-sans-first:1.58 03:38:01 INFO - PROCESS | 1681 | Values: 68.0 68.0 68.0 69.0 67.0 64.0 66.0 67.0 66.0 65.0 03:38:01 INFO - PROCESS | 1681 | -------- Summary: end -------- 03:38:01 INFO - PROCESS | 1681 | 03:38:02 INFO - TEST-INFO | 1681: exit 0 03:38:02 INFO - TEST-OK | kraken | took 60700ms 03:38:02 INFO - SUITE-END | took 1180s 03:38:02 INFO - Completed test suite (00:19:40) 03:38:02 INFO - javascript benchmark 03:38:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.2336101016263, 3320.468725003999, 3325.7173140283076, 3330.0009997000893, 3376.307856889338, 5596.804111856086, 5612.494875461208, 5647.265855438797, 5683.5169010634145, 5695.943040569593, 5609.887802243963, 5678.659280443177, 5687.488126068653, 5700.458456446641, 5717.285339332583, 4342.3052311630145, 4695.577398034176, 5124.231365295198, 5132.127538318495, 5281.841544753664, 5141.280220769096, 5146.3309769729885, 5150.896982060356, 5187.48125187482, 5242.868928276805, 5138.075146473633, 5139.48605139485, 5170.586353091744, 5181.481851814826, 5195.818146364878, 5166.767495462713, 5175.663581867167, 5217.608679349064, 5224.08578498765, 5274.340707411574, 4998.350214472095, 5148.124818780816, 5175.870603234912, 5183.2743415921805, 5194.480551944813, 5567.832965011056, 5574.16387541872, 5605.663660180402, 5606.187102870102, 5611.9438805612235, 6122.265328160604, 6176.8764624707255, 6209.596376235575, 6210.192674952273, 6250.249970003629, 6232.781852635181, 6271.968640156816, 6310.211223597051, 6319.178506794087, 6325.9051114233325, 5642.463965923272, 5685.886282274331, 5706.629069110494, 5733.598648094677, 5807.738651760596, 6278.751833631035, 6324.873502530016, 6326.145970294044, 6335.556511044183, 6367.872642547216, 6119.326874043852, 6123.877522449526, 6136.294326152461, 6147.846303842351, 6148.938510614926, 6089.604175728564, 6105.542084343603, 6109.890546867989, 6142.450882883642, 6197.597156184924, 6115.127601665894, 6186.536009799283, 6191.040388739752, 6196.287426945869, 6211.16149319845, 6146.815595532141, 6207.34822843604, 6218.689065546704, 6221.9377806221355, 6228.28374736902, 4816.133096042746, 4867.878303042452, 4908.386451693538, 4910.189818679878, 4937.333459982929, 4375.6280716138845, 4376.846810361622, 4420.734755914656, 4421.115776844644, 4431.135928493913, 5712.000399929995, 5717.542596592346, 5719.227904232958, 5726.627769194989, 5754.309482862, 6249.781257656051, 6270.498360131179, 6286.654234017082, 6300.621962682254, 6301.7164227609865, 5546.084895992116, 5621.325440947113, 5622.0, 5626.943730562642, 5685.260916080883, 5350.4649535046965, 5371.57027437804, 5395.163749618815, 5412.702301373383, 5435.320584926884, 6300.369963003846, 6307.810765677037, 6319.96840015797, 6321.146645202839, 6330.746770129143, 5837.912431313449, 6132.6920582337325, 6282.183316169052, 6283.403076707706, 6314.116023756769, 5576.888462230814, 6136.969315153396, 6234.251889773256, 6259.561830671809, 6290.182276304051, 6110.816675499742, 6162.168107305636, 6168.074788781719, 6173.783917562864, 6189.535784816067, 6067.484263837623, 6071.544634152545, 6210.130581718473, 6235.158253635883, 6281.654509002049, 5947.940520594739, 6046.969765151146, 6051.273847138372, 6065.545084118797, 6092.786752463642, 6085.361037091218, 6101.328853826164, 6102.694865256808, 6130.509559235161, 6133.26400831903, 5915.378885217162, 5924.0, 5945.613535120204, 5948.375420580776, 5952.494038006818, 5869.4717475427415, 5963.761449541969, 5986.730597123053, 5991.011483105413, 6020.157177995172, 5890.263717035371, 5895.7052147391605, 5905.616134951214, 5914.645121292736, 5936.940630593639], "value": 5660.527014790319, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.2702540807667, 474.0660898030878, 501.3006855436666, 503.1120073071033, 529.1110933631497, 29807.55288670669, 39035.21929561407, 39954.800225998864, 40096.39855402164, 41692.0, 40959.795201024026, 41274.58725412745, 41456.58543414565, 41458.75623731285, 41562.79218603903, 9192.908070919306, 9354.906450935472, 9362.2042126419, 9363.4381937084, 9364.672236471724, 9328.347015708903, 9432.575534100948, 9438.764030899249, 9451.385659932117, 9452.385594936342, 9328.860067098998, 9463.384879982814, 9480.573374198178, 9480.668176613819, 9486.952565237165, 7640.465167438281, 9334.0, 9396.248300135972, 9406.059394060607, 9421.38760980541, 9230.0, 9294.581743821544, 9296.628134874596, 9308.90691093094, 9310.53447327631, 38821.805890970645, 39164.60835391638, 39184.80407597944, 39215.41176882349, 39216.80391598052, 3131.5772370729887, 3234.822084785336, 3271.4275001874576, 3436.244026314207, 3612.7651702639505, 29082.563761543595, 30055.248618784488, 30072.947446839473, 30313.393732125456, 30443.391132177232, 3143.1513491357205, 3160.7945483543726, 3192.6488086310487, 3204.3270913108277, 3296.4066468035744, 474988.0, 475358.0, 475984.6200768974, 476891.61758676905, 486041.0, 33606.8319658405, 34273.65726342754, 34606.653933460344, 57436.0, 58014.709926450945, 35648.10879728028, 35655.4651680225, 35825.0, 35886.641133588855, 35927.281454370765, 14190.787138192936, 14301.28493575317, 14305.427782888568, 14307.9984401093, 14310.356033978496, 12069.33618650965, 12145.635630931087, 12168.965637920699, 12177.660457349684, 12187.573434929735, 7823.139454659983, 7825.569593672289, 7829.960850195713, 7894.684212631545, 7901.644426000844, 3080.8767649294227, 3213.951790723141, 3221.5677163741225, 3239.076863094054, 3263.3310171414805, 894.7092195036639, 1010.6715317521688, 1014.8731408573929, 1040.5889673578895, 1059.1368035051407, 25028.24915252545, 29313.706862931525, 29332.560011599842, 29777.957771477893, 30193.69806301953, 857.773384060799, 868.4572142410993, 923.5751554284969, 1030.7062487191115, 1038.5845661735216, 9708.660196893075, 12737.554185603645, 15307.46423875159, 15425.537233883002, 16333.509994700178, 688906.0, 692455.0, 694298.0, 694795.0, 695935.0, 56999.71500142556, 57432.42567574354, 57546.7122664384, 57736.71131644315, 58007.0, 1206.7526157137765, 1258.1821815819608, 1334.0661536924385, 1334.6863487080723, 1372.61566761305, 28777.0, 29314.267143321587, 29595.40809183847, 29801.850990745774, 30888.536671950387, 49194.75402623107, 49684.751576241884, 49703.0, 49758.50241497539, 49844.0, 391928.0, 433714.0, 470989.0, 472540.0, 475065.62467187445, 40057.0, 40603.79698101491, 40909.38635920523, 40944.1811163781, 41064.384034238916, 44561.10877782491, 44569.88575285644, 44801.0, 44987.0, 45226.77386613178, 36782.44826327661, 37240.25519489649, 39254.60745392624, 39463.21073578455, 41337.75986720403, 37282.813585932985, 37504.0, 38196.0, 38536.0, 38668.0, 36673.81663091668, 36728.63271367252, 36746.816265919566, 36917.446238306984, 37299.62700372961, 32396.190095247806, 33969.70708212789, 34282.65717342795, 34779.478307825906, 34821.12947176341, 24984.750152498244, 25112.121075762992, 25119.87440062788, 25580.488390232462, 25655.615165772157], "value": 18231.571338279366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.93546758382115, 345.0390662006313, 382.07537758624125, 384.181692993923, 405.24826446940926, 14470.0, 14865.182414967172, 15294.770578441332, 19169.0, 19537.609247815035, 19192.232310707554, 19419.32032378867, 19691.113899874505, 19707.113179906904, 19974.60050798983, 5457.508824205831, 5674.09214525676, 5781.537477001851, 5787.189793428924, 5788.507976821975, 4763.928541071869, 5616.073347897592, 6315.526335524831, 6393.0730044143575, 6433.935660643404, 6098.268207815068, 6379.266384365811, 6398.264199617034, 6401.391867772578, 6403.135576697133, 6270.3729627037155, 6279.089532017854, 6308.116863639094, 6308.369163083701, 6319.494440444753, 5282.181261904411, 5484.890302193974, 5498.202760599731, 5512.448755124456, 5538.47384498476, 24009.519809603884, 24618.50762984748, 24820.50358992828, 24879.004839806385, 24991.62512562313, 1708.3935203003005, 2101.506146055676, 2125.8724476531456, 2126.138913739938, 2312.2138472919287, 9884.308098433112, 10163.729533808273, 10244.180465562811, 11240.775184496346, 15142.697146057017, 1784.5984653453, 1793.488855676139, 1847.7228415737613, 1887.2733997410958, 1931.0, 113238.30142547868, 115827.0, 117956.41021794922, 118920.0, 121298.78701213052, 11308.321500709984, 11388.0, 11422.371769552754, 11426.542938282542, 11632.941835290769, 14297.213653248964, 14328.713425731426, 14334.0, 14350.49773257931, 14370.856291437161, 6224.875502489925, 6780.457563394916, 8039.517628942165, 8316.334693224528, 8341.708040218564, 7610.086789585285, 8050.557219352875, 8231.259186673227, 8234.423590348739, 8362.581870906552, 3909.198614284065, 4332.981749288914, 4456.331550267421, 4461.397711308997, 4473.753943533137, 1892.5930924851223, 1935.129191863667, 1936.6804477261094, 1942.854285928561, 1944.8055194480721, 655.8557117434157, 699.7096205074939, 752.443192037888, 798.9121196668361, 810.4731924249285, 19164.137613807412, 19695.901520492305, 20192.798072019094, 20260.594788104154, 20374.898125509277, 779.7796448558101, 918.8989211186764, 919.2875521470913, 926.2266007883493, 940.6895724410928, 9971.850422243671, 10726.875195216684, 10740.113248471927, 10813.783724325469, 10822.997745417122, 606660.7668731574, 608891.0, 610049.0, 618673.0, 624350.0, 96901.53775533619, 105833.0, 112824.0, 116860.0, 135444.32277838746, 863.210162701134, 911.3984770051734, 924.4545718026532, 925.9166774873414, 955.8709574207533, 10129.0, 17805.0, 18584.25662973466, 19116.617667646846, 19118.0, 53118.46881531135, 54629.0, 55089.44910550843, 55256.72371638116, 55800.72099639476, 73469.14349831692, 76544.0, 77595.0, 78403.2159678396, 79173.60413197897, 5426.403095659553, 6336.398042185985, 6878.968154776823, 7006.194287656985, 8215.301699355621, 10667.41329226869, 10685.51915163804, 11183.72040698989, 12346.691332716395, 12500.624981250578, 10648.201384896009, 11040.392778397265, 11090.168237382068, 11121.88878111241, 11279.605213817476, 10333.793324133325, 10461.006204410569, 10768.51541680642, 10813.24307298513, 10911.563537458413, 10727.624533141303, 10859.728506787393, 11064.0, 11064.502097405797, 11337.206395552232, 6984.126984126984, 7293.562386256842, 7352.5220860643885, 7452.403807695479, 8189.222023907958, 9050.91075223976, 10839.99460099884, 10929.344239345664, 10950.288231264942, 11005.559777609125], "value": 9190.625755732375, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.762274224753, 1454.0040072550303, 1586.8095828500582, 1725.1891610942869, 1780.1989104902789, 7916.525008499494, 8336.458130221547, 8336.833263334738, 8345.874811877828, 8353.4987900726, 7283.599402032886, 7570.0, 7571.31858132768, 7858.724944626939, 8107.148749381304, 2277.4078739527718, 2325.837191396603, 2326.8603883766946, 2337.8714170720605, 2340.730815956161, 2104.8000439958178, 2348.43637526994, 2354.30547988343, 2354.505553833697, 2357.8231632627535, 2289.404754763765, 2291.232437133562, 2315.6642286868396, 2317.7102862142233, 2331.079223706635, 2272.102519504803, 2296.3914562641, 2300.2869110575775, 2301.42464383904, 2305.619572770491, 2301.2981040782556, 2330.1844354475966, 2333.6382860656627, 2337.3922780077132, 2338.263447014185, 8193.34453243745, 8194.01671799382, 8286.0, 8289.917100828974, 8315.584220788936, 5053.545180933696, 5214.791408343662, 5219.71291578963, 5220.634555581111, 5231.921521177185, 2788.6793018802896, 3020.9848950755327, 3355.798652080883, 3457.7233821294235, 3512.8946131615835, 1050.1913526584487, 1074.2533938912459, 1089.3246187363884, 1094.7263184203948, 1095.1074873977682, 9114.361994660376, 10403.375797452178, 10743.785124297548, 10903.945480272627, 10921.180911431595, 4289.699721019499, 4360.41134446852, 4469.307257375112, 4485.663575231871, 4489.371487991619, 8582.356323275779, 8589.871151932726, 8594.613242404106, 8604.440711353742, 8611.483311001235, 5064.797408103708, 5066.240063990431, 5066.594672426197, 5069.417017043013, 5069.822556210515, 3717.5353080864893, 4252.064545799919, 4705.106029854385, 4757.904841903142, 4759.619230461555, 3643.198496330803, 3648.7445878788762, 3714.0714821294678, 3737.7383583149463, 3756.924861502809, 1118.983215251772, 1132.2810015640127, 1138.7836311100864, 1154.492023509653, 1157.9247348922293, 776.5762472397497, 859.1880672764178, 880.366136381804, 891.2290868398788, 902.1429641840278, 5302.09864323066, 5559.0, 5668.716564171775, 5710.486056254957, 5723.771049157987, 935.1536859142487, 970.1365784451843, 1001.2890847498358, 1003.4430890855499, 1030.845373194012, 3567.1795487038125, 3601.2437388148783, 3766.9434958475645, 3782.432635104701, 3843.616957486376, 9551.0, 9971.850422243671, 9983.051610097029, 10016.54925528353, 10032.398056116657, 8450.323974082059, 9507.524623768784, 9897.851532227023, 9914.950425247827, 9938.155256803253, 7530.962345188349, 7763.378929685611, 7769.300762931476, 7781.455298129076, 7795.688172473037, 5204.531592156724, 5263.421023687315, 5353.437889021597, 5720.771169153188, 5798.072308430631, 9031.819363612822, 9368.4378937264, 9401.952990235006, 9484.288678349289, 9485.762855928657, 9131.726048218565, 9438.150566449052, 9443.763905902408, 9551.235901128031, 9665.936746957688, 6844.691988860413, 7017.193022802239, 7073.717051318095, 7099.503034787722, 7210.567365958059, 7818.452708310591, 7887.290143887078, 7894.328982036362, 7900.960495197717, 7912.564808935564, 6978.092847929736, 7077.079979602619, 7107.964460177666, 7153.2131465537705, 7221.53060051095, 6705.966470167813, 6723.798286051427, 6906.482013849082, 6949.930500694928, 6970.51206415546, 6383.9361606383345, 6539.803805885831, 6601.603903765789, 6620.106285651375, 6678.465722742072, 4792.664513484023, 4810.158222311012, 4860.0, 4863.10032643962, 4893.535114164149, 4711.505291944297, 4765.070811191785, 4873.87815304606, 4932.161532539549, 4958.8760280993265], "value": 4351.5330498194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.96711427514427, 284.15747309228135, 299.8275991305, 306.6396983544335, 311.10712255825786, 5071.340725705658, 5160.122779127543, 5177.326947496825, 5224.4775522447735, 5340.679559226449, 4401.899525118721, 4606.57768542199, 5300.257963885049, 5302.655327403716, 5312.335958005239, 3937.739923224562, 4134.4625198724125, 4140.917181656365, 4146.730462519941, 4149.340263894452, 3805.1058001369656, 3829.8276577554075, 3875.922481550367, 3925.411188321746, 4146.958530414702, 3811.2568049230413, 3982.900427489307, 3987.381955796842, 4041.979790101045, 4060.5736397678115, 3056.404001219763, 3569.8750543730976, 3965.325894597925, 4001.7398869073418, 4007.198560287954, 3484.0418884806627, 3486.093615659947, 3490.947635785465, 3513.578370595519, 3514.6309637488207, 4131.975332087286, 4200.22295875261, 4540.887482566759, 4566.589006989387, 5114.386273647149, 4545.636349092098, 4551.8634440966825, 4558.475775285851, 4571.519990400993, 4584.908301833978, 5265.921011184835, 5327.280817089682, 5532.75102620379, 5560.4161563035705, 5573.359063707685, 3685.3182161300247, 3785.712857628392, 3821.407681809324, 3822.7515211511163, 3862.092408284051, 4539.137563862889, 5790.323144803038, 5801.071828507418, 5812.505936995318, 5814.325410311262, 3229.709326160657, 3807.562130354989, 3828.4831547741255, 3830.6552410283207, 3872.7676339419727, 3755.9201454807344, 3892.260470510594, 3899.6100389960775, 3909.9638595772144, 3917.804109794556, 4271.551487093872, 4378.868633940987, 4418.889527761831, 4421.469423669116, 4503.482099558527, 4871.658983871095, 5612.102063669793, 5614.606977511535, 5618.016847051749, 5666.858328541737, 1095.9669812497862, 1227.7176249462673, 1265.3609926986812, 1270.3711662726826, 1289.052546378411, 752.8706939590614, 769.8960640313486, 815.6207363575966, 862.9309655227567, 876.9783202569063, 4368.209034295924, 4827.841318083705, 4890.58430033444, 4903.215485522299, 4907.386576677915, 4277.022369196677, 5397.379301380313, 5419.241306217133, 5427.6200665953, 5434.212039254286, 4189.832406703697, 4561.566651168134, 4636.6058884995155, 4862.0, 4928.539671597138, 2400.7719266669637, 2552.2726023083333, 2612.3077384493126, 2683.0, 2808.5787131929965, 5058.797648094035, 5371.516563509303, 5496.0107180707855, 5550.639208451437, 5565.749541270652, 4668.762777863869, 5154.30416893722, 5245.3214971208845, 5503.2020357048, 5575.0, 4617.861464156081, 4860.854174374775, 5119.129747942859, 5235.900460903177, 5570.108782594765, 4753.239481682914, 5059.569936555286, 5096.317605869355, 5099.736168852012, 5243.7976050058305, 4413.646908247397, 5012.9170560106, 5274.91864167837, 5356.973215133899, 5367.946320536745, 5360.785568577213, 5583.469570390806, 5590.0, 5599.692016939108, 5606.299212598426, 3173.286010647586, 3571.0893722101737, 3649.6532829381167, 3650.653187947247, 3772.6038765929184, 5019.7741101651245, 5248.8425347239645, 5353.946460535345, 5388.919166212431, 5418.701971391612, 4444.955550444454, 4497.0, 5298.54962328191, 5492.80775172867, 5601.439856014529, 4991.57571606403, 5083.83071893474, 5148.150555158507, 5431.198161287036, 5581.293072859741, 4848.781804818721, 5067.619928505451, 5200.349956255468, 5231.55531779803, 5726.312842458931, 4273.978075760906, 5528.889422211614, 5537.889242215214, 5627.971860140673, 5648.237487939075, 4910.107870555276, 5069.7211653357945, 5254.605904557097, 5465.9726701366235, 5520.944790552204], "value": 3921.672336034847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.8799428108659, 676.5703778100906, 734.5555938657109, 743.4238465189476, 754.724525548175, 13739.313034348292, 13848.307584620767, 14209.147451152925, 14552.417903283882, 14863.10821350717, 12895.161814482051, 12995.090343675947, 12997.545085921995, 12997.675058123552, 13026.478940842355, 796.8366484870617, 811.4644334739073, 823.0, 826.68999125328, 827.4662842466605, 645.2643985856128, 664.3821246240994, 667.1393901866586, 801.9799505012393, 839.4375768235267, 866.4714524140269, 872.1932212703256, 874.0909454167689, 874.2350443362059, 876.1763941894599, 870.4516154822485, 871.2855458524012, 871.8082021955191, 871.8169184471269, 875.295387213293, 502.9069622119919, 519.4805194805194, 624.7657128576784, 641.5445034025847, 645.7998020613625, 14343.78484322736, 14346.713065738732, 14349.210793406359, 14349.641258968504, 14361.856381436157, 11899.226550274205, 12067.0, 12129.878701212963, 12297.385130743427, 12339.876601233962, 11994.70013249667, 12141.15011949164, 12263.202891812003, 12281.877181228163, 12331.75336493265, 4197.9370309445385, 4226.9855234743745, 4293.0, 4349.652027837766, 4459.687821852472, 92654.61018084666, 93822.0, 97305.0, 98117.0, 99800.50299245518, 9420.105090016437, 9951.900480995242, 10148.949255253676, 10220.744481387876, 10456.163506919429, 19303.8069619302, 19324.516887077934, 19346.903265483583, 19395.612087758167, 19633.509162271057, 7103.89344159838, 7177.282271772781, 7206.243344448862, 7326.853462930711, 7327.523710958771, 3951.2887680217264, 3984.641382275609, 4079.0, 4084.611961863618, 4264.637505812041, 3192.345569158317, 3287.72054375376, 3289.7368210543577, 3290.851911663933, 3291.325278317987, 594.1325664529749, 616.5992105131611, 628.355935166458, 632.7310892870512, 635.9109724638554, 592.6444133519853, 596.7702434562638, 597.3011576455557, 600.4985836826299, 619.7985654662252, 7393.9260607393235, 8436.704715334934, 8540.957295213484, 8614.91385086141, 8817.559122044, 548.5556699073684, 585.6047168161474, 602.2802750712856, 623.7130919776954, 639.0095352204158, 4174.906613930999, 4199.853005144805, 4228.23891699497, 4230.64039556635, 4263.76549289792, 92386.0, 117710.0, 121053.39473302577, 122199.16701249489, 125040.0, 102246.97753022524, 105028.42457363146, 105034.0, 106250.0, 107405.4629726862, 68684.6565767178, 69201.0, 70534.64732676304, 72373.0, 92764.53617732003, 9209.85911291829, 9337.953310233406, 9558.95220523893, 9742.657133604102, 9747.025297470196, 41300.793496032325, 42040.15919681528, 49310.50689493203, 50148.498515014384, 51047.74476127596, 52898.47101528935, 53170.73414632902, 62353.37646623476, 70560.0, 72809.0, 12130.878691212974, 12152.21010634306, 12171.513139474677, 12405.689857753629, 12484.93757531243, 13358.866411335763, 13904.389834488316, 14436.206008669624, 14438.927805360907, 14775.92612036933, 10371.636992705218, 12907.935460322638, 13049.217046977212, 13069.411876465392, 13396.0, 11129.610463633733, 11316.49075791575, 11341.0, 11483.885161148282, 11555.364454955059, 11621.709457263298, 12384.380780961095, 12731.299778512272, 12961.805572916226, 13182.604521863976, 10683.30558513694, 10942.288751231144, 11226.03544379714, 11605.76788464243, 12017.09871759604, 10119.0, 11312.15158863072, 11352.94323528377, 11491.367974761468, 11546.538138474367], "value": 7105.6457322311835, "unit": "score"}], "name": "dromaeo_css", "value": 6973.725219544323, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 114.0, 116.0, 114.0, 115.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 112.0, 143.0, 114.0, 110.0, 110.0, 113.0, 180.0, 137.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 187.0, 181.0, 186.0, 183.0, 184.0, 185.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 89.0, 62.0, 59.0, 50.0, 59.0, 101.0, 82.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 93.0, 85.0, 101.0, 100.0, 111.0, 66.0, 68.0, 91.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 85.0, 89.0, 86.0, 89.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 99.0, 98.0, 97.0, 99.0, 98.0, 98.0, 98.0, 97.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 83.0, 83.0, 101.0, 130.0, 122.0, 84.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 53.0, 58.0, 58.0, 60.0, 59.0, 59.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 76.0, 76.0, 99.0, 100.0, 78.0, 72.0, 71.0, 72.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 82.0, 82.0, 83.0, 83.0, 84.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 150.0, 144.0, 142.0, 144.0, 143.0, 142.0, 185.0, 157.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 168.0, 164.0, 164.0, 167.0, 165.0, 163.0, 166.0, 160.0, 224.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 67.0, 64.0, 66.0, 67.0, 66.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1473.7, "alertThreshold": 2.0}]} 03:38:02 INFO - Return code: 0 03:38:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:02 INFO - # TBPL SUCCESS # 03:38:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:38:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:38:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:38:03 INFO - 2017-01-06 03:38:03.000 screenresolution[1685:12473] starting screenresolution argv=screenresolution get 03:38:03 INFO - 2017-01-06 03:38:03.003 screenresolution[1685:12473] Display 0: 1600x1200x32@60 03:38:03 INFO - 2017-01-06 03:38:03.009 screenresolution[1686:12476] starting screenresolution argv=screenresolution list 03:38:03 INFO - Available Modes on Display 0 03:38:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:38:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:38:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:38:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:38:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:38:03 INFO - Intel Iris: 03:38:03 INFO - Chipset Model: Intel Iris 03:38:03 INFO - Type: GPU 03:38:03 INFO - Bus: Built-In 03:38:03 INFO - VRAM (Dynamic, Max): 1536 MB 03:38:03 INFO - Vendor: Intel (0x8086) 03:38:03 INFO - Device ID: 0x0a2e 03:38:03 INFO - Revision ID: 0x0009 03:38:03 INFO - Displays: 03:38:03 INFO - Display: 03:38:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:38:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:38:03 INFO - Display Serial Number: 1600x1200 60 03:38:03 INFO - Main Display: Yes 03:38:03 INFO - Mirror: Off 03:38:03 INFO - Online: Yes 03:38:03 INFO - Rotation: Supported 03:38:03 INFO - Return code: 0 03:38:03 INFO - Running post-action listener: _resource_record_post_action 03:38:03 INFO - [mozharness: 2017-01-06 11:38:03.258713Z] Finished run-tests step (success) 03:38:03 INFO - Running post-run listener: _resource_record_post_run 03:38:03 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32562176; Write bytes: 662624768; Read time: 197; Write time: 1980 03:38:03 INFO - TinderboxPrint: CPU usage
53.6% 03:38:03 INFO - TinderboxPrint: I/O read bytes / time
32,562,176 / 197 03:38:03 INFO - TinderboxPrint: I/O write bytes / time
662,624,768 / 1,980 03:38:03 INFO - TinderboxPrint: CPU idle
2,251.9 (46.4%) 03:38:03 INFO - TinderboxPrint: CPU system
973.8 (20.1%) 03:38:03 INFO - TinderboxPrint: CPU user
1,623.9 (33.5%) 03:38:03 INFO - TinderboxPrint: Swap in / out
377,196,544 / 0 03:38:03 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 342929920; Write bytes: 336877568; Read time: 26816; Write time: 755 03:38:03 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30747648; Write bytes: 310325760; Read time: 183; Write time: 1174 03:38:03 INFO - Running post-run listener: _upload_blobber_files 03:38:03 INFO - Blob upload gear active. 03:38:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:03 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 03:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:38:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:38:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:05 INFO - (blobuploader) - INFO - Done attempting. 03:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:38:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:06 INFO - (blobuploader) - INFO - Done attempting. 03:38:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:09 INFO - (blobuploader) - INFO - Done attempting. 03:38:09 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:09 INFO - Return code: 0 03:38:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1798997e04f86d2440815cf7afacbd216e1b7b653a46375d8bcfa35262269527e047a50c15d50f4413e33dc3adf003217ecbe7f6b52cbbe63513fbba1d6a9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9108ed536577586e653c4183232f83db0433d9d783ae03462ec8ec2e754b678b89559f669b9110dfb0d27769447a56a2b481b4b56fd3f84537e3502f941d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60e23f2ea4fb4e6d0db380186cefa62712178a3fcadca0fbbfb4394b3078d6a5cb5a9606e14abf57a901c8515e0b16d753e9ca1b04caef868d27ea9116e2d16"} 03:38:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:09 INFO - Contents: 03:38:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1798997e04f86d2440815cf7afacbd216e1b7b653a46375d8bcfa35262269527e047a50c15d50f4413e33dc3adf003217ecbe7f6b52cbbe63513fbba1d6a9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9108ed536577586e653c4183232f83db0433d9d783ae03462ec8ec2e754b678b89559f669b9110dfb0d27769447a56a2b481b4b56fd3f84537e3502f941d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60e23f2ea4fb4e6d0db380186cefa62712178a3fcadca0fbbfb4394b3078d6a5cb5a9606e14abf57a901c8515e0b16d753e9ca1b04caef868d27ea9116e2d16"} 03:38:09 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:09 INFO - Copying logs to upload dir... 03:38:09 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.091223 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-06 03:38:09.936330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 03:38:09.940198) ========= 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.NL417SswkX/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.ALbaXzaAI4/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/Mozilla-Aurora/sha512/f1798997e04f86d2440815cf7afacbd216e1b7b653a46375d8bcfa35262269527e047a50c15d50f4413e33dc3adf003217ecbe7f6b52cbbe63513fbba1d6a9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9108ed536577586e653c4183232f83db0433d9d783ae03462ec8ec2e754b678b89559f669b9110dfb0d27769447a56a2b481b4b56fd3f84537e3502f941d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60e23f2ea4fb4e6d0db380186cefa62712178a3fcadca0fbbfb4394b3078d6a5cb5a9606e14abf57a901c8515e0b16d753e9ca1b04caef868d27ea9116e2d16"} build_url:https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/R2REfRbRSPSpkhwxriLnSA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1798997e04f86d2440815cf7afacbd216e1b7b653a46375d8bcfa35262269527e047a50c15d50f4413e33dc3adf003217ecbe7f6b52cbbe63513fbba1d6a9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9108ed536577586e653c4183232f83db0433d9d783ae03462ec8ec2e754b678b89559f669b9110dfb0d27769447a56a2b481b4b56fd3f84537e3502f941d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60e23f2ea4fb4e6d0db380186cefa62712178a3fcadca0fbbfb4394b3078d6a5cb5a9606e14abf57a901c8515e0b16d753e9ca1b04caef868d27ea9116e2d16"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 03:38:09.974792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 03:38:09.975121) ========= 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.NL417SswkX/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.ALbaXzaAI4/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005194 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 03:38:10.023549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 03:38:10.023857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 03:38:10.024168) ========= ========= Total master_lag: 0.25 =========