builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1477039907.72 results: success (0) buildid: 20161020233149 builduid: a077cb3d8264443e8ac43f230c1944fb revision: 75c306c21c0f719b590d4ebd63e1ca7ad8981adc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.717152) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.717670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.717988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.743047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.743370) ========= 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.TQPnZkEuzF/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.dbLBccf8JV/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-21 01:51:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-10-21 01:51:47 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137579 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.903393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.903727) ========= 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.TQPnZkEuzF/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.dbLBccf8JV/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.036715 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:47.960519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-21 01:51:47.960856) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 75c306c21c0f719b590d4ebd63e1ca7ad8981adc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 75c306c21c0f719b590d4ebd63e1ca7ad8981adc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TQPnZkEuzF/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.dbLBccf8JV/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-21 01:51:48,050 truncating revision to first 12 chars 2016-10-21 01:51:48,050 Setting DEBUG logging. 2016-10-21 01:51:48,050 attempt 1/10 2016-10-21 01:51:48,050 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/75c306c21c0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 01:51:50,183 unpacking tar archive at: fx-team-75c306c21c0f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.614893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-21 01:51:50.597263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:50.597575) ========= script_repo_revision: 75c306c21c0f719b590d4ebd63e1ca7ad8981adc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:50.597972) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:50.598236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 01:51:50.615896) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-21 01:51:50.616174) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TQPnZkEuzF/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.dbLBccf8JV/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:51:50 INFO - MultiFileLogger online at 20161021 01:51:50 in /builds/slave/test 01:51:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:51:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:51:50 INFO - {'append_to_log': False, 01:51:50 INFO - 'base_work_dir': '/builds/slave/test', 01:51:50 INFO - 'blob_upload_branch': 'Fx-Team', 01:51:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:51:50 INFO - 'branch': 'Fx-Team', 01:51:50 INFO - 'buildbot_json_path': 'buildprops.json', 01:51:50 INFO - 'config_files': ('talos/mac_config.py',), 01:51:50 INFO - 'default_actions': ('clobber', 01:51:50 INFO - 'read-buildbot-config', 01:51:50 INFO - 'download-and-extract', 01:51:50 INFO - 'populate-webroot', 01:51:50 INFO - 'create-virtualenv', 01:51:50 INFO - 'install', 01:51:50 INFO - 'run-tests'), 01:51:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:51:50 INFO - 'download_minidump_stackwalk': True, 01:51:50 INFO - 'download_symbols': 'ondemand', 01:51:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:51:50 INFO - 'tooltool.py': '/tools/tooltool.py', 01:51:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:51:50 INFO - '/tools/misc-python/virtualenv.py')}, 01:51:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:51:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:51:50 INFO - 'installer_path': 'installer.exe', 01:51:50 INFO - 'log_level': 'info', 01:51:50 INFO - 'log_name': 'talos', 01:51:50 INFO - 'log_to_console': True, 01:51:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:51:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:51:50 INFO - 'opt_config_files': (), 01:51:50 INFO - 'pip_index': False, 01:51:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:51:50 INFO - 'cmd': ('bash', 01:51:50 INFO - '-c', 01:51:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:51:50 INFO - 'enabled': True, 01:51:50 INFO - 'halt_on_failure': False, 01:51:50 INFO - 'name': 'check_screen_resolution'},), 01:51:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:51:50 INFO - 'cmd': ('bash', 01:51:50 INFO - '-c', 01:51:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:51:50 INFO - 'enabled': True, 01:51:50 INFO - 'halt_on_failure': False, 01:51:50 INFO - 'name': 'check_screen_resolution'},), 01:51:50 INFO - 'run_cmd_checks_enabled': True, 01:51:50 INFO - 'sps_profile': False, 01:51:50 INFO - 'sps_profile_interval': 0, 01:51:50 INFO - 'suite': 'dromaeojs', 01:51:50 INFO - 'system_bits': '32', 01:51:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:51:50 INFO - 'title': 't-yosemite-r7-0106', 01:51:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:51:50 INFO - 'use_talos_json': True, 01:51:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:51:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:51:50 INFO - 'work_dir': 'build'} 01:51:50 INFO - [mozharness: 2016-10-21 08:51:50.835839Z] Running clobber step. 01:51:50 INFO - Running pre-action listener: _resource_record_pre_action 01:51:50 INFO - Running main action method: clobber 01:51:50 INFO - rmtree: /builds/slave/test/build 01:51:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:51:53 INFO - Running post-action listener: _resource_record_post_action 01:51:53 INFO - [mozharness: 2016-10-21 08:51:53.273446Z] Finished clobber step (success) 01:51:53 INFO - [mozharness: 2016-10-21 08:51:53.273613Z] Running read-buildbot-config step. 01:51:53 INFO - Running pre-action listener: _resource_record_pre_action 01:51:53 INFO - Running main action method: read_buildbot_config 01:51:53 INFO - Using buildbot properties: 01:51:53 INFO - { 01:51:53 INFO - "project": "", 01:51:53 INFO - "product": "firefox", 01:51:53 INFO - "script_repo_revision": "production", 01:51:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:51:53 INFO - "repository": "", 01:51:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:51:53 INFO - "buildid": "20161020233149", 01:51:53 INFO - "pgo_build": "False", 01:51:53 INFO - "basedir": "/builds/slave/test", 01:51:53 INFO - "buildnumber": 23, 01:51:53 INFO - "slavename": "t-yosemite-r7-0106", 01:51:53 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 01:51:53 INFO - "platform": "yosemite_r7", 01:51:53 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:51:53 INFO - "branch": "fx-team", 01:51:53 INFO - "repo_path": "integration/fx-team", 01:51:53 INFO - "revision": "75c306c21c0f719b590d4ebd63e1ca7ad8981adc", 01:51:53 INFO - "stage_platform": "macosx64", 01:51:53 INFO - "builduid": "a077cb3d8264443e8ac43f230c1944fb", 01:51:53 INFO - "slavebuilddir": "test" 01:51:53 INFO - } 01:51:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 01:51:53 INFO - Running post-action listener: _resource_record_post_action 01:51:53 INFO - [mozharness: 2016-10-21 08:51:53.276693Z] Finished read-buildbot-config step (success) 01:51:53 INFO - [mozharness: 2016-10-21 08:51:53.276800Z] Running download-and-extract step. 01:51:53 INFO - Running pre-action listener: _resource_record_pre_action 01:51:53 INFO - Running main action method: download_and_extract 01:51:53 INFO - mkdir: /builds/slave/test/build/tests 01:51:53 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')]} 01:51:53 INFO - trying https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 01:51:53 INFO - Downloading https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 01:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 01:51:54 INFO - Downloaded 1199 bytes. 01:51:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 01:51:54 INFO - Using the following test package requirements: 01:51:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 01:51:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 01:51:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 01:51:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'jsshell-mac.zip'], 01:51:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 01:51:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 01:51:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 01:51:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 01:51:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 01:51:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:51:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 01:51:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 01:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 01:51:55 INFO - Http code: 200 01:51:55 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 01:51:55 INFO - x-amz-cf-id: YXQJujz5CwjYrdc7AxUez4Ixp0y9LQ4i_qQVz76UmAfBwLe2g42fEg== 01:51:55 INFO - x-amz-version-id: oI31bYNgBQVuYdH2Iu_ZLSfqLNA75GrW 01:51:55 INFO - Expected file size: 16507002 01:51:55 INFO - Obtained file size: 16507002 01:52:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:52:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 01:52:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:52:02 INFO - Fetch https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 01:52:02 INFO - Http code: 200 01:52:02 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 01:52:02 INFO - x-amz-cf-id: r2ykTLPiJeSJhOxsol76WZMB5cQtyw0qnTLxhGRrVXmFGTJ70HAueg== 01:52:02 INFO - x-amz-version-id: oI31bYNgBQVuYdH2Iu_ZLSfqLNA75GrW 01:52:03 INFO - Expected file size: 16507002 01:52:03 INFO - Obtained file size: 16507002 01:52:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 01:52:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:52:09 INFO - Fetch https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 01:52:10 INFO - Http code: 200 01:52:10 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 01:52:10 INFO - x-amz-cf-id: fopc9TUsMeGiz4RlzfOFWhjaQDxVGqqsqunfMP1ZXF6B4ST_541JBw== 01:52:10 INFO - x-amz-version-id: E4Ne_YDcgTBJjqnSUPbGevFB_ndcFM.W 01:52:10 INFO - Expected file size: 14409028 01:52:10 INFO - Obtained file size: 14409028 01:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:11 INFO - trying https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 01:52:11 INFO - Downloading https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 01:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 01:52:14 INFO - Downloaded 111628297 bytes. 01:52:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 01:52:14 INFO - mkdir: /builds/slave/test/properties 01:52:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:52:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:52:14 INFO - Contents: 01:52:14 INFO - build_url:https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 01:52:14 INFO - Running post-action listener: _resource_record_post_action 01:52:14 INFO - Running post-action listener: set_extra_try_arguments 01:52:14 INFO - [mozharness: 2016-10-21 08:52:14.704564Z] Finished download-and-extract step (success) 01:52:14 INFO - [mozharness: 2016-10-21 08:52:14.704719Z] Running populate-webroot step. 01:52:14 INFO - Running pre-action listener: _resource_record_pre_action 01:52:14 INFO - Running main action method: populate_webroot 01:52:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:52:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:52:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:52:14 INFO - '--tppagecycles', 01:52:14 INFO - '7'], 01:52:14 INFO - 'tests': ['tsvgm']}}, 01:52:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:52:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:52:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:52:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:52:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['damp', 'tps']}, 01:52:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'tests': ['damp', 'tps']}, 01:52:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['dromaeo_dom']}, 01:52:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:52:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['basic_compositor_video']}, 01:52:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:52:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['a11yr', 01:52:14 INFO - 'ts_paint', 01:52:14 INFO - 'tpaint', 01:52:14 INFO - 'sessionrestore', 01:52:14 INFO - 'sessionrestore_no_auto_restore', 01:52:14 INFO - 'tabpaint']}, 01:52:14 INFO - 'other-e10s': {'tests': ['a11yr', 01:52:14 INFO - 'ts_paint', 01:52:14 INFO - 'tpaint', 01:52:14 INFO - 'sessionrestore', 01:52:14 INFO - 'sessionrestore_no_auto_restore', 01:52:14 INFO - 'tabpaint']}, 01:52:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:52:14 INFO - 'ts_paint', 01:52:14 INFO - 'tpaint', 01:52:14 INFO - 'sessionrestore', 01:52:14 INFO - 'sessionrestore_no_auto_restore', 01:52:14 INFO - 'tabpaint']}, 01:52:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:52:14 INFO - 'ts_paint', 01:52:14 INFO - 'tpaint', 01:52:14 INFO - 'sessionrestore', 01:52:14 INFO - 'sessionrestore_no_auto_restore', 01:52:14 INFO - 'tabpaint']}, 01:52:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['a11yr', 01:52:14 INFO - 'ts_paint', 01:52:14 INFO - 'tpaint', 01:52:14 INFO - 'sessionrestore', 01:52:14 INFO - 'sessionrestore_no_auto_restore', 01:52:14 INFO - 'tabpaint']}, 01:52:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['a11yr', 01:52:14 INFO - 'ts_paint', 01:52:14 INFO - 'tpaint', 01:52:14 INFO - 'sessionrestore', 01:52:14 INFO - 'sessionrestore_no_auto_restore', 01:52:14 INFO - 'tabpaint']}, 01:52:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['tsvgx', 01:52:14 INFO - 'tsvgr_opacity', 01:52:14 INFO - 'tart', 01:52:14 INFO - 'tscrollx', 01:52:14 INFO - 'cart']}, 01:52:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:52:14 INFO - 'tsvgr_opacity', 01:52:14 INFO - 'tart', 01:52:14 INFO - 'tscrollx', 01:52:14 INFO - 'cart']}, 01:52:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'talos_options': ['--disable-e10s'], 01:52:14 INFO - 'tests': ['tp5o']}, 01:52:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'tests': ['tp5o']}, 01:52:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'talos_options': ['--disable-e10s', 01:52:14 INFO - '--xperf_path', 01:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:14 INFO - 'tests': ['tp5n']}, 01:52:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:14 INFO - 'talos_options': ['--xperf_path', 01:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:14 INFO - 'tests': ['tp5n']}}, 01:52:14 INFO - 'talos.zip': {'path': '', 01:52:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:52:14 INFO - Running post-action listener: _resource_record_post_action 01:52:14 INFO - [mozharness: 2016-10-21 08:52:14.723333Z] Finished populate-webroot step (success) 01:52:14 INFO - [mozharness: 2016-10-21 08:52:14.723462Z] Running create-virtualenv step. 01:52:14 INFO - Running pre-action listener: _resource_record_pre_action 01:52:14 INFO - Running main action method: create_virtualenv 01:52:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:52:14 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 01:52:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:52:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:52:14 INFO - Using real prefix '/tools/python27' 01:52:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:52:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:52:18 INFO - Installing pip.................done. 01:52:18 INFO - Return code: 0 01:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:52:18 INFO - Reading from file tmpfile_stdout 01:52:18 INFO - Output received: 01:52:18 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) 01:52:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:52:18 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')]} 01:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:18 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')]} 01:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:18 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:18 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 01:52:18 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 01:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:18 INFO - 'HOME': '/Users/cltbld', 01:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:18 INFO - 'LOGNAME': 'cltbld', 01:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:18 INFO - 'MOZ_NO_REMOTE': '1', 01:52:18 INFO - 'NO_EM_RESTART': '1', 01:52:18 INFO - 'PAGER': '/bin/cat', 01:52:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:18 INFO - 'PWD': '/builds/slave/test', 01:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:18 INFO - 'SHELL': '/bin/bash', 01:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:18 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:18 INFO - 'USER': 'cltbld', 01:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:18 INFO - 'XPC_FLAGS': '0x0', 01:52:18 INFO - 'XPC_SERVICE_NAME': '0', 01:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:18 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 01:52:18 INFO - Cleaning up... 01:52:18 INFO - Return code: 0 01:52:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:52:18 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')]} 01:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:18 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')]} 01:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:19 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:19 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 01:52:19 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 01:52:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:19 INFO - 'HOME': '/Users/cltbld', 01:52:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:19 INFO - 'LOGNAME': 'cltbld', 01:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:19 INFO - 'MOZ_NO_REMOTE': '1', 01:52:19 INFO - 'NO_EM_RESTART': '1', 01:52:19 INFO - 'PAGER': '/bin/cat', 01:52:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:19 INFO - 'PWD': '/builds/slave/test', 01:52:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:19 INFO - 'SHELL': '/bin/bash', 01:52:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:19 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:19 INFO - 'USER': 'cltbld', 01:52:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:19 INFO - 'XPC_FLAGS': '0x0', 01:52:19 INFO - 'XPC_SERVICE_NAME': '0', 01:52:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:19 INFO - Downloading/unpacking psutil>=3.1.1 01:52:19 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 01:52:19 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 01:52:19 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 01:52:19 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 01:52:19 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 01:52:19 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 01:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:52:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:22 INFO - Installing collected packages: psutil 01:52:22 INFO - Running setup.py install for psutil 01:52:22 INFO - building 'psutil._psutil_osx' extension 01:52:22 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 01:52:23 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 01:52:23 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 01:52:23 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 01:52:23 INFO - building 'psutil._psutil_posix' extension 01:52:23 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 01:52:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:52:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:52:23 INFO - ^ 01:52:23 INFO - 1 warning generated. 01:52:23 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 01:52:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:23 INFO - Successfully installed psutil 01:52:23 INFO - Cleaning up... 01:52:23 INFO - Return code: 0 01:52:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:52:23 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')]} 01:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:23 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')]} 01:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:23 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:23 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 01:52:23 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 01:52:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:23 INFO - 'HOME': '/Users/cltbld', 01:52:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:23 INFO - 'LOGNAME': 'cltbld', 01:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:23 INFO - 'MOZ_NO_REMOTE': '1', 01:52:23 INFO - 'NO_EM_RESTART': '1', 01:52:23 INFO - 'PAGER': '/bin/cat', 01:52:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:23 INFO - 'PWD': '/builds/slave/test', 01:52:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:23 INFO - 'SHELL': '/bin/bash', 01:52:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:23 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:23 INFO - 'USER': 'cltbld', 01:52:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:23 INFO - 'XPC_FLAGS': '0x0', 01:52:23 INFO - 'XPC_SERVICE_NAME': '0', 01:52:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:52:26 INFO - Installing collected packages: mozsystemmonitor 01:52:26 INFO - Running setup.py install for mozsystemmonitor 01:52:26 INFO - Successfully installed mozsystemmonitor 01:52:26 INFO - Cleaning up... 01:52:26 INFO - Return code: 0 01:52:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:26 INFO - 'HOME': '/Users/cltbld', 01:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:26 INFO - 'LOGNAME': 'cltbld', 01:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:26 INFO - 'MOZ_NO_REMOTE': '1', 01:52:26 INFO - 'NO_EM_RESTART': '1', 01:52:26 INFO - 'PAGER': '/bin/cat', 01:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:26 INFO - 'PWD': '/builds/slave/test', 01:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:26 INFO - 'SHELL': '/bin/bash', 01:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:26 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:26 INFO - 'USER': 'cltbld', 01:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:26 INFO - 'XPC_FLAGS': '0x0', 01:52:26 INFO - 'XPC_SERVICE_NAME': '0', 01:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:27 INFO - Downloading/unpacking jsonschema==2.5.1 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:30 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:30 INFO - warning: no files found matching '*.txt' 01:52:30 INFO - no previously-included directories found matching 'build' 01:52:30 INFO - no previously-included directories found matching 'dist' 01:52:30 INFO - no previously-included directories found matching '.git*' 01:52:30 INFO - Installing collected packages: jsonschema, functools32 01:52:30 INFO - Running setup.py install for functools32 01:52:30 INFO - warning: no files found matching '*.txt' 01:52:30 INFO - no previously-included directories found matching 'build' 01:52:30 INFO - no previously-included directories found matching 'dist' 01:52:30 INFO - no previously-included directories found matching '.git*' 01:52:30 INFO - Successfully installed jsonschema functools32 01:52:30 INFO - Cleaning up... 01:52:30 INFO - Return code: 0 01:52:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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', '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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:52: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 functools32==3.2.3-2 01:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:30 INFO - 'HOME': '/Users/cltbld', 01:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:30 INFO - 'LOGNAME': 'cltbld', 01:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:30 INFO - 'MOZ_NO_REMOTE': '1', 01:52:30 INFO - 'NO_EM_RESTART': '1', 01:52:30 INFO - 'PAGER': '/bin/cat', 01:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:30 INFO - 'PWD': '/builds/slave/test', 01:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:30 INFO - 'SHELL': '/bin/bash', 01:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:30 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:30 INFO - 'USER': 'cltbld', 01:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:30 INFO - 'XPC_FLAGS': '0x0', 01:52:30 INFO - 'XPC_SERVICE_NAME': '0', 01:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:52:30 INFO - Cleaning up... 01:52:30 INFO - Return code: 0 01:52:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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', '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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:52: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 blobuploader==1.2.4 01:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:30 INFO - 'HOME': '/Users/cltbld', 01:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:30 INFO - 'LOGNAME': 'cltbld', 01:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:30 INFO - 'MOZ_NO_REMOTE': '1', 01:52:30 INFO - 'NO_EM_RESTART': '1', 01:52:30 INFO - 'PAGER': '/bin/cat', 01:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:30 INFO - 'PWD': '/builds/slave/test', 01:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:30 INFO - 'SHELL': '/bin/bash', 01:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:30 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:30 INFO - 'USER': 'cltbld', 01:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:30 INFO - 'XPC_FLAGS': '0x0', 01:52:30 INFO - 'XPC_SERVICE_NAME': '0', 01:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:52:30 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 01:52:30 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 01:52:30 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 01:52:30 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 01:52:30 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 01:52:30 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 01:52:33 INFO - Downloading blobuploader-1.2.4.tar.gz 01:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:52:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:52:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:34 INFO - Downloading docopt-0.6.1.tar.gz 01:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:52:34 INFO - Installing collected packages: blobuploader, requests, docopt 01:52:34 INFO - Running setup.py install for blobuploader 01:52:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:52:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:52:34 INFO - Running setup.py install for requests 01:52:35 INFO - Running setup.py install for docopt 01:52:35 INFO - Successfully installed blobuploader requests docopt 01:52:35 INFO - Cleaning up... 01:52:35 INFO - Return code: 0 01:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:35 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:35 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 01:52:35 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 01:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:35 INFO - 'HOME': '/Users/cltbld', 01:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:35 INFO - 'LOGNAME': 'cltbld', 01:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:35 INFO - 'MOZ_NO_REMOTE': '1', 01:52:35 INFO - 'NO_EM_RESTART': '1', 01:52:35 INFO - 'PAGER': '/bin/cat', 01:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:35 INFO - 'PWD': '/builds/slave/test', 01:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:35 INFO - 'SHELL': '/bin/bash', 01:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:35 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:35 INFO - 'USER': 'cltbld', 01:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:35 INFO - 'XPC_FLAGS': '0x0', 01:52:35 INFO - 'XPC_SERVICE_NAME': '0', 01:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-A2a0Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-p91K46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-IICO8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-qrhZem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xg8SgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9oo8QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-C2aSte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ts_YJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2D45L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-qoYMsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-EQDdSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-yQUlyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-WfzgJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kgGQgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-vCHC3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Lu6TfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:37 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-IIkZk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:52:37 INFO - Running setup.py install for manifestparser 01:52:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:52:37 INFO - Running setup.py install for mozcrash 01:52:37 INFO - Running setup.py install for mozdebug 01:52:38 INFO - Running setup.py install for mozdevice 01:52:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Running setup.py install for mozfile 01:52:38 INFO - Running setup.py install for mozhttpd 01:52:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Running setup.py install for mozinfo 01:52:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Running setup.py install for mozInstall 01:52:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:52:38 INFO - Running setup.py install for mozleak 01:52:38 INFO - Running setup.py install for mozlog 01:52:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:52:39 INFO - Running setup.py install for moznetwork 01:52:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:52:39 INFO - Running setup.py install for mozprocess 01:52:39 INFO - Running setup.py install for mozprofile 01:52:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:52:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:52:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:52:39 INFO - Running setup.py install for mozrunner 01:52:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:52:39 INFO - Running setup.py install for mozscreenshot 01:52:39 INFO - Running setup.py install for moztest 01:52:40 INFO - Running setup.py install for mozversion 01:52:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:52:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:40 INFO - Cleaning up... 01:52:40 INFO - Return code: 0 01:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:40 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:40 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 01:52:40 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 01:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:40 INFO - 'HOME': '/Users/cltbld', 01:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:40 INFO - 'LOGNAME': 'cltbld', 01:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:40 INFO - 'MOZ_NO_REMOTE': '1', 01:52:40 INFO - 'NO_EM_RESTART': '1', 01:52:40 INFO - 'PAGER': '/bin/cat', 01:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:40 INFO - 'PWD': '/builds/slave/test', 01:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:40 INFO - 'SHELL': '/bin/bash', 01:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:40 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:40 INFO - 'USER': 'cltbld', 01:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:40 INFO - 'XPC_FLAGS': '0x0', 01:52:40 INFO - 'XPC_SERVICE_NAME': '0', 01:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-aDV4dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-FPqVtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MdgGKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kyTDrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-XOV8jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-fzEeJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-UsMq2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-C2bLEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Zjzjtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:41 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)) 01:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-uaHeEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:42 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)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-FkoNwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:42 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)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bO3qaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:42 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)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-i83Nbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:42 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)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-vRXZ4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-CxTh3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:42 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)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5xl5vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-SHqdIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:42 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)) 01:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:52:42 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)) 01:52:42 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)) 01:52:42 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)) 01:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:52:42 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 01:52:42 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 01:52:42 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 01:52:42 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 01:52:42 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 01:52:42 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 01:52:45 INFO - Downloading blessings-1.6.tar.gz 01:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:45 INFO - Installing collected packages: blessings 01:52:45 INFO - Running setup.py install for blessings 01:52:45 INFO - Successfully installed blessings 01:52:45 INFO - Cleaning up... 01:52:45 INFO - Return code: 0 01:52:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:52:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:46 INFO - Reading from file tmpfile_stdout 01:52:46 INFO - Current package versions: 01:52:46 INFO - blessings == 1.6 01:52:46 INFO - blobuploader == 1.2.4 01:52:46 INFO - docopt == 0.6.1 01:52:46 INFO - functools32 == 3.2.3-2 01:52:46 INFO - jsonschema == 2.5.1 01:52:46 INFO - manifestparser == 1.1 01:52:46 INFO - mozInstall == 1.12 01:52:46 INFO - mozcrash == 0.17 01:52:46 INFO - mozdebug == 0.1 01:52:46 INFO - mozdevice == 0.48 01:52:46 INFO - mozfile == 1.2 01:52:46 INFO - mozhttpd == 0.7 01:52:46 INFO - mozinfo == 0.9 01:52:46 INFO - mozleak == 0.1 01:52:46 INFO - mozlog == 3.4 01:52:46 INFO - moznetwork == 0.27 01:52:46 INFO - mozprocess == 0.23 01:52:46 INFO - mozprofile == 0.28 01:52:46 INFO - mozrunner == 6.12 01:52:46 INFO - mozscreenshot == 0.1 01:52:46 INFO - mozsystemmonitor == 0.3 01:52:46 INFO - moztest == 0.7 01:52:46 INFO - mozversion == 1.4 01:52:46 INFO - psutil == 3.1.1 01:52:46 INFO - requests == 1.2.3 01:52:46 INFO - wsgiref == 0.1.2 01:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:46 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')]} 01:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:46 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')]} 01:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:46 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:46 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 01:52:46 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 01:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:46 INFO - 'HOME': '/Users/cltbld', 01:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:46 INFO - 'LOGNAME': 'cltbld', 01:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:46 INFO - 'MOZ_NO_REMOTE': '1', 01:52:46 INFO - 'NO_EM_RESTART': '1', 01:52:46 INFO - 'PAGER': '/bin/cat', 01:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:46 INFO - 'PWD': '/builds/slave/test', 01:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:46 INFO - 'SHELL': '/bin/bash', 01:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:46 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:46 INFO - 'USER': 'cltbld', 01:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:46 INFO - 'XPC_FLAGS': '0x0', 01:52:46 INFO - 'XPC_SERVICE_NAME': '0', 01:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 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)) 01:52:46 INFO - Cleaning up... 01:52:46 INFO - Return code: 0 01:52:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52:46 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')]} 01:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:46 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')]} 01:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:46 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 0x10753f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba3db58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, '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.TQPnZkEuzF/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.dbLBccf8JV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 01:52:46 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 01:52:46 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 01:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:46 INFO - 'HOME': '/Users/cltbld', 01:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:46 INFO - 'LOGNAME': 'cltbld', 01:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:46 INFO - 'MOZ_NO_REMOTE': '1', 01:52:46 INFO - 'NO_EM_RESTART': '1', 01:52:46 INFO - 'PAGER': '/bin/cat', 01:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:46 INFO - 'PWD': '/builds/slave/test', 01:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:46 INFO - 'SHELL': '/bin/bash', 01:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:52:46 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:46 INFO - 'USER': 'cltbld', 01:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:46 INFO - 'XPC_FLAGS': '0x0', 01:52:46 INFO - 'XPC_SERVICE_NAME': '0', 01:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:52:46 INFO - Cleaning up... 01:52:46 INFO - Return code: 0 01:52:46 INFO - Running post-action listener: _resource_record_post_action 01:52:46 INFO - Running post-action listener: _start_resource_monitoring 01:52:46 INFO - Starting resource monitoring. 01:52:46 INFO - [mozharness: 2016-10-21 08:52:46.564255Z] Finished create-virtualenv step (success) 01:52:46 INFO - [mozharness: 2016-10-21 08:52:46.565233Z] Running install step. 01:52:46 INFO - Running pre-action listener: _resource_record_pre_action 01:52:46 INFO - Running main action method: install 01:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:46 INFO - Reading from file tmpfile_stdout 01:52:46 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:46 INFO - Reading from file tmpfile_stdout 01:52:46 INFO - Output received: 01:52:46 INFO - Usage: mozinstall [options] installer 01:52:46 INFO - Options: 01:52:46 INFO - -h, --help show this help message and exit 01:52:46 INFO - -d DEST, --destination=DEST 01:52:46 INFO - Directory to install application into. [default: 01:52:46 INFO - "/builds/slave/test"] 01:52:46 INFO - --app=APP Application being installed. [default: firefox] 01:52:46 INFO - mkdir: /builds/slave/test/build/application 01:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:53:21 INFO - Reading from file tmpfile_stdout 01:53:21 INFO - Output received: 01:53:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:53:21 INFO - Running post-action listener: _resource_record_post_action 01:53:21 INFO - [mozharness: 2016-10-21 08:53:21.244890Z] Finished install step (success) 01:53:21 INFO - [mozharness: 2016-10-21 08:53:21.245043Z] Running run-tests step. 01:53:21 INFO - Running pre-action listener: _resource_record_pre_action 01:53:21 INFO - Running main action method: run_tests 01:53:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:53:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:53:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:53:21 INFO - 2016-10-21 01:53:21.259 screenresolution[1646:7807] starting screenresolution argv=screenresolution get 01:53:21 INFO - 2016-10-21 01:53:21.262 screenresolution[1646:7807] Display 0: 1600x1200x32@60 01:53:21 INFO - 2016-10-21 01:53:21.268 screenresolution[1647:7809] starting screenresolution argv=screenresolution list 01:53:21 INFO - Available Modes on Display 0 01:53:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:53:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:53:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:53:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:53:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:53:21 INFO - Intel Iris: 01:53:21 INFO - Chipset Model: Intel Iris 01:53:21 INFO - Type: GPU 01:53:21 INFO - Bus: Built-In 01:53:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:53:21 INFO - Vendor: Intel (0x8086) 01:53:21 INFO - Device ID: 0x0a2e 01:53:21 INFO - Revision ID: 0x0009 01:53:21 INFO - Displays: 01:53:21 INFO - Display: 01:53:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:53:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:53:21 INFO - Display Serial Number: 1600x1200 60 01:53:21 INFO - Main Display: Yes 01:53:21 INFO - Mirror: Off 01:53:21 INFO - Online: Yes 01:53:21 INFO - Rotation: Supported 01:53:21 INFO - Return code: 0 01:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:53:21 INFO - Python 2.7.3 01:53:21 INFO - Return code: 0 01:53:21 INFO - grabbing minidump binary from tooltool 01:53: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')]} 01:53:21 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 0x107353d30>, '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 0x107179db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10734bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:53:21 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 01:53:21 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 01:53:21 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 01:53:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:53:21 INFO - Return code: 0 01:53:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:53:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:53:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:53:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:53:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 01:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 01:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQPnZkEuzF/Render', 01:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:53:21 INFO - 'HOME': '/Users/cltbld', 01:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:53:21 INFO - 'LOGNAME': 'cltbld', 01:53:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:53:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:21 INFO - 'MOZ_NO_REMOTE': '1', 01:53:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:53:21 INFO - 'NO_EM_RESTART': '1', 01:53:21 INFO - 'PAGER': '/bin/cat', 01:53:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:21 INFO - 'PWD': '/builds/slave/test', 01:53:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:53:21 INFO - 'SHELL': '/bin/bash', 01:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbLBccf8JV/Listeners', 01:53:21 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 01:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:53:21 INFO - 'USER': 'cltbld', 01:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:21 INFO - 'XPC_FLAGS': '0x0', 01:53:21 INFO - 'XPC_SERVICE_NAME': '0', 01:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:53:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 01:53:21 INFO - mozversion application_buildid: 20161020233149 01:53:21 INFO - mozversion application_changeset: 75c306c21c0f719b590d4ebd63e1ca7ad8981adc 01:53:21 INFO - mozversion application_display_name: Nightly 01:53:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:53:21 INFO - mozversion application_name: Firefox 01:53:21 INFO - mozversion application_remotingname: firefox 01:53:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:53:21 INFO - mozversion application_vendor: Mozilla 01:53:21 INFO - mozversion application_version: 52.0a1 01:53:21 INFO - mozversion platform_buildid: 20161020233149 01:53:21 INFO - mozversion platform_changeset: 75c306c21c0f719b590d4ebd63e1ca7ad8981adc 01:53:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:53:21 INFO - mozversion platform_version: 52.0a1 01:53:21 INFO - using testdate: 1477040001 01:53:21 INFO - actual date: 1477040001 01:53:21 INFO - starting webserver on 'localhost:49272' 01:53:21 INFO - SUITE-START | Running 2 tests 01:53:21 INFO - TEST-START | dromaeo_css 01:53:21 INFO - operating with platform_type : mac_ 01:53:21 INFO - Initialising browser for dromaeo_css test... 01:53:21 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpHFDFwL/profile http://localhost:49272/getInfo.html) 01:53:24 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 01:53:24 INFO - PROCESS | 1657 | colorDepth:24 01:53:24 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 01:53:24 INFO - PROCESS | 1657 | __metrics 01:53:24 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:53:24 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:53:25 INFO - TEST-INFO | 1657: exit 0 01:53:25 INFO - Browser initialized. 01:53:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:53:25 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpHFDFwL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:37 INFO - PROCESS | 1660 | RSS: Main: 253304832 01:53:37 INFO - PROCESS | 1660 | 01:54:28 INFO - PROCESS | 1660 | 1477040068914 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:56:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 01:56:43 INFO - PROCESS | 1660 | RSS: Main: 443568128 01:56:43 INFO - PROCESS | 1660 | 01:59:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 01:59:47 INFO - PROCESS | 1660 | RSS: Main: 394698752 01:59:47 INFO - PROCESS | 1660 | 02:02:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:02:50 INFO - PROCESS | 1660 | RSS: Main: 371818496 02:02:50 INFO - PROCESS | 1660 | 02:05:52 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:05:53 INFO - PROCESS | 1660 | RSS: Main: 357314560 02:05:53 INFO - PROCESS | 1660 | 02:08:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:08:57 INFO - PROCESS | 1660 | RSS: Main: 343003136 02:08:57 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:12:00 INFO - PROCESS | 1660 | RSS: Main: 452091904 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | __start_tp_report 02:12:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 02:12:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 02:12:00 INFO - PROCESS | 1660 | |i|pagename|runs| 02:12:00 INFO - PROCESS | 1660 | |0;dojo.html;3297.6702329767027;3305.5537502437164;3312.2381852173985;3345.448001079822;3358.9328213435733;5387.326584176978;5531.225628412026;5536.806211782588;5576.804811831586;5580.665160090397;5422.1595652673805;5508.724563771805;5533.142362933741;5542.057850165472;5549.334079910406;5077.999999999991;5091.083604951107;5093.18509038552;5125.103106956268;5167.9224811627855;5131.3842338919385;5182.844514664547;5187.3775146982225;5191.558717509016;5195.402528709209;5134.845954621349;5179.792808287664;5184.5074717901925;5185.377754669426;5216.035033518792;5186.870328241786;5208.791648334062;5218.347706536683;5248.370195576517;5310.150375939869;5035.269885866529;5037.49625037497;5109.948900511022;5126;5155.896882062338;5520.972395138038;5543.445655434464;5569.721513924328;5585.720713964326;5653.57598180134;6103.35914728956;6118.296395914438;6120.234970628671;6132.08018797184;6138.508919286446;6006.339302676702;6110.175126357929;6126.663033533198;6144.600600960924;6157.7536898524;5504.009278329939;5684.744186511617;5687.7156142192725;5743.770249190027;5750.6837123958585;5357.919631205535;6285.685715714196;6286.15136956505;6300.810975670737;6317.084022816666;5856.12158176277;5920.141579471038;6035.758569657164;6039.909401358983;6041.124037014696;6122.855605809957;6144.662043587646;6149.61633632438;6163.1679723237685;6223.284322302902;6104.481119104837;6106.511479081662;6115.266168059861;6121.117656725486;6134.503712358327;5818.389069147764;6133.865234931552;6142.034548944295;6147.831911936718;6149.446549810538;4729.196036673774;4824.204006338985;4841.080194762983;4852.102361063215;4891.853244402673;4332.0469496710675;4346.695731298779;4354.825806967686;4391.055922976511;4395.252807022814;5576.9163462548095;5643.604947653707;5665.5184309333345;5669;5670.036093864053;4796.56830885222;5991.340952495222;6019.097135429721;6099.603525770811;6200.007998720183;5583.69289689071;5670.262865827499;5677.37548869624;5696.772129114789;5722.77108915647;5318.574514038945;5327.907778905315;5334.5732341412595;5338.839834804962;5339.706316152571;6212;6275.811725648238;6276.560640755286;6286.497080233479;6295.307516173309;6030.5778595497895;6102.307478454246;6122.602030867979;6134.263888333428;6141.547378150984;6267.2479302484;6268.686565671607;6277.591956522811;6290.874182516415;6304.65324407162;5999.820005399845;6012.218411606463;6056.212692349966;6062.909056364247;6065.696715164312;6018.849528761816;6083;6094.146819445193;6109.236345456818;6148.692565371803;5972.790952316648;5973.880522389441;5983.102534619842;6005.609635373687;6016.2479690038745;5945.881082378415;5972.343042265435;5977.701114944322;5979.402059793986;5981.461668449861;4756.476787553435;5488.231647569423;5749.8275051748515;5776.364599893925;5831.4168583141345;5871.03127983895;5922.289325280994;5925.822225333247;5933.525317974638;5934.6735929522565;5760.683162426107;5779.508741756998;5787.652740835563;5788;5788.942110579009 02:12:00 INFO - PROCESS | 1660 | |1;ext.html;474.7009384088024;502.43225155574197;522.464473914238;523.9371275446946;524.4598063994085;30216.546751798713;30688.539671904913;40442;41049.17901641973;41153;42068.57931420692;42587.14825703484;42613.36079958795;42617.93455163622;42629;8554.401191916568;9423.293253006035;9596.472194029326;9610;9613.66352177674;8516.701915432961;11432.314061156358;11634.418279086054;11702.882971170307;11858.229215101033;11550;11593.130515211351;11611.303321800719;11620.302781833076;11785.351805650685;11478.368689722061;11541.826872596876;11562;11564.53741850325;11573.884261157365;11379.601713939972;11444.828327575093;11459.31244125355;11466.541338346457;11474.311541307548;39816;40480.39279410811;40631.593684063075;40640.39039414411;40749.59250407488;3332.7167190788814;3370.1911541230174;3422.401079811023;3540.91147721309;3675.724320675933;30560.8471957641;30592.54111188334;31013.22466938322;31265.531017034536;31694;3172.825494597796;3214.8714051437914;3229.531717900915;3331.4003479373705;3363.8486268117995;440064;441822.7908860435;442882;444560.9895109423;457457;32762.83618581892;61188.38811611827;61540;61576;61586;33419.83290083534;34453.48319775205;34961.65038349635;35105.29789404198;35113.648863511546;14054.297285135703;14180.290985450687;14203.78694319586;14210;14229.28853557318;10771.946140269249;11052.668419947415;12015.219010764447;12137;12162.452689628988;7404.222556631584;7619.314261716361;7792.493487923267;7817.80455488606;7854.6858125674335;3191.9042428727175;3209.759268054905;3217.6621454746914;3226.5321528378254;3244.8539815707877;929.2287401456774;968.1238479176357;980.7302991677345;993.3245393132739;1041.656253436364;30354;30386.392272154877;30929.536056959165;31068.689313107032;31272;989.7525618595351;1027.1474676018886;1031.8245898197324;1050.3592808386877;1109.916756243285;14779.334929927963;15225.619359515878;15624.531264062096;16007.985028072364;16214.51356459308;578863;580023;581786;581950;585572;59059.40940590625;59651;59863.70068149632;59870.401295986485;59975;1214.2228973456995;1267.3916520070418;1271.0784681106493;1368.8699573540696;1394.2958805803207;29613.703862961094;31284.843575781975;31908.8404557985;32164;32646.83676581602;54115.18827217674;54527;54793;54897.45102548923;54920.90158196894;555102;559550;559741;561426;561752;25775.613365799152;26109.216723498324;26476.205713828615;26788.330291742863;27127.59308610412;39814;46963.530364695915;47114;47926.760366197945;48098;39609.81170564888;39772.40341394823;39997.60002399939;40903.59096409117;40944.59055409408;39086.02284942899;39592.812215633574;39611.80194099011;40562.391564125974;40838.59161408467;37948.81025594854;38313.61686383212;38485.230295394496;38894.02764930899;39224.803875981575;33653.99038028863;34245;35039.64960350364;35216.29567408689;35406.29187416289;18284.451466456027;24204;25851.405463267325;26003.34991625149;26076.608850866873 02:12:00 INFO - PROCESS | 1660 | |2;jquery.html;344.4437233867305;368.09815950920245;369.123332086295;375.0698268294629;395.7170623004551;14781.334839932202;14961.401543938244;15926.362945482197;20448.591028179464;20799;19229.711554326663;19750.30873919413;20184.394468165978;20312.390628281137;20715.274965376215;4980.6015518758595;5694.487496125358;5919.615225010382;5964.671943043131;5972.343042265347;5470.64440811348;5805.535557155438;5844.941550584504;5896.439838215363;5923.496502797246;3809.619038096182;4030.1939612077554;5661.886762264752;5887.4112588741;5929.495992840613;5730;6023.969880150593;6028.849278768044;6041.24484439445;6047.455728984412;5618.690971996539;5668.348139963916;5676.091825307931;5677.57418193633;5692.459216374438;12841.807372889414;13057.34713264333;19161.520961975923;24936.87531562349;25244;2148.666956621726;2465.6671349367966;2549.005887703797;2646.4442467081935;2940.7059294070423;9492.240620750323;10034.147097496721;10351.171906247557;10374.740631484197;15249.645078082804;1715.8970461772333;1857.1085878778126;1901.2965202874886;1905.514093906045;1906.7044608085769;107636.46181769119;111627;113768.4311578445;114343;115125;10979.011888930034;11007.889921100686;11304.604338848265;11365.545378184945;11568.76862462746;14295.07082039664;14296;14324.997250192595;14334;14384.35270412834;8255.669773209005;8394.8321033579;8409.56122724403;8440.74677759656;8549.786255343543;6831.87274099768;7304.5252058616015;8315.79420983966;8508.914910850812;8545.615447304886;3712.8119001919126;4237.343211802176;4570.428696412949;4600.861974140714;4616.330632058332;1605.8635016023768;1837.364745376616;1900.4583693647244;1904.7428597139485;1910.0545230110906;854.3421565394611;856.8629019356997;913.3150137396952;925.9074092590687;961.077365728894;20074;21430;21800.80095594726;22352.888235559043;22823.429414264778;879.8108406692592;898.8247291778172;934.8878134623752;952.1050212799946;962.1773383756927;8755.255803256794;10015.499225038719;11648.41757912118;11701.941490292495;11764.411779410995;550606;552112;565373;573006;578398;126241;131686;131925.68074319133;132644;136151.31924340315;964.4936408385654;1016.1159790981745;1054.9578016879393;1058.8464672622426;1059.814532456817;14557.41770329175;15150.621234469227;18010.459686209433;19066.428007159808;19449;55745.88508229732;55927.44072559222;56558.717206413705;56902.43097568971;57126;77601;80803;82069.58965205136;83893.58053209695;84432;7708.614569271402;7877.251661092187;8076.757697269091;8145.226203510657;8496.490210587384;11161.274517156358;12680.74638507243;12877.35613219354;13206.405711743188;13254.469821207043;11178.552857885594;11247.212695111592;11489.655310340702;11521.193516453768;11558.364289963796;10992.340459572451;10994.28537145083;11158.330500170016;11517.942410287895;11526.077913767047;11133.83299250528;11345.489452974802;11383.943080284545;11419.31484110956;11770.76458470843;7890.881636775338;7980.042394912648;8175.7138500152205;8399.160083991552;8415.579221039046;8303.4602750821;10266.230032747722;11155.72110697239;11186.776264474502;11440.713982150513 02:12:00 INFO - PROCESS | 1660 | |3;mootools.html;1322.1868550841232;1374.2304309586625;1541.9229038548074;1729.5762538178149;1964.7740509841371;7757.5733334666575;8173.100958894517;8463.322934165268;8804.691835785748;8813.691520796774;8571.100034496381;8684.91315086849;8687.261582765472;8695.521746303952;8704.347173961947;2341.1337805012167;2366.3965688749345;2374.7031621047367;2381.404648837791;2385.594448943675;2331.94170145746;2362.444825466014;2370.6207006878903;2377.2630484549845;2382.19005538117;2338.1348900906687;2362.244081893795;2367.3489790307717;2371.1819422299277;2379.940501487468;2308.953820923589;2328.161861729776;2333.614953532665;2345.870977096259;2353.8352315337934;2059.6704527275715;2326.685897403846;2327.674125622414;2335.4161459635093;2336.439254578906;8248.13394593565;8612.354073444516;8694;8695.087015863306;8713.69502067431;5152.098382782998;5373.435789242112;5378.623496355257;5382.219578161144;5406.324209473816;3351.329734053199;3585.0678823505814;3610.0433385152955;3668.229671768932;3683.8158092095287;835.6907944060675;1066.7493139112303;1073.7476692977143;1089.7657003744155;1102.7518808268155;11435.428228588537;11524.250923690017;11603.013743831785;11610.303381797035;11615.709607259801;4397.582229688174;4448.065906159743;4616.538346165424;4630.837920672828;4631.120087183424;9065.728028159167;9066.320025998077;9067.591958361889;9067.81864362709;9090.409123406956;5115.951229997841;5209.43716884933;5226.947730522646;5241;5243.292155558951;4131.628153466202;4392.582704643054;4551.590356867898;4551.658625603027;4903.607711383081;3707.888763337104;3721.14413684854;3797.5632802228097;3799.4490798834568;3804.4483549885667;1150.451749375138;1153.9192256542128;1154.8787377325427;1161.924474909128;1163.3020187887369;843.7510934274404;860.8407444622765;906.775852598986;911.8221946720325;938.554186761283;5703.771849126071;5734;6012.1582978382185;6085.9695701521205;6159.476444502178;782.5891407011251;845.7462761171747;942.9575669094908;949.9762505937268;964.0889359555293;3978.6380508470297;3989.5810939851476;3992.9800350998057;4054.716169868081;4114.917701645951;9967.551460184164;10614.0447359738;10798.78402431947;10818.56725730962;10832.945835270773;10344.844827327595;10568.524416401127;10774.353538787698;10787.6224332148;10818.94590527058;8077.717279895293;8309.379670964225;8330.083690794008;8340.541270230196;8346.791330216793;5437.238786569963;5546.195801608825;5893.145493903275;5931.555133365101;5943.64338139713;9801;10058.597656093967;10107.444090575089;10131.240156988108;10132.986701329808;7354.301341372561;9101.544922753968;9765.462899540309;10002.549885255035;10027.348222365523;6582.901256481253;7466.813329666802;7526.849463010819;7536;7626.275503827128;8099.311558517592;8176.713815016446;8225.95887020561;8291.83416331658;8307.916920830714;7387;7431.479796414199;7484.476086673881;7504.812379690551;7534.8493030138;7230.13238411394;7293;7329.230430804902;7353.963230183815;7408.6666100026705;6890.44876409896;6927.965360173167;7002.934134430254;7050.647467626495;7060.6116663584;4692.014676917749;4719.150552900373;4926.4088309403105;4971.502849715;5021.146405111067;5001.57486613642;5003.699778013331;5094.1849304111165;5125.820596279113;5207.635465517377 02:12:00 INFO - PROCESS | 1660 | |4;prototype.html;244.5451460283872;294.29075927015896;297.72014306551847;304.7805579982412;309.37351862478494;5105.923411148836;5298.013245033113;5298.284731561238;5310.20346947958;5347.278117454148;5082.593392528598;5221.295125158103;5227;5264.289320941672;5272.841814745554;3569.8398020643267;3850.2299540092095;4106.1992911382295;4106.77412742299;4128.442660240874;3909.3158697228014;4073.9185216295655;4122.278601244785;4135.710500264982;4146.1914926589325;3848.2111167210796;3906.824192911326;3969.741966772165;3998.8400463981407;4045.919081618366;3297.0768184908266;3994.4407782910416;4021;4028.5568587455355;4037.5154981402275;3058.3730335281216;3493.8602455901732;3495.196104895863;3511.4732790081694;3529.400001999666;4368.366586844922;4829.5028541152005;5091.9236211456855;5174.6636468629795;5253.50091741284;4571.771411429449;4656.324832899245;4669.486356500782;4679.906401871944;4698.553637404441;4712.64655150865;5426.864328391783;5542.168674698827;5548.361938377057;5554.333479982388;3220.4203243416177;3615.7649752765988;3680.7791532508136;3878.146807702301;3917.843286268546;5122.795088196468;5197.830488140176;5590;5801.764711760438;5806.187133801313;3935.409688546684;3954.347532657137;3957.6635985940943;3966.841326346914;3973.000384709526;3686.829326778968;3817.4655548223272;3878.437626544135;4022.1955608878343;4043.2317859606583;4225.514065882401;4475.283954567319;4545.522720114406;4601.585857272795;4604.470485894098;4828.082664293773;5391.35303763543;5563.109902415594;5586.24585680936;5605.887882242414;1355.7966305054322;1370.6984463418032;1380.675541247806;1391.6173052410668;1403.996142757933;828.362161135922;848.4569875279826;859.5573279760928;893.3255392178863;904.4437670832522;4390.05613793036;5173.896522069537;5174.482551744871;5179.792808287626;5181.637285390062;4833.347498087784;5261.868453288698;5455.645383050169;5647.774089036392;5654.455495027254;4663.953360466419;4912.25614906703;5172.301739265151;5255.921161182585;5276.841694749163;2602;3000.9099727008224;3002;3009.759219262454;3026.334206474572;5601.60788744784;5936.5844390892225;5941.70291485424;6009.789657361971;6072.7570897164505;4692.1554120258;4882.462929077798;5392.573341996039;5930.22907022093;5955.67243801595;5155.793768249228;5907.675077870758;6022.518198544106;6086.543509236825;6129.387061293835;4356.6950313477755;4480.596746292849;5407.486288802557;5714.571407144397;5779.624324418899;4961.03259864323;5670.9432905672065;5707.343655479673;5726.713664316851;5746.310442746897;5491.807786727445;5694.804091140907;5984.730687119003;6001.339852616122;6035.486983606443;3700.9814950925074;3848.288066707668;3881.9223615526967;3914.72596918213;3914.8434062637175;5125.43620201785;5524.392316845064;5818.33089194748;5832.212651292021;5865.266841644794;4877.463598966314;5053.393592768891;5103.693778373309;5376.758045888023;5487.338640759149;5616.66300022;5621.100623900156;5647.124695672177;5667.20659107717;5692.914606280992;4700.670953033392;5464.836054918359;5518.751656175402;5540.418256083053;5564.054110801093;4650.558196971282;5307.150855863198;5610.747516361856;5622.465865742748;5626.2967129108865;4288.270993931102;4533.818647254073;5153.484651534816;5492.286002819608;5512.503874651301 02:12:00 INFO - PROCESS | 1660 | |5;yui.html;599.69415598045;804.7907544038549;805.3557154276577;827.9503229806212;831.2477208126647;15027.173505457196;15859.920700396511;15880.444184453532;15914.124723140238;15925.283362248698;13838.654033649163;14355.856441435582;14435.711285774278;14446.205458699767;14466.855331446683;875.5797217335682;877.455977294077;880.0187790613452;888.5468411110348;889.6797153024938;895.5432729308067;895.771578247546;898.5956319656149;898.6405437824857;899.9145081217274;948.3361646847235;949.0130264524886;950.2587981374539;952.3714348529971;955.3885513271478;790.7746292306665;938.5448057692014;940.1867384712175;943.3443756589173;945.9574319155655;696.3384784454738;697.5744795674634;698.2284575544002;698.5250029979612;698.6960672107599;13859.722805543934;13878.028538002343;13886.513972010931;13886.722265554734;13901.513447029305;9914.55384507699;11925.344106074162;11949.820752688716;12107.878921210764;12295.93852030743;10750.78498430027;10755;10804.351738895692;10960.890391096067;11270.887291127066;3041.650210225808;3627;3683.686886614641;3698.149425632093;3717.851285948586;107890.46054769676;110143.44928275388;111828;115397.42301288524;115435;8922.197002269826;9029.77425564353;9078.500682462529;9122.179003889549;9631.662891798753;19912.50218744543;20111.994400279928;20127.194912203642;20145.697814532792;20147.798522014884;7936.2857342839425;8052.194780521901;8089.39329550286;8182.4681395709085;8352.540610266493;4270.423492828429;4404.2512772828695;4462.196804575207;4489.259272220047;4497.815077699912;3569.0720412692885;3678.301122786662;3701.0192299040777;3701.6668499835146;3705.2404257127223;628.9151710858248;642.9421352078335;655.9508036897251;656.409231691472;659.3768888400512;624.8968920128128;643.3823529411724;654.5549026661915;661.3849120318055;692.7540723043347;6957.547759395623;9312.627494900264;9378.202852757591;9435.952820235992;9512.90487095134;615.6552330694825;655.6099121022984;668.5387082912774;669.648434571844;683.9931600684029;4334.046509767846;4436.467623885154;4575.215586074744;4624.468186158635;4624.907501849944;150197;156884;160769.1961540185;161073;166368;136611;138127.64042696837;139838;140629;141452;103458.96541034644;119504.07438884237;122409.16386254036;122696.38651806684;123178;8503.319734421355;8527.573621319034;8604.569771511524;8708.825823483368;9061.954690226507;50485.747571261905;51509;62766.37233627788;63236;64767.056988290424;94867;96950;99043.05741655524;99362;100968.49515752374;11068.114550836075;11279.887201127884;11288.717782055513;11398.544058237578;11419;12017.278963262232;12077.879221207675;12198.207116537396;12500.499980001063;12579.119461637598;11073.778524429628;11920.880791191978;11921.284722916653;12048.457819397972;12370.81443778326;11547.364894930859;11752.059835213333;11775.646730597753;12303.323317217639;12440.875591244334;11546.76906461883;11741.76516469683;11750.588729394773;11900.642980710592;12257.448414821176;9681.419114853132;9714.174295184988;9893.060159284856;9958;9975.60097596088;9812.65655702047;9972.152367048882;10016;10097.5456104474;10118.241131915283 02:12:00 INFO - PROCESS | 1660 | __end_tp_report 02:12:00 INFO - PROCESS | 1660 | __start_cc_report 02:12:00 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1936 02:12:00 INFO - PROCESS | 1660 | __end_cc_report 02:12:00 INFO - PROCESS | 1660 | __startTimestamp1477041120653__endTimestamp 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | ------- Summary: start ------- 02:12:00 INFO - PROCESS | 1660 | Number of tests: 6 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5627.46 Median:5779.51 stddev:625.28 (10.8%) stddev-sans-first:599.89 02:12:00 INFO - PROCESS | 1660 | Values: 3297.7 3305.6 3312.2 3345.4 3358.9 5387.3 5531.2 5536.8 5576.8 5580.7 5422.2 5508.7 5533.1 5542.1 5549.3 5078.0 5091.1 5093.2 5125.1 5167.9 5131.4 5182.8 5187.4 5191.6 5195.4 5134.8 5179.8 5184.5 5185.4 5216.0 5186.9 5208.8 5218.3 5248.4 5310.2 5035.3 5037.5 5109.9 5126.0 5155.9 5521.0 5543.4 5569.7 5585.7 5653.6 6103.4 6118.3 6120.2 6132.1 6138.5 6006.3 6110.2 6126.7 6144.6 6157.8 5504.0 5684.7 5687.7 5743.8 5750.7 5357.9 6285.7 6286.2 6300.8 6317.1 5856.1 5920.1 6035.8 6039.9 6041.1 6122.9 6144.7 6149.6 6163.2 6223.3 6104.5 6106.5 6115.3 6121.1 6134.5 5818.4 6133.9 6142.0 6147.8 6149.4 4729.2 4824.2 4841.1 4852.1 4891.9 4332.0 4346.7 4354.8 4391.1 4395.3 5576.9 5643.6 5665.5 5669.0 5670.0 4796.6 5991.3 6019.1 6099.6 6200.0 5583.7 5670.3 5677.4 5696.8 5722.8 5318.6 5327.9 5334.6 5338.8 5339.7 6212.0 6275.8 6276.6 6286.5 6295.3 6030.6 6102.3 6122.6 6134.3 6141.5 6267.2 6268.7 6277.6 6290.9 6304.7 5999.8 6012.2 6056.2 6062.9 6065.7 6018.8 6083.0 6094.1 6109.2 6148.7 5972.8 5973.9 5983.1 6005.6 6016.2 5945.9 5972.3 5977.7 5979.4 5981.5 4756.5 5488.2 5749.8 5776.4 5831.4 5871.0 5922.3 5925.8 5933.5 5934.7 5760.7 5779.5 5787.7 5788.0 5788.9 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:65890.93 Median:35072.47 stddev:142088.60 (405.1%) stddev-sans-first:142402.31 02:12:00 INFO - PROCESS | 1660 | Values: 474.7 502.4 522.5 523.9 524.5 30216.5 30688.5 40442.0 41049.2 41153.0 42068.6 42587.1 42613.4 42617.9 42629.0 8554.4 9423.3 9596.5 9610.0 9613.7 8516.7 11432.3 11634.4 11702.9 11858.2 11550.0 11593.1 11611.3 11620.3 11785.4 11478.4 11541.8 11562.0 11564.5 11573.9 11379.6 11444.8 11459.3 11466.5 11474.3 39816.0 40480.4 40631.6 40640.4 40749.6 3332.7 3370.2 3422.4 3540.9 3675.7 30560.8 30592.5 31013.2 31265.5 31694.0 3172.8 3214.9 3229.5 3331.4 3363.8 440064.0 441822.8 442882.0 444561.0 457457.0 32762.8 61188.4 61540.0 61576.0 61586.0 33419.8 34453.5 34961.7 35105.3 35113.6 14054.3 14180.3 14203.8 14210.0 14229.3 10771.9 11052.7 12015.2 12137.0 12162.5 7404.2 7619.3 7792.5 7817.8 7854.7 3191.9 3209.8 3217.7 3226.5 3244.9 929.2 968.1 980.7 993.3 1041.7 30354.0 30386.4 30929.5 31068.7 31272.0 989.8 1027.1 1031.8 1050.4 1109.9 14779.3 15225.6 15624.5 16008.0 16214.5 578863.0 580023.0 581786.0 581950.0 585572.0 59059.4 59651.0 59863.7 59870.4 59975.0 1214.2 1267.4 1271.1 1368.9 1394.3 29613.7 31284.8 31908.8 32164.0 32646.8 54115.2 54527.0 54793.0 54897.5 54920.9 555102.0 559550.0 559741.0 561426.0 561752.0 25775.6 26109.2 26476.2 26788.3 27127.6 39814.0 46963.5 47114.0 47926.8 48098.0 39609.8 39772.4 39997.6 40903.6 40944.6 39086.0 39592.8 39611.8 40562.4 40838.6 37948.8 38313.6 38485.2 38894.0 39224.8 33654.0 34245.0 35039.6 35216.3 35406.3 18284.5 24204.0 25851.4 26003.3 26076.6 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33914.36 Median:13701.27 stddev:94569.67 (690.2%) stddev-sans-first:94801.37 02:12:00 INFO - PROCESS | 1660 | Values: 344.4 368.1 369.1 375.1 395.7 14781.3 14961.4 15926.4 20448.6 20799.0 19229.7 19750.3 20184.4 20312.4 20715.3 4980.6 5694.5 5919.6 5964.7 5972.3 5470.6 5805.5 5844.9 5896.4 5923.5 3809.6 4030.2 5661.9 5887.4 5929.5 5730.0 6024.0 6028.8 6041.2 6047.5 5618.7 5668.3 5676.1 5677.6 5692.5 12841.8 13057.3 19161.5 24936.9 25244.0 2148.7 2465.7 2549.0 2646.4 2940.7 9492.2 10034.1 10351.2 10374.7 15249.6 1715.9 1857.1 1901.3 1905.5 1906.7 107636.5 111627.0 113768.4 114343.0 115125.0 10979.0 11007.9 11304.6 11365.5 11568.8 14295.1 14296.0 14325.0 14334.0 14384.4 8255.7 8394.8 8409.6 8440.7 8549.8 6831.9 7304.5 8315.8 8508.9 8545.6 3712.8 4237.3 4570.4 4600.9 4616.3 1605.9 1837.4 1900.5 1904.7 1910.1 854.3 856.9 913.3 925.9 961.1 20074.0 21430.0 21800.8 22352.9 22823.4 879.8 898.8 934.9 952.1 962.2 8755.3 10015.5 11648.4 11701.9 11764.4 550606.0 552112.0 565373.0 573006.0 578398.0 126241.0 131686.0 131925.7 132644.0 136151.3 964.5 1016.1 1055.0 1058.8 1059.8 14557.4 15150.6 18010.5 19066.4 19449.0 55745.9 55927.4 56558.7 56902.4 57126.0 77601.0 80803.0 82069.6 83893.6 84432.0 7708.6 7877.3 8076.8 8145.2 8496.5 11161.3 12680.7 12877.4 13206.4 13254.5 11178.6 11247.2 11489.7 11521.2 11558.4 10992.3 10994.3 11158.3 11517.9 11526.1 11133.8 11345.5 11383.9 11419.3 11770.8 7890.9 7980.0 8175.7 8399.2 8415.6 8303.5 10266.2 11155.7 11186.8 11440.7 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5621.37 Median:5057.67 stddev:3136.94 (62.0%) stddev-sans-first:3129.09 02:12:00 INFO - PROCESS | 1660 | Values: 1322.2 1374.2 1541.9 1729.6 1964.8 7757.6 8173.1 8463.3 8804.7 8813.7 8571.1 8684.9 8687.3 8695.5 8704.3 2341.1 2366.4 2374.7 2381.4 2385.6 2331.9 2362.4 2370.6 2377.3 2382.2 2338.1 2362.2 2367.3 2371.2 2379.9 2309.0 2328.2 2333.6 2345.9 2353.8 2059.7 2326.7 2327.7 2335.4 2336.4 8248.1 8612.4 8694.0 8695.1 8713.7 5152.1 5373.4 5378.6 5382.2 5406.3 3351.3 3585.1 3610.0 3668.2 3683.8 835.7 1066.7 1073.7 1089.8 1102.8 11435.4 11524.3 11603.0 11610.3 11615.7 4397.6 4448.1 4616.5 4630.8 4631.1 9065.7 9066.3 9067.6 9067.8 9090.4 5116.0 5209.4 5226.9 5241.0 5243.3 4131.6 4392.6 4551.6 4551.7 4903.6 3707.9 3721.1 3797.6 3799.4 3804.4 1150.5 1153.9 1154.9 1161.9 1163.3 843.8 860.8 906.8 911.8 938.6 5703.8 5734.0 6012.2 6086.0 6159.5 782.6 845.7 943.0 950.0 964.1 3978.6 3989.6 3993.0 4054.7 4114.9 9967.6 10614.0 10798.8 10818.6 10832.9 10344.8 10568.5 10774.4 10787.6 10818.9 8077.7 8309.4 8330.1 8340.5 8346.8 5437.2 5546.2 5893.1 5931.6 5943.6 9801.0 10058.6 10107.4 10131.2 10133.0 7354.3 9101.5 9765.5 10002.5 10027.3 6582.9 7466.8 7526.8 7536.0 7626.3 8099.3 8176.7 8226.0 8291.8 8307.9 7387.0 7431.5 7484.5 7504.8 7534.8 7230.1 7293.0 7329.2 7354.0 7408.7 6890.4 6928.0 7002.9 7050.6 7060.6 4692.0 4719.2 4926.4 4971.5 5021.1 5001.6 5003.7 5094.2 5125.8 5207.6 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4507.12 Median:5097.81 stddev:1375.35 (27.0%) stddev-sans-first:1341.48 02:12:00 INFO - PROCESS | 1660 | Values: 244.5 294.3 297.7 304.8 309.4 5105.9 5298.0 5298.3 5310.2 5347.3 5082.6 5221.3 5227.0 5264.3 5272.8 3569.8 3850.2 4106.2 4106.8 4128.4 3909.3 4073.9 4122.3 4135.7 4146.2 3848.2 3906.8 3969.7 3998.8 4045.9 3297.1 3994.4 4021.0 4028.6 4037.5 3058.4 3493.9 3495.2 3511.5 3529.4 4368.4 4829.5 5091.9 5174.7 5253.5 4571.8 4656.3 4669.5 4679.9 4698.6 4712.6 5426.9 5542.2 5548.4 5554.3 3220.4 3615.8 3680.8 3878.1 3917.8 5122.8 5197.8 5590.0 5801.8 5806.2 3935.4 3954.3 3957.7 3966.8 3973.0 3686.8 3817.5 3878.4 4022.2 4043.2 4225.5 4475.3 4545.5 4601.6 4604.5 4828.1 5391.4 5563.1 5586.2 5605.9 1355.8 1370.7 1380.7 1391.6 1404.0 828.4 848.5 859.6 893.3 904.4 4390.1 5173.9 5174.5 5179.8 5181.6 4833.3 5261.9 5455.6 5647.8 5654.5 4664.0 4912.3 5172.3 5255.9 5276.8 2602.0 3000.9 3002.0 3009.8 3026.3 5601.6 5936.6 5941.7 6009.8 6072.8 4692.2 4882.5 5392.6 5930.2 5955.7 5155.8 5907.7 6022.5 6086.5 6129.4 4356.7 4480.6 5407.5 5714.6 5779.6 4961.0 5670.9 5707.3 5726.7 5746.3 5491.8 5694.8 5984.7 6001.3 6035.5 3701.0 3848.3 3881.9 3914.7 3914.8 5125.4 5524.4 5818.3 5832.2 5865.3 4877.5 5053.4 5103.7 5376.8 5487.3 5616.7 5621.1 5647.1 5667.2 5692.9 4700.7 5464.8 5518.8 5540.4 5564.1 4650.6 5307.2 5610.7 5622.5 5626.3 4288.3 4533.8 5153.5 5492.3 5512.5 02:12:00 INFO - PROCESS | 1660 | 02:12:00 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25259.09 Median:4420.36 stddev:42315.07 (957.3%) stddev-sans-first:42393.27 02:12:00 INFO - PROCESS | 1660 | Values: 599.7 804.8 805.4 828.0 831.2 15027.2 15859.9 15880.4 15914.1 15925.3 13838.7 14355.9 14435.7 14446.2 14466.9 875.6 877.5 880.0 888.5 889.7 895.5 895.8 898.6 898.6 899.9 948.3 949.0 950.3 952.4 955.4 790.8 938.5 940.2 943.3 946.0 696.3 697.6 698.2 698.5 698.7 13859.7 13878.0 13886.5 13886.7 13901.5 9914.6 11925.3 11949.8 12107.9 12295.9 10750.8 10755.0 10804.4 10960.9 11270.9 3041.7 3627.0 3683.7 3698.1 3717.9 107890.5 110143.4 111828.0 115397.4 115435.0 8922.2 9029.8 9078.5 9122.2 9631.7 19912.5 20112.0 20127.2 20145.7 20147.8 7936.3 8052.2 8089.4 8182.5 8352.5 4270.4 4404.3 4462.2 4489.3 4497.8 3569.1 3678.3 3701.0 3701.7 3705.2 628.9 642.9 656.0 656.4 659.4 624.9 643.4 654.6 661.4 692.8 6957.5 9312.6 9378.2 9436.0 9512.9 615.7 655.6 668.5 669.6 684.0 4334.0 4436.5 4575.2 4624.5 4624.9 150197.0 156884.0 160769.2 161073.0 166368.0 136611.0 138127.6 139838.0 140629.0 141452.0 103459.0 119504.1 122409.2 122696.4 123178.0 8503.3 8527.6 8604.6 8708.8 9062.0 50485.7 51509.0 62766.4 63236.0 64767.1 94867.0 96950.0 99043.1 99362.0 100968.5 11068.1 11279.9 11288.7 11398.5 11419.0 12017.3 12077.9 12198.2 12500.5 12579.1 11073.8 11920.9 11921.3 12048.5 12370.8 11547.4 11752.1 11775.6 12303.3 12440.9 11546.8 11741.8 11750.6 11900.6 12257.4 9681.4 9714.2 9893.1 9958.0 9975.6 9812.7 9972.2 10016.0 10097.5 10118.2 02:12:00 INFO - PROCESS | 1660 | -------- Summary: end -------- 02:12:00 INFO - PROCESS | 1660 | 02:12:01 INFO - TEST-INFO | 1660: exit 0 02:12:01 INFO - TEST-OK | dromaeo_css | took 1119491ms 02:12:01 INFO - TEST-START | kraken 02:12:01 INFO - operating with platform_type : mac_ 02:12:01 INFO - Initialising browser for kraken test... 02:12:01 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpPm_okW/profile http://localhost:49272/getInfo.html) 02:12:03 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 02:12:03 INFO - PROCESS | 1666 | colorDepth:24 02:12:03 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 02:12:03 INFO - PROCESS | 1666 | __metrics 02:12:03 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:12:03 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:12:04 INFO - TEST-INFO | 1666: exit 0 02:12:04 INFO - Browser initialized. 02:12:04 INFO - Running cycle 1/1 for kraken test... 02:12:04 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpPm_okW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:16 INFO - PROCESS | 1667 | RSS: Main: 258809856 02:12:16 INFO - PROCESS | 1667 | 02:12:19 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:12:20 INFO - PROCESS | 1667 | RSS: Main: 308117504 02:12:20 INFO - PROCESS | 1667 | 02:12:22 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:12:23 INFO - PROCESS | 1667 | RSS: Main: 307933184 02:12:23 INFO - PROCESS | 1667 | 02:12:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:12:27 INFO - PROCESS | 1667 | RSS: Main: 396566528 02:12:27 INFO - PROCESS | 1667 | 02:12:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:12:30 INFO - PROCESS | 1667 | RSS: Main: 299937792 02:12:30 INFO - PROCESS | 1667 | 02:12:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:12:33 INFO - PROCESS | 1667 | RSS: Main: 301486080 02:12:33 INFO - PROCESS | 1667 | 02:12:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:12:36 INFO - PROCESS | 1667 | RSS: Main: 339050496 02:12:36 INFO - PROCESS | 1667 | 02:12:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:12:40 INFO - PROCESS | 1667 | RSS: Main: 341139456 02:12:40 INFO - PROCESS | 1667 | 02:12:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:12:43 INFO - PROCESS | 1667 | RSS: Main: 339558400 02:12:43 INFO - PROCESS | 1667 | 02:12:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:12:45 INFO - PROCESS | 1667 | RSS: Main: 315801600 02:12:45 INFO - PROCESS | 1667 | 02:12:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:12:48 INFO - PROCESS | 1667 | RSS: Main: 316350464 02:12:48 INFO - PROCESS | 1667 | 02:12:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:50 INFO - PROCESS | 1667 | RSS: Main: 321765376 02:12:50 INFO - PROCESS | 1667 | 02:12:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:54 INFO - PROCESS | 1667 | RSS: Main: 330469376 02:12:54 INFO - PROCESS | 1667 | 02:12:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:58 INFO - PROCESS | 1667 | RSS: Main: 329990144 02:12:58 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:13:00 INFO - PROCESS | 1667 | RSS: Main: 374362112 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | __start_tp_report 02:13:00 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 02:13:00 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 02:13:00 INFO - PROCESS | 1667 | |i|pagename|runs| 02:13:00 INFO - PROCESS | 1667 | |0;ai-astar;113;112;114;111;112;113;112;111;112;111 02:13:00 INFO - PROCESS | 1667 | |1;audio-beat-detection;182;142;118;163;116;115;113;113;165;142 02:13:00 INFO - PROCESS | 1667 | |2;audio-dft;182;182;186;185;184;184;185;181;182;180 02:13:00 INFO - PROCESS | 1667 | |3;audio-fft;82;84;83;112;66;59;59;60;82;58 02:13:00 INFO - PROCESS | 1667 | |4;audio-oscillator;86;69;93;70;68;68;92;68;70;117 02:13:00 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;85;89;89;86;88;94;87;85;80 02:13:00 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;122;150;94;93;93;102;94;93;94 02:13:00 INFO - PROCESS | 1667 | |7;imaging-desaturate;80;81;80;79;82;81;97;128;113;80 02:13:00 INFO - PROCESS | 1667 | |8;json-parse-financial;56;57;56;56;55;54;54;55;54;54 02:13:00 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;67;78;75;76;71;69;70;70;69;72 02:13:00 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;91;87;86;86;90;87;86;86;92;87 02:13:00 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;147;160;157;146;150;148;154;168;219;151 02:13:00 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;174;172;181;172;171;175;173;174;167;171 02:13:00 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;70;69;69;70;69;70;69;72;83;89 02:13:00 INFO - PROCESS | 1667 | __end_tp_report 02:13:00 INFO - PROCESS | 1667 | __start_cc_report 02:13:00 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2007 02:13:00 INFO - PROCESS | 1667 | __end_cc_report 02:13:00 INFO - PROCESS | 1667 | __startTimestamp1477041180446__endTimestamp 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | ------- Summary: start ------- 02:13:00 INFO - PROCESS | 1667 | Number of tests: 14 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 02:13:00 INFO - PROCESS | 1667 | Values: 113.0 112.0 114.0 111.0 112.0 113.0 112.0 111.0 112.0 111.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:142.00 stddev:25.76 (18.1%) stddev-sans-first:21.54 02:13:00 INFO - PROCESS | 1667 | Values: 182.0 142.0 118.0 163.0 116.0 115.0 113.0 113.0 165.0 142.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:1.97 (1.1%) stddev-sans-first:2.05 02:13:00 INFO - PROCESS | 1667 | Values: 182.0 182.0 186.0 185.0 184.0 184.0 185.0 181.0 182.0 180.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:74.50 Median:74.00 stddev:17.37 (23.5%) stddev-sans-first:18.21 02:13:00 INFO - PROCESS | 1667 | Values: 82.0 84.0 83.0 112.0 66.0 59.0 59.0 60.0 82.0 58.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:70.00 stddev:16.57 (23.7%) stddev-sans-first:17.44 02:13:00 INFO - PROCESS | 1667 | Values: 86.0 69.0 93.0 70.0 68.0 68.0 92.0 68.0 70.0 117.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.50 stddev:3.65 (4.1%) stddev-sans-first:3.81 02:13:00 INFO - PROCESS | 1667 | Values: 89.0 85.0 89.0 89.0 86.0 88.0 94.0 87.0 85.0 80.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:93.50 stddev:18.79 (20.1%) stddev-sans-first:19.71 02:13:00 INFO - PROCESS | 1667 | Values: 95.0 122.0 150.0 94.0 93.0 93.0 102.0 94.0 93.0 94.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:80.50 stddev:17.22 (21.4%) stddev-sans-first:17.87 02:13:00 INFO - PROCESS | 1667 | Values: 80.0 81.0 80.0 79.0 82.0 81.0 97.0 128.0 113.0 80.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.10 (2.0%) stddev-sans-first:1.12 02:13:00 INFO - PROCESS | 1667 | Values: 56.0 57.0 56.0 56.0 55.0 54.0 54.0 55.0 54.0 54.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:3.53 (4.9%) stddev-sans-first:3.31 02:13:00 INFO - PROCESS | 1667 | Values: 67.0 78.0 75.0 76.0 71.0 69.0 70.0 70.0 69.0 72.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:2.30 (2.6%) stddev-sans-first:2.13 02:13:00 INFO - PROCESS | 1667 | Values: 91.0 87.0 86.0 86.0 90.0 87.0 86.0 86.0 92.0 87.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:160.00 Median:155.50 stddev:21.81 (14.0%) stddev-sans-first:22.62 02:13:00 INFO - PROCESS | 1667 | Values: 147.0 160.0 157.0 146.0 150.0 148.0 154.0 168.0 219.0 151.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.50 stddev:3.59 (2.1%) stddev-sans-first:3.79 02:13:00 INFO - PROCESS | 1667 | Values: 174.0 172.0 181.0 172.0 171.0 175.0 173.0 174.0 167.0 171.0 02:13:00 INFO - PROCESS | 1667 | 02:13:00 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:70.00 stddev:7.06 (10.1%) stddev-sans-first:7.40 02:13:00 INFO - PROCESS | 1667 | Values: 70.0 69.0 69.0 70.0 69.0 70.0 69.0 72.0 83.0 89.0 02:13:00 INFO - PROCESS | 1667 | -------- Summary: end -------- 02:13:00 INFO - PROCESS | 1667 | 02:13:01 INFO - TEST-INFO | 1667: exit 0 02:13:01 INFO - TEST-OK | kraken | took 59988ms 02:13:01 INFO - SUITE-END | took 1179s 02:13:01 INFO - Completed test suite (00:19:39) 02:13:01 INFO - javascript benchmark 02:13:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.6702329767027, 3305.5537502437164, 3312.2381852173985, 3345.448001079822, 3358.9328213435733, 5387.326584176978, 5531.225628412026, 5536.806211782588, 5576.804811831586, 5580.665160090397, 5422.1595652673805, 5508.724563771805, 5533.142362933741, 5542.057850165472, 5549.334079910406, 5077.999999999991, 5091.083604951107, 5093.18509038552, 5125.103106956268, 5167.9224811627855, 5131.3842338919385, 5182.844514664547, 5187.3775146982225, 5191.558717509016, 5195.402528709209, 5134.845954621349, 5179.792808287664, 5184.5074717901925, 5185.377754669426, 5216.035033518792, 5186.870328241786, 5208.791648334062, 5218.347706536683, 5248.370195576517, 5310.150375939869, 5035.269885866529, 5037.49625037497, 5109.948900511022, 5126.0, 5155.896882062338, 5520.972395138038, 5543.445655434464, 5569.721513924328, 5585.720713964326, 5653.57598180134, 6103.35914728956, 6118.296395914438, 6120.234970628671, 6132.08018797184, 6138.508919286446, 6006.339302676702, 6110.175126357929, 6126.663033533198, 6144.600600960924, 6157.7536898524, 5504.009278329939, 5684.744186511617, 5687.7156142192725, 5743.770249190027, 5750.6837123958585, 5357.919631205535, 6285.685715714196, 6286.15136956505, 6300.810975670737, 6317.084022816666, 5856.12158176277, 5920.141579471038, 6035.758569657164, 6039.909401358983, 6041.124037014696, 6122.855605809957, 6144.662043587646, 6149.61633632438, 6163.1679723237685, 6223.284322302902, 6104.481119104837, 6106.511479081662, 6115.266168059861, 6121.117656725486, 6134.503712358327, 5818.389069147764, 6133.865234931552, 6142.034548944295, 6147.831911936718, 6149.446549810538, 4729.196036673774, 4824.204006338985, 4841.080194762983, 4852.102361063215, 4891.853244402673, 4332.0469496710675, 4346.695731298779, 4354.825806967686, 4391.055922976511, 4395.252807022814, 5576.9163462548095, 5643.604947653707, 5665.5184309333345, 5669.0, 5670.036093864053, 4796.56830885222, 5991.340952495222, 6019.097135429721, 6099.603525770811, 6200.007998720183, 5583.69289689071, 5670.262865827499, 5677.37548869624, 5696.772129114789, 5722.77108915647, 5318.574514038945, 5327.907778905315, 5334.5732341412595, 5338.839834804962, 5339.706316152571, 6212.0, 6275.811725648238, 6276.560640755286, 6286.497080233479, 6295.307516173309, 6030.5778595497895, 6102.307478454246, 6122.602030867979, 6134.263888333428, 6141.547378150984, 6267.2479302484, 6268.686565671607, 6277.591956522811, 6290.874182516415, 6304.65324407162, 5999.820005399845, 6012.218411606463, 6056.212692349966, 6062.909056364247, 6065.696715164312, 6018.849528761816, 6083.0, 6094.146819445193, 6109.236345456818, 6148.692565371803, 5972.790952316648, 5973.880522389441, 5983.102534619842, 6005.609635373687, 6016.2479690038745, 5945.881082378415, 5972.343042265435, 5977.701114944322, 5979.402059793986, 5981.461668449861, 4756.476787553435, 5488.231647569423, 5749.8275051748515, 5776.364599893925, 5831.4168583141345, 5871.03127983895, 5922.289325280994, 5925.822225333247, 5933.525317974638, 5934.6735929522565, 5760.683162426107, 5779.508741756998, 5787.652740835563, 5788.0, 5788.942110579009], "value": 5588.442984229549, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.7009384088024, 502.43225155574197, 522.464473914238, 523.9371275446946, 524.4598063994085, 30216.546751798713, 30688.539671904913, 40442.0, 41049.17901641973, 41153.0, 42068.57931420692, 42587.14825703484, 42613.36079958795, 42617.93455163622, 42629.0, 8554.401191916568, 9423.293253006035, 9596.472194029326, 9610.0, 9613.66352177674, 8516.701915432961, 11432.314061156358, 11634.418279086054, 11702.882971170307, 11858.229215101033, 11550.0, 11593.130515211351, 11611.303321800719, 11620.302781833076, 11785.351805650685, 11478.368689722061, 11541.826872596876, 11562.0, 11564.53741850325, 11573.884261157365, 11379.601713939972, 11444.828327575093, 11459.31244125355, 11466.541338346457, 11474.311541307548, 39816.0, 40480.39279410811, 40631.593684063075, 40640.39039414411, 40749.59250407488, 3332.7167190788814, 3370.1911541230174, 3422.401079811023, 3540.91147721309, 3675.724320675933, 30560.8471957641, 30592.54111188334, 31013.22466938322, 31265.531017034536, 31694.0, 3172.825494597796, 3214.8714051437914, 3229.531717900915, 3331.4003479373705, 3363.8486268117995, 440064.0, 441822.7908860435, 442882.0, 444560.9895109423, 457457.0, 32762.83618581892, 61188.38811611827, 61540.0, 61576.0, 61586.0, 33419.83290083534, 34453.48319775205, 34961.65038349635, 35105.29789404198, 35113.648863511546, 14054.297285135703, 14180.290985450687, 14203.78694319586, 14210.0, 14229.28853557318, 10771.946140269249, 11052.668419947415, 12015.219010764447, 12137.0, 12162.452689628988, 7404.222556631584, 7619.314261716361, 7792.493487923267, 7817.80455488606, 7854.6858125674335, 3191.9042428727175, 3209.759268054905, 3217.6621454746914, 3226.5321528378254, 3244.8539815707877, 929.2287401456774, 968.1238479176357, 980.7302991677345, 993.3245393132739, 1041.656253436364, 30354.0, 30386.392272154877, 30929.536056959165, 31068.689313107032, 31272.0, 989.7525618595351, 1027.1474676018886, 1031.8245898197324, 1050.3592808386877, 1109.916756243285, 14779.334929927963, 15225.619359515878, 15624.531264062096, 16007.985028072364, 16214.51356459308, 578863.0, 580023.0, 581786.0, 581950.0, 585572.0, 59059.40940590625, 59651.0, 59863.70068149632, 59870.401295986485, 59975.0, 1214.2228973456995, 1267.3916520070418, 1271.0784681106493, 1368.8699573540696, 1394.2958805803207, 29613.703862961094, 31284.843575781975, 31908.8404557985, 32164.0, 32646.83676581602, 54115.18827217674, 54527.0, 54793.0, 54897.45102548923, 54920.90158196894, 555102.0, 559550.0, 559741.0, 561426.0, 561752.0, 25775.613365799152, 26109.216723498324, 26476.205713828615, 26788.330291742863, 27127.59308610412, 39814.0, 46963.530364695915, 47114.0, 47926.760366197945, 48098.0, 39609.81170564888, 39772.40341394823, 39997.60002399939, 40903.59096409117, 40944.59055409408, 39086.02284942899, 39592.812215633574, 39611.80194099011, 40562.391564125974, 40838.59161408467, 37948.81025594854, 38313.61686383212, 38485.230295394496, 38894.02764930899, 39224.803875981575, 33653.99038028863, 34245.0, 35039.64960350364, 35216.29567408689, 35406.29187416289, 18284.451466456027, 24204.0, 25851.405463267325, 26003.34991625149, 26076.608850866873], "value": 18873.647001107027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.4437233867305, 368.09815950920245, 369.123332086295, 375.0698268294629, 395.7170623004551, 14781.334839932202, 14961.401543938244, 15926.362945482197, 20448.591028179464, 20799.0, 19229.711554326663, 19750.30873919413, 20184.394468165978, 20312.390628281137, 20715.274965376215, 4980.6015518758595, 5694.487496125358, 5919.615225010382, 5964.671943043131, 5972.343042265347, 5470.64440811348, 5805.535557155438, 5844.941550584504, 5896.439838215363, 5923.496502797246, 3809.619038096182, 4030.1939612077554, 5661.886762264752, 5887.4112588741, 5929.495992840613, 5730.0, 6023.969880150593, 6028.849278768044, 6041.24484439445, 6047.455728984412, 5618.690971996539, 5668.348139963916, 5676.091825307931, 5677.57418193633, 5692.459216374438, 12841.807372889414, 13057.34713264333, 19161.520961975923, 24936.87531562349, 25244.0, 2148.666956621726, 2465.6671349367966, 2549.005887703797, 2646.4442467081935, 2940.7059294070423, 9492.240620750323, 10034.147097496721, 10351.171906247557, 10374.740631484197, 15249.645078082804, 1715.8970461772333, 1857.1085878778126, 1901.2965202874886, 1905.514093906045, 1906.7044608085769, 107636.46181769119, 111627.0, 113768.4311578445, 114343.0, 115125.0, 10979.011888930034, 11007.889921100686, 11304.604338848265, 11365.545378184945, 11568.76862462746, 14295.07082039664, 14296.0, 14324.997250192595, 14334.0, 14384.35270412834, 8255.669773209005, 8394.8321033579, 8409.56122724403, 8440.74677759656, 8549.786255343543, 6831.87274099768, 7304.5252058616015, 8315.79420983966, 8508.914910850812, 8545.615447304886, 3712.8119001919126, 4237.343211802176, 4570.428696412949, 4600.861974140714, 4616.330632058332, 1605.8635016023768, 1837.364745376616, 1900.4583693647244, 1904.7428597139485, 1910.0545230110906, 854.3421565394611, 856.8629019356997, 913.3150137396952, 925.9074092590687, 961.077365728894, 20074.0, 21430.0, 21800.80095594726, 22352.888235559043, 22823.429414264778, 879.8108406692592, 898.8247291778172, 934.8878134623752, 952.1050212799946, 962.1773383756927, 8755.255803256794, 10015.499225038719, 11648.41757912118, 11701.941490292495, 11764.411779410995, 550606.0, 552112.0, 565373.0, 573006.0, 578398.0, 126241.0, 131686.0, 131925.68074319133, 132644.0, 136151.31924340315, 964.4936408385654, 1016.1159790981745, 1054.9578016879393, 1058.8464672622426, 1059.814532456817, 14557.41770329175, 15150.621234469227, 18010.459686209433, 19066.428007159808, 19449.0, 55745.88508229732, 55927.44072559222, 56558.717206413705, 56902.43097568971, 57126.0, 77601.0, 80803.0, 82069.58965205136, 83893.58053209695, 84432.0, 7708.614569271402, 7877.251661092187, 8076.757697269091, 8145.226203510657, 8496.490210587384, 11161.274517156358, 12680.74638507243, 12877.35613219354, 13206.405711743188, 13254.469821207043, 11178.552857885594, 11247.212695111592, 11489.655310340702, 11521.193516453768, 11558.364289963796, 10992.340459572451, 10994.28537145083, 11158.330500170016, 11517.942410287895, 11526.077913767047, 11133.83299250528, 11345.489452974802, 11383.943080284545, 11419.31484110956, 11770.76458470843, 7890.881636775338, 7980.042394912648, 8175.7138500152205, 8399.160083991552, 8415.579221039046, 8303.4602750821, 10266.230032747722, 11155.72110697239, 11186.776264474502, 11440.713982150513], "value": 9398.298968175714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.1868550841232, 1374.2304309586625, 1541.9229038548074, 1729.5762538178149, 1964.7740509841371, 7757.5733334666575, 8173.100958894517, 8463.322934165268, 8804.691835785748, 8813.691520796774, 8571.100034496381, 8684.91315086849, 8687.261582765472, 8695.521746303952, 8704.347173961947, 2341.1337805012167, 2366.3965688749345, 2374.7031621047367, 2381.404648837791, 2385.594448943675, 2331.94170145746, 2362.444825466014, 2370.6207006878903, 2377.2630484549845, 2382.19005538117, 2338.1348900906687, 2362.244081893795, 2367.3489790307717, 2371.1819422299277, 2379.940501487468, 2308.953820923589, 2328.161861729776, 2333.614953532665, 2345.870977096259, 2353.8352315337934, 2059.6704527275715, 2326.685897403846, 2327.674125622414, 2335.4161459635093, 2336.439254578906, 8248.13394593565, 8612.354073444516, 8694.0, 8695.087015863306, 8713.69502067431, 5152.098382782998, 5373.435789242112, 5378.623496355257, 5382.219578161144, 5406.324209473816, 3351.329734053199, 3585.0678823505814, 3610.0433385152955, 3668.229671768932, 3683.8158092095287, 835.6907944060675, 1066.7493139112303, 1073.7476692977143, 1089.7657003744155, 1102.7518808268155, 11435.428228588537, 11524.250923690017, 11603.013743831785, 11610.303381797035, 11615.709607259801, 4397.582229688174, 4448.065906159743, 4616.538346165424, 4630.837920672828, 4631.120087183424, 9065.728028159167, 9066.320025998077, 9067.591958361889, 9067.81864362709, 9090.409123406956, 5115.951229997841, 5209.43716884933, 5226.947730522646, 5241.0, 5243.292155558951, 4131.628153466202, 4392.582704643054, 4551.590356867898, 4551.658625603027, 4903.607711383081, 3707.888763337104, 3721.14413684854, 3797.5632802228097, 3799.4490798834568, 3804.4483549885667, 1150.451749375138, 1153.9192256542128, 1154.8787377325427, 1161.924474909128, 1163.3020187887369, 843.7510934274404, 860.8407444622765, 906.775852598986, 911.8221946720325, 938.554186761283, 5703.771849126071, 5734.0, 6012.1582978382185, 6085.9695701521205, 6159.476444502178, 782.5891407011251, 845.7462761171747, 942.9575669094908, 949.9762505937268, 964.0889359555293, 3978.6380508470297, 3989.5810939851476, 3992.9800350998057, 4054.716169868081, 4114.917701645951, 9967.551460184164, 10614.0447359738, 10798.78402431947, 10818.56725730962, 10832.945835270773, 10344.844827327595, 10568.524416401127, 10774.353538787698, 10787.6224332148, 10818.94590527058, 8077.717279895293, 8309.379670964225, 8330.083690794008, 8340.541270230196, 8346.791330216793, 5437.238786569963, 5546.195801608825, 5893.145493903275, 5931.555133365101, 5943.64338139713, 9801.0, 10058.597656093967, 10107.444090575089, 10131.240156988108, 10132.986701329808, 7354.301341372561, 9101.544922753968, 9765.462899540309, 10002.549885255035, 10027.348222365523, 6582.901256481253, 7466.813329666802, 7526.849463010819, 7536.0, 7626.275503827128, 8099.311558517592, 8176.713815016446, 8225.95887020561, 8291.83416331658, 8307.916920830714, 7387.0, 7431.479796414199, 7484.476086673881, 7504.812379690551, 7534.8493030138, 7230.13238411394, 7293.0, 7329.230430804902, 7353.963230183815, 7408.6666100026705, 6890.44876409896, 6927.965360173167, 7002.934134430254, 7050.647467626495, 7060.6116663584, 4692.014676917749, 4719.150552900373, 4926.4088309403105, 4971.502849715, 5021.146405111067, 5001.57486613642, 5003.699778013331, 5094.1849304111165, 5125.820596279113, 5207.635465517377], "value": 4514.874967596301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.5451460283872, 294.29075927015896, 297.72014306551847, 304.7805579982412, 309.37351862478494, 5105.923411148836, 5298.013245033113, 5298.284731561238, 5310.20346947958, 5347.278117454148, 5082.593392528598, 5221.295125158103, 5227.0, 5264.289320941672, 5272.841814745554, 3569.8398020643267, 3850.2299540092095, 4106.1992911382295, 4106.77412742299, 4128.442660240874, 3909.3158697228014, 4073.9185216295655, 4122.278601244785, 4135.710500264982, 4146.1914926589325, 3848.2111167210796, 3906.824192911326, 3969.741966772165, 3998.8400463981407, 4045.919081618366, 3297.0768184908266, 3994.4407782910416, 4021.0, 4028.5568587455355, 4037.5154981402275, 3058.3730335281216, 3493.8602455901732, 3495.196104895863, 3511.4732790081694, 3529.400001999666, 4368.366586844922, 4829.5028541152005, 5091.9236211456855, 5174.6636468629795, 5253.50091741284, 4571.771411429449, 4656.324832899245, 4669.486356500782, 4679.906401871944, 4698.553637404441, 4712.64655150865, 5426.864328391783, 5542.168674698827, 5548.361938377057, 5554.333479982388, 3220.4203243416177, 3615.7649752765988, 3680.7791532508136, 3878.146807702301, 3917.843286268546, 5122.795088196468, 5197.830488140176, 5590.0, 5801.764711760438, 5806.187133801313, 3935.409688546684, 3954.347532657137, 3957.6635985940943, 3966.841326346914, 3973.000384709526, 3686.829326778968, 3817.4655548223272, 3878.437626544135, 4022.1955608878343, 4043.2317859606583, 4225.514065882401, 4475.283954567319, 4545.522720114406, 4601.585857272795, 4604.470485894098, 4828.082664293773, 5391.35303763543, 5563.109902415594, 5586.24585680936, 5605.887882242414, 1355.7966305054322, 1370.6984463418032, 1380.675541247806, 1391.6173052410668, 1403.996142757933, 828.362161135922, 848.4569875279826, 859.5573279760928, 893.3255392178863, 904.4437670832522, 4390.05613793036, 5173.896522069537, 5174.482551744871, 5179.792808287626, 5181.637285390062, 4833.347498087784, 5261.868453288698, 5455.645383050169, 5647.774089036392, 5654.455495027254, 4663.953360466419, 4912.25614906703, 5172.301739265151, 5255.921161182585, 5276.841694749163, 2602.0, 3000.9099727008224, 3002.0, 3009.759219262454, 3026.334206474572, 5601.60788744784, 5936.5844390892225, 5941.70291485424, 6009.789657361971, 6072.7570897164505, 4692.1554120258, 4882.462929077798, 5392.573341996039, 5930.22907022093, 5955.67243801595, 5155.793768249228, 5907.675077870758, 6022.518198544106, 6086.543509236825, 6129.387061293835, 4356.6950313477755, 4480.596746292849, 5407.486288802557, 5714.571407144397, 5779.624324418899, 4961.03259864323, 5670.9432905672065, 5707.343655479673, 5726.713664316851, 5746.310442746897, 5491.807786727445, 5694.804091140907, 5984.730687119003, 6001.339852616122, 6035.486983606443, 3700.9814950925074, 3848.288066707668, 3881.9223615526967, 3914.72596918213, 3914.8434062637175, 5125.43620201785, 5524.392316845064, 5818.33089194748, 5832.212651292021, 5865.266841644794, 4877.463598966314, 5053.393592768891, 5103.693778373309, 5376.758045888023, 5487.338640759149, 5616.66300022, 5621.100623900156, 5647.124695672177, 5667.20659107717, 5692.914606280992, 4700.670953033392, 5464.836054918359, 5518.751656175402, 5540.418256083053, 5564.054110801093, 4650.558196971282, 5307.150855863198, 5610.747516361856, 5622.465865742748, 5626.2967129108865, 4288.270993931102, 4533.818647254073, 5153.484651534816, 5492.286002819608, 5512.503874651301], "value": 4065.6298709239813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.69415598045, 804.7907544038549, 805.3557154276577, 827.9503229806212, 831.2477208126647, 15027.173505457196, 15859.920700396511, 15880.444184453532, 15914.124723140238, 15925.283362248698, 13838.654033649163, 14355.856441435582, 14435.711285774278, 14446.205458699767, 14466.855331446683, 875.5797217335682, 877.455977294077, 880.0187790613452, 888.5468411110348, 889.6797153024938, 895.5432729308067, 895.771578247546, 898.5956319656149, 898.6405437824857, 899.9145081217274, 948.3361646847235, 949.0130264524886, 950.2587981374539, 952.3714348529971, 955.3885513271478, 790.7746292306665, 938.5448057692014, 940.1867384712175, 943.3443756589173, 945.9574319155655, 696.3384784454738, 697.5744795674634, 698.2284575544002, 698.5250029979612, 698.6960672107599, 13859.722805543934, 13878.028538002343, 13886.513972010931, 13886.722265554734, 13901.513447029305, 9914.55384507699, 11925.344106074162, 11949.820752688716, 12107.878921210764, 12295.93852030743, 10750.78498430027, 10755.0, 10804.351738895692, 10960.890391096067, 11270.887291127066, 3041.650210225808, 3627.0, 3683.686886614641, 3698.149425632093, 3717.851285948586, 107890.46054769676, 110143.44928275388, 111828.0, 115397.42301288524, 115435.0, 8922.197002269826, 9029.77425564353, 9078.500682462529, 9122.179003889549, 9631.662891798753, 19912.50218744543, 20111.994400279928, 20127.194912203642, 20145.697814532792, 20147.798522014884, 7936.2857342839425, 8052.194780521901, 8089.39329550286, 8182.4681395709085, 8352.540610266493, 4270.423492828429, 4404.2512772828695, 4462.196804575207, 4489.259272220047, 4497.815077699912, 3569.0720412692885, 3678.301122786662, 3701.0192299040777, 3701.6668499835146, 3705.2404257127223, 628.9151710858248, 642.9421352078335, 655.9508036897251, 656.409231691472, 659.3768888400512, 624.8968920128128, 643.3823529411724, 654.5549026661915, 661.3849120318055, 692.7540723043347, 6957.547759395623, 9312.627494900264, 9378.202852757591, 9435.952820235992, 9512.90487095134, 615.6552330694825, 655.6099121022984, 668.5387082912774, 669.648434571844, 683.9931600684029, 4334.046509767846, 4436.467623885154, 4575.215586074744, 4624.468186158635, 4624.907501849944, 150197.0, 156884.0, 160769.1961540185, 161073.0, 166368.0, 136611.0, 138127.64042696837, 139838.0, 140629.0, 141452.0, 103458.96541034644, 119504.07438884237, 122409.16386254036, 122696.38651806684, 123178.0, 8503.319734421355, 8527.573621319034, 8604.569771511524, 8708.825823483368, 9061.954690226507, 50485.747571261905, 51509.0, 62766.37233627788, 63236.0, 64767.056988290424, 94867.0, 96950.0, 99043.05741655524, 99362.0, 100968.49515752374, 11068.114550836075, 11279.887201127884, 11288.717782055513, 11398.544058237578, 11419.0, 12017.278963262232, 12077.879221207675, 12198.207116537396, 12500.499980001063, 12579.119461637598, 11073.778524429628, 11920.880791191978, 11921.284722916653, 12048.457819397972, 12370.81443778326, 11547.364894930859, 11752.059835213333, 11775.646730597753, 12303.323317217639, 12440.875591244334, 11546.76906461883, 11741.76516469683, 11750.588729394773, 11900.642980710592, 12257.448414821176, 9681.419114853132, 9714.174295184988, 9893.060159284856, 9958.0, 9975.60097596088, 9812.65655702047, 9972.152367048882, 10016.0, 10097.5456104474, 10118.241131915283], "value": 7589.24886558442, "unit": "score"}], "name": "dromaeo_css", "value": 7189.557560803744, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 142.0, 118.0, 163.0, 116.0, 115.0, 113.0, 113.0, 165.0, 142.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 186.0, 185.0, 184.0, 184.0, 185.0, 181.0, 182.0, 180.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 112.0, 66.0, 59.0, 59.0, 60.0, 82.0, 58.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 93.0, 70.0, 68.0, 68.0, 92.0, 68.0, 70.0, 117.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 89.0, 86.0, 88.0, 94.0, 87.0, 85.0, 80.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 122.0, 150.0, 94.0, 93.0, 93.0, 102.0, 94.0, 93.0, 94.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 79.0, 82.0, 81.0, 97.0, 128.0, 113.0, 80.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 75.0, 76.0, 71.0, 69.0, 70.0, 70.0, 69.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 86.0, 86.0, 90.0, 87.0, 86.0, 86.0, 92.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 160.0, 157.0, 146.0, 150.0, 148.0, 154.0, 168.0, 219.0, 151.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 181.0, 172.0, 171.0, 175.0, 173.0, 174.0, 167.0, 171.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 72.0, 83.0, 89.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1487.6000000000001, "alertThreshold": 2.0}]} 02:13:01 INFO - Return code: 0 02:13:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:13:01 INFO - # TBPL SUCCESS # 02:13:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:13:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:13:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:13:01 INFO - 2016-10-21 02:13:01.739 screenresolution[1671:9899] starting screenresolution argv=screenresolution get 02:13:01 INFO - 2016-10-21 02:13:01.742 screenresolution[1671:9899] Display 0: 1600x1200x32@60 02:13:01 INFO - 2016-10-21 02:13:01.748 screenresolution[1672:9902] starting screenresolution argv=screenresolution list 02:13:01 INFO - Available Modes on Display 0 02:13:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:13:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:13:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:13:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:13:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:13:01 INFO - Intel Iris: 02:13:01 INFO - Chipset Model: Intel Iris 02:13:01 INFO - Type: GPU 02:13:01 INFO - Bus: Built-In 02:13:01 INFO - VRAM (Dynamic, Max): 1536 MB 02:13:01 INFO - Vendor: Intel (0x8086) 02:13:01 INFO - Device ID: 0x0a2e 02:13:01 INFO - Revision ID: 0x0009 02:13:01 INFO - Displays: 02:13:01 INFO - Display: 02:13:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:13:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:13:01 INFO - Display Serial Number: 1600x1200 60 02:13:01 INFO - Main Display: Yes 02:13:01 INFO - Mirror: Off 02:13:01 INFO - Online: Yes 02:13:01 INFO - Rotation: Supported 02:13:01 INFO - Return code: 0 02:13:01 INFO - Running post-action listener: _resource_record_post_action 02:13:01 INFO - [mozharness: 2016-10-21 09:13:01.975965Z] Finished run-tests step (success) 02:13:01 INFO - Running post-run listener: _resource_record_post_run 02:13:02 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 33192960; Write bytes: 705772544; Read time: 317; Write time: 1863 02:13:02 INFO - TinderboxPrint: CPU usage
53.3% 02:13:02 INFO - TinderboxPrint: I/O read bytes / time
33,192,960 / 317 02:13:02 INFO - TinderboxPrint: I/O write bytes / time
705,772,544 / 1,863 02:13:02 INFO - TinderboxPrint: CPU idle
2,267.4 (46.7%) 02:13:02 INFO - TinderboxPrint: CPU system
969.1 (19.9%) 02:13:02 INFO - TinderboxPrint: CPU user
1,621.3 (33.4%) 02:13:02 INFO - TinderboxPrint: Swap in / out
435,613,696 / 0 02:13:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393126400; Write bytes: 388445696; Read time: 29527; Write time: 690 02:13:02 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 31677440; Write bytes: 295704064; Read time: 299; Write time: 1124 02:13:02 INFO - Running post-run listener: _upload_blobber_files 02:13:02 INFO - Blob upload gear active. 02:13:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:13:02 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 02:13:02 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:13:02 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:13:02 INFO - (blobuploader) - INFO - Open directory for files ... 02:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:03 INFO - (blobuploader) - INFO - Done attempting. 02:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:04 INFO - (blobuploader) - INFO - Done attempting. 02:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:13:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:07 INFO - (blobuploader) - INFO - Done attempting. 02:13:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:13:07 INFO - Return code: 0 02:13:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:13:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:13:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af43b6daab443800ec269a6097dbf2b792ce6fd96a53c37415f300b24c6213709ff23ba4b82cb14393cf153b96edaeb68e584f30363f4d0db70b45430cf7a2cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ecace99dfe783f96d1a0698501f524b4540946f9086c874bf39d6d66ae637aae9f37a3c6825981a33033f0fb163e0a0613e2530dd62b9ffd49a3432555a34fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e995b1e41bce8fc7c90faa9df08eef1792120c691a56f9e288a2e63135949ba1e8dfd635936ec8578303462168f9fbd6ef0d79dff303517f4caac269f600a51"} 02:13:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:13:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:13:07 INFO - Contents: 02:13:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af43b6daab443800ec269a6097dbf2b792ce6fd96a53c37415f300b24c6213709ff23ba4b82cb14393cf153b96edaeb68e584f30363f4d0db70b45430cf7a2cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ecace99dfe783f96d1a0698501f524b4540946f9086c874bf39d6d66ae637aae9f37a3c6825981a33033f0fb163e0a0613e2530dd62b9ffd49a3432555a34fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e995b1e41bce8fc7c90faa9df08eef1792120c691a56f9e288a2e63135949ba1e8dfd635936ec8578303462168f9fbd6ef0d79dff303517f4caac269f600a51"} 02:13:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:13:07 INFO - Copying logs to upload dir... 02:13:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:13:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.987506 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-21 02:13:07.640863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 02:13:07.644332) ========= 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.TQPnZkEuzF/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.dbLBccf8JV/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/Fx-Team/sha512/af43b6daab443800ec269a6097dbf2b792ce6fd96a53c37415f300b24c6213709ff23ba4b82cb14393cf153b96edaeb68e584f30363f4d0db70b45430cf7a2cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ecace99dfe783f96d1a0698501f524b4540946f9086c874bf39d6d66ae637aae9f37a3c6825981a33033f0fb163e0a0613e2530dd62b9ffd49a3432555a34fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e995b1e41bce8fc7c90faa9df08eef1792120c691a56f9e288a2e63135949ba1e8dfd635936ec8578303462168f9fbd6ef0d79dff303517f4caac269f600a51"} build_url:https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/K5ryMj6KQwSyb-mCaoR9JA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af43b6daab443800ec269a6097dbf2b792ce6fd96a53c37415f300b24c6213709ff23ba4b82cb14393cf153b96edaeb68e584f30363f4d0db70b45430cf7a2cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ecace99dfe783f96d1a0698501f524b4540946f9086c874bf39d6d66ae637aae9f37a3c6825981a33033f0fb163e0a0613e2530dd62b9ffd49a3432555a34fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e995b1e41bce8fc7c90faa9df08eef1792120c691a56f9e288a2e63135949ba1e8dfd635936ec8578303462168f9fbd6ef0d79dff303517f4caac269f600a51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 02:13:07.676183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 02:13:07.676498) ========= 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.TQPnZkEuzF/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.dbLBccf8JV/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005202 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 02:13:07.724563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 02:13:07.724875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 02:13:07.725169) ========= ========= Total master_lag: 0.16 =========