builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0281 starttime: 1479224063.27 results: success (0) buildid: 20161115060313 builduid: 849d8dca843243caa0d5767b9fc26ccf revision: bfaa16ab61ee71dd05d27e2b07244032207b5dad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.271186) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.271619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.271889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.303560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.303840) ========= 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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-15 07:34:23-- 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% 168M=0s 2016-11-15 07:34:23 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.421170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.421496) ========= 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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.024519 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:23.470103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-15 07:34:23.470455) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfaa16ab61ee71dd05d27e2b07244032207b5dad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfaa16ab61ee71dd05d27e2b07244032207b5dad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZihqnzbVbm/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.PQeN4vmXqW/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-15 07:34:23,569 truncating revision to first 12 chars 2016-11-15 07:34:23,569 Setting DEBUG logging. 2016-11-15 07:34:23,569 attempt 1/10 2016-11-15 07:34:23,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfaa16ab61ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 07:34:25,444 unpacking tar archive at: mozilla-aurora-bfaa16ab61ee/testing/mozharness/ program finished with exit code 0 elapsedTime=2.138976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-15 07:34:25.631070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:25.631429) ========= script_repo_revision: bfaa16ab61ee71dd05d27e2b07244032207b5dad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:25.631836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:25.632122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:25.650198) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-15 07:34:25.650575) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZihqnzbVbm/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.PQeN4vmXqW/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:34:25 INFO - MultiFileLogger online at 20161115 07:34:25 in /builds/slave/test 07:34:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:34:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:25 INFO - {'append_to_log': False, 07:34:25 INFO - 'base_work_dir': '/builds/slave/test', 07:34:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:34:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:25 INFO - 'branch': 'Mozilla-Aurora', 07:34:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:25 INFO - 'config_files': ('talos/mac_config.py',), 07:34:25 INFO - 'default_actions': ('clobber', 07:34:25 INFO - 'read-buildbot-config', 07:34:25 INFO - 'download-and-extract', 07:34:25 INFO - 'populate-webroot', 07:34:25 INFO - 'create-virtualenv', 07:34:25 INFO - 'install', 07:34:25 INFO - 'run-tests'), 07:34:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:25 INFO - 'download_minidump_stackwalk': True, 07:34:25 INFO - 'download_symbols': 'ondemand', 07:34:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:25 INFO - 'installer_path': 'installer.exe', 07:34:25 INFO - 'log_level': 'info', 07:34:25 INFO - 'log_name': 'talos', 07:34:25 INFO - 'log_to_console': True, 07:34:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:34:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:34:25 INFO - 'opt_config_files': (), 07:34:25 INFO - 'pip_index': False, 07:34:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:25 INFO - 'cmd': ('bash', 07:34:25 INFO - '-c', 07:34:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:25 INFO - 'enabled': True, 07:34:25 INFO - 'halt_on_failure': False, 07:34:25 INFO - 'name': 'check_screen_resolution'},), 07:34:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:25 INFO - 'cmd': ('bash', 07:34:25 INFO - '-c', 07:34:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:25 INFO - 'enabled': True, 07:34:25 INFO - 'halt_on_failure': False, 07:34:25 INFO - 'name': 'check_screen_resolution'},), 07:34:25 INFO - 'run_cmd_checks_enabled': True, 07:34:25 INFO - 'sps_profile': False, 07:34:25 INFO - 'sps_profile_interval': 0, 07:34:25 INFO - 'suite': 'dromaeojs', 07:34:25 INFO - 'system_bits': '32', 07:34:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:25 INFO - 'title': 't-yosemite-r7-0281', 07:34:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:25 INFO - 'use_talos_json': True, 07:34:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:25 INFO - 'work_dir': 'build'} 07:34:25 INFO - [mozharness: 2016-11-15 15:34:25.851045Z] Running clobber step. 07:34:25 INFO - Running pre-action listener: _resource_record_pre_action 07:34:25 INFO - Running main action method: clobber 07:34:25 INFO - rmtree: /builds/slave/test/build 07:34:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:28 INFO - Running post-action listener: _resource_record_post_action 07:34:28 INFO - [mozharness: 2016-11-15 15:34:28.238899Z] Finished clobber step (success) 07:34:28 INFO - [mozharness: 2016-11-15 15:34:28.239120Z] Running read-buildbot-config step. 07:34:28 INFO - Running pre-action listener: _resource_record_pre_action 07:34:28 INFO - Running main action method: read_buildbot_config 07:34:28 INFO - Using buildbot properties: 07:34:28 INFO - { 07:34:28 INFO - "project": "", 07:34:28 INFO - "product": "firefox", 07:34:28 INFO - "script_repo_revision": "production", 07:34:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:34:28 INFO - "repository": "", 07:34:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:34:28 INFO - "buildid": "20161115060313", 07:34:28 INFO - "pgo_build": "False", 07:34:28 INFO - "basedir": "/builds/slave/test", 07:34:28 INFO - "buildnumber": 92, 07:34:28 INFO - "slavename": "t-yosemite-r7-0281", 07:34:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:34:28 INFO - "platform": "yosemite_r7", 07:34:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:34:28 INFO - "branch": "mozilla-aurora", 07:34:28 INFO - "repo_path": "releases/mozilla-aurora", 07:34:28 INFO - "revision": "bfaa16ab61ee71dd05d27e2b07244032207b5dad", 07:34:28 INFO - "stage_platform": "macosx64", 07:34:28 INFO - "builduid": "849d8dca843243caa0d5767b9fc26ccf", 07:34:28 INFO - "slavebuilddir": "test" 07:34:28 INFO - } 07:34:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:34:28 INFO - Running post-action listener: _resource_record_post_action 07:34:28 INFO - [mozharness: 2016-11-15 15:34:28.244838Z] Finished read-buildbot-config step (success) 07:34:28 INFO - [mozharness: 2016-11-15 15:34:28.245048Z] Running download-and-extract step. 07:34:28 INFO - Running pre-action listener: _resource_record_pre_action 07:34:28 INFO - Running main action method: download_and_extract 07:34:28 INFO - mkdir: /builds/slave/test/build/tests 07:34:28 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')]} 07:34:28 INFO - trying https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:34:28 INFO - Downloading https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:34:29 INFO - Downloaded 1199 bytes. 07:34:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:34:29 INFO - Using the following test package requirements: 07:34:29 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:34:29 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:34:29 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:34:29 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'jsshell-mac.zip'], 07:34:29 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:34:29 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:34:29 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:34:29 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:34:29 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:34:29 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:29 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:34:29 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:34:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:34:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:34:29 INFO - Fetch https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:34:30 INFO - Http code: 200 07:34:30 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 07:34:30 INFO - x-amz-cf-id: KpZtNo1OesVN1MdbwULIimf-25E6vb6_QZ2v4nDhG9cwh7MBQRTe-w== 07:34:30 INFO - x-amz-version-id: _LfC4jQ8MhQSCUNer9mGEhmcxvumGCI0 07:34:30 INFO - Expected file size: 16327393 07:34:30 INFO - Obtained file size: 16327393 07:34:37 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:34:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:34:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:34:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:34:37 INFO - Http code: 200 07:34:37 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 07:34:37 INFO - x-amz-cf-id: kVMOJAjBklbpsxgFRuCL1aSpOt7gfhQnL3BjzJ00OUXhhxrM2Sc6Lg== 07:34:37 INFO - x-amz-version-id: _LfC4jQ8MhQSCUNer9mGEhmcxvumGCI0 07:34:37 INFO - Expected file size: 16327393 07:34:37 INFO - Obtained file size: 16327393 07:34:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:34:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:34:44 INFO - Fetch https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:34:44 INFO - Http code: 200 07:34:44 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 07:34:44 INFO - x-amz-cf-id: WYKETPl71OwqJzXe60Xs69D3pawsEN9bK8x6UxHK9A3OylmRkDrGPw== 07:34:44 INFO - x-amz-version-id: q5H6DwfA1PUKplTHCgJxJugsrLD2oB3b 07:34:45 INFO - Expected file size: 14409038 07:34:45 INFO - Obtained file size: 14409038 07:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:45 INFO - trying https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:34:48 INFO - Downloaded 114362300 bytes. 07:34:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:34:48 INFO - mkdir: /builds/slave/test/properties 07:34:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:48 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:48 INFO - Contents: 07:34:48 INFO - build_url:https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:34:49 INFO - Running post-action listener: _resource_record_post_action 07:34:49 INFO - Running post-action listener: set_extra_try_arguments 07:34:49 INFO - [mozharness: 2016-11-15 15:34:49.195119Z] Finished download-and-extract step (success) 07:34:49 INFO - [mozharness: 2016-11-15 15:34:49.195277Z] Running populate-webroot step. 07:34:49 INFO - Running pre-action listener: _resource_record_pre_action 07:34:49 INFO - Running main action method: populate_webroot 07:34:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:49 INFO - '--tppagecycles', 07:34:49 INFO - '7'], 07:34:49 INFO - 'tests': ['tsvgm']}}, 07:34:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['damp', 'tps']}, 07:34:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'tests': ['damp', 'tps']}, 07:34:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['dromaeo_dom']}, 07:34:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['basic_compositor_video']}, 07:34:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['a11yr', 07:34:49 INFO - 'ts_paint', 07:34:49 INFO - 'tpaint', 07:34:49 INFO - 'sessionrestore', 07:34:49 INFO - 'sessionrestore_no_auto_restore', 07:34:49 INFO - 'tabpaint']}, 07:34:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:49 INFO - 'ts_paint', 07:34:49 INFO - 'tpaint', 07:34:49 INFO - 'sessionrestore', 07:34:49 INFO - 'sessionrestore_no_auto_restore', 07:34:49 INFO - 'tabpaint']}, 07:34:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:49 INFO - 'ts_paint', 07:34:49 INFO - 'tpaint', 07:34:49 INFO - 'sessionrestore', 07:34:49 INFO - 'sessionrestore_no_auto_restore', 07:34:49 INFO - 'tabpaint']}, 07:34:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:49 INFO - 'ts_paint', 07:34:49 INFO - 'tpaint', 07:34:49 INFO - 'sessionrestore', 07:34:49 INFO - 'sessionrestore_no_auto_restore', 07:34:49 INFO - 'tabpaint']}, 07:34:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['a11yr', 07:34:49 INFO - 'ts_paint', 07:34:49 INFO - 'tpaint', 07:34:49 INFO - 'sessionrestore', 07:34:49 INFO - 'sessionrestore_no_auto_restore', 07:34:49 INFO - 'tabpaint']}, 07:34:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['a11yr', 07:34:49 INFO - 'ts_paint', 07:34:49 INFO - 'tpaint', 07:34:49 INFO - 'sessionrestore', 07:34:49 INFO - 'sessionrestore_no_auto_restore', 07:34:49 INFO - 'tabpaint']}, 07:34:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['tsvgx', 07:34:49 INFO - 'tsvgr_opacity', 07:34:49 INFO - 'tart', 07:34:49 INFO - 'tscrollx', 07:34:49 INFO - 'cart']}, 07:34:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:49 INFO - 'tsvgr_opacity', 07:34:49 INFO - 'tart', 07:34:49 INFO - 'tscrollx', 07:34:49 INFO - 'cart']}, 07:34:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'talos_options': ['--disable-e10s'], 07:34:49 INFO - 'tests': ['tp5o']}, 07:34:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'tests': ['tp5o']}, 07:34:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'talos_options': ['--disable-e10s', 07:34:49 INFO - '--xperf_path', 07:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:49 INFO - 'tests': ['tp5n']}, 07:34:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:49 INFO - 'talos_options': ['--xperf_path', 07:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:49 INFO - 'tests': ['tp5n']}}, 07:34:49 INFO - 'talos.zip': {'path': '', 07:34:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:49 INFO - Running post-action listener: _resource_record_post_action 07:34:49 INFO - [mozharness: 2016-11-15 15:34:49.213947Z] Finished populate-webroot step (success) 07:34:49 INFO - [mozharness: 2016-11-15 15:34:49.214059Z] Running create-virtualenv step. 07:34:49 INFO - Running pre-action listener: _resource_record_pre_action 07:34:49 INFO - Running main action method: create_virtualenv 07:34:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:49 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 07:34:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:49 INFO - Using real prefix '/tools/python27' 07:34:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:52 INFO - Installing pip.................done. 07:34:52 INFO - Return code: 0 07:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:34:53 INFO - Reading from file tmpfile_stdout 07:34:53 INFO - Output received: 07:34:53 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) 07:34:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:53 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:34:53 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 07:34:53 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 07:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:53 INFO - 'HOME': '/Users/cltbld', 07:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:53 INFO - 'LOGNAME': 'cltbld', 07:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:53 INFO - 'MOZ_NO_REMOTE': '1', 07:34:53 INFO - 'NO_EM_RESTART': '1', 07:34:53 INFO - 'PAGER': '/bin/cat', 07:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:53 INFO - 'PWD': '/builds/slave/test', 07:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:53 INFO - 'SHELL': '/bin/bash', 07:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:34:53 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:53 INFO - 'USER': 'cltbld', 07:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:53 INFO - 'XPC_FLAGS': '0x0', 07:34:53 INFO - 'XPC_SERVICE_NAME': '0', 07:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:53 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 07:34:53 INFO - Cleaning up... 07:34:53 INFO - Return code: 0 07:34:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:53 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:34:53 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 07:34:53 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 07:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:53 INFO - 'HOME': '/Users/cltbld', 07:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:53 INFO - 'LOGNAME': 'cltbld', 07:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:53 INFO - 'MOZ_NO_REMOTE': '1', 07:34:53 INFO - 'NO_EM_RESTART': '1', 07:34:53 INFO - 'PAGER': '/bin/cat', 07:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:53 INFO - 'PWD': '/builds/slave/test', 07:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:53 INFO - 'SHELL': '/bin/bash', 07:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:34:53 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:53 INFO - 'USER': 'cltbld', 07:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:53 INFO - 'XPC_FLAGS': '0x0', 07:34:53 INFO - 'XPC_SERVICE_NAME': '0', 07:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:53 INFO - Downloading/unpacking psutil>=3.1.1 07:34:53 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 07:34:53 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 07:34:53 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 07:34:53 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 07:34:53 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 07:34:53 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 07:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:57 INFO - Installing collected packages: psutil 07:34:57 INFO - Running setup.py install for psutil 07:34:57 INFO - building 'psutil._psutil_osx' extension 07:34:57 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 07:34:57 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 07:34:58 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 07:34:58 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 07:34:58 INFO - building 'psutil._psutil_posix' extension 07:34:58 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 07:34:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:58 INFO - ^ 07:34:58 INFO - 1 warning generated. 07:34:58 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 07:34:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:58 INFO - Successfully installed psutil 07:34:58 INFO - Cleaning up... 07:34:58 INFO - Return code: 0 07:34:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34:58 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')]} 07:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:58 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')]} 07:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:58 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:34:58 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 07:34:58 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 07:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:58 INFO - 'HOME': '/Users/cltbld', 07:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:58 INFO - 'LOGNAME': 'cltbld', 07:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:58 INFO - 'MOZ_NO_REMOTE': '1', 07:34:58 INFO - 'NO_EM_RESTART': '1', 07:34:58 INFO - 'PAGER': '/bin/cat', 07:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:58 INFO - 'PWD': '/builds/slave/test', 07:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:58 INFO - 'SHELL': '/bin/bash', 07:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:34:58 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:58 INFO - 'USER': 'cltbld', 07:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:58 INFO - 'XPC_FLAGS': '0x0', 07:34:58 INFO - 'XPC_SERVICE_NAME': '0', 07:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:58 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 07:34:58 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 07:34:58 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 07:34:58 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 07:34:58 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 07:34:58 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 07:35:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:01 INFO - Installing collected packages: mozsystemmonitor 07:35:01 INFO - Running setup.py install for mozsystemmonitor 07:35:01 INFO - Successfully installed mozsystemmonitor 07:35:01 INFO - Cleaning up... 07:35:01 INFO - Return code: 0 07:35:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:01 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')]} 07:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:01 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')]} 07:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:01 INFO - 'HOME': '/Users/cltbld', 07:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:01 INFO - 'LOGNAME': 'cltbld', 07:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:01 INFO - 'MOZ_NO_REMOTE': '1', 07:35:01 INFO - 'NO_EM_RESTART': '1', 07:35:01 INFO - 'PAGER': '/bin/cat', 07:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:01 INFO - 'PWD': '/builds/slave/test', 07:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:01 INFO - 'SHELL': '/bin/bash', 07:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:01 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:01 INFO - 'USER': 'cltbld', 07:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:01 INFO - 'XPC_FLAGS': '0x0', 07:35:01 INFO - 'XPC_SERVICE_NAME': '0', 07:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:01 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:01 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 07:35:01 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 07:35:01 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 07:35:01 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 07:35:01 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 07:35:01 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 07:35:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:04 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 07:35:04 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 07:35:04 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 07:35:04 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 07:35:04 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 07:35:04 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 07:35:04 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:04 INFO - warning: no files found matching '*.txt' 07:35:04 INFO - no previously-included directories found matching 'build' 07:35:04 INFO - no previously-included directories found matching 'dist' 07:35:04 INFO - no previously-included directories found matching '.git*' 07:35:04 INFO - Installing collected packages: jsonschema, functools32 07:35:04 INFO - Running setup.py install for functools32 07:35:04 INFO - warning: no files found matching '*.txt' 07:35:04 INFO - no previously-included directories found matching 'build' 07:35:04 INFO - no previously-included directories found matching 'dist' 07:35:04 INFO - no previously-included directories found matching '.git*' 07:35:04 INFO - Successfully installed jsonschema functools32 07:35:04 INFO - Cleaning up... 07:35:05 INFO - Return code: 0 07:35:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:05 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:05 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 07:35:05 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 07:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:05 INFO - 'HOME': '/Users/cltbld', 07:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:05 INFO - 'LOGNAME': 'cltbld', 07:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:05 INFO - 'MOZ_NO_REMOTE': '1', 07:35:05 INFO - 'NO_EM_RESTART': '1', 07:35:05 INFO - 'PAGER': '/bin/cat', 07:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:05 INFO - 'PWD': '/builds/slave/test', 07:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:05 INFO - 'SHELL': '/bin/bash', 07:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:05 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:05 INFO - 'USER': 'cltbld', 07:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:05 INFO - 'XPC_FLAGS': '0x0', 07:35:05 INFO - 'XPC_SERVICE_NAME': '0', 07:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:05 INFO - Cleaning up... 07:35:05 INFO - Return code: 0 07:35:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:05 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:05 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 07:35:05 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 07:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:05 INFO - 'HOME': '/Users/cltbld', 07:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:05 INFO - 'LOGNAME': 'cltbld', 07:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:05 INFO - 'MOZ_NO_REMOTE': '1', 07:35:05 INFO - 'NO_EM_RESTART': '1', 07:35:05 INFO - 'PAGER': '/bin/cat', 07:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:05 INFO - 'PWD': '/builds/slave/test', 07:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:05 INFO - 'SHELL': '/bin/bash', 07:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:05 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:05 INFO - 'USER': 'cltbld', 07:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:05 INFO - 'XPC_FLAGS': '0x0', 07:35:05 INFO - 'XPC_SERVICE_NAME': '0', 07:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:05 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:05 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 07:35:05 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 07:35:05 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 07:35:05 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 07:35:05 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 07:35:05 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 07:35:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 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 07:35:08 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 07:35:09 INFO - Downloading docopt-0.6.1.tar.gz 07:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:09 INFO - Running setup.py install for blobuploader 07:35:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:09 INFO - Running setup.py install for requests 07:35:10 INFO - Running setup.py install for docopt 07:35:10 INFO - Successfully installed blobuploader requests docopt 07:35:10 INFO - Cleaning up... 07:35:10 INFO - Return code: 0 07:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:10 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')]} 07:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:10 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')]} 07:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:10 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:10 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 07:35:10 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 07:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:10 INFO - 'HOME': '/Users/cltbld', 07:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:10 INFO - 'LOGNAME': 'cltbld', 07:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:10 INFO - 'MOZ_NO_REMOTE': '1', 07:35:10 INFO - 'NO_EM_RESTART': '1', 07:35:10 INFO - 'PAGER': '/bin/cat', 07:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:10 INFO - 'PWD': '/builds/slave/test', 07:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:10 INFO - 'SHELL': '/bin/bash', 07:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:10 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:10 INFO - 'USER': 'cltbld', 07:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:10 INFO - 'XPC_FLAGS': '0x0', 07:35:10 INFO - 'XPC_SERVICE_NAME': '0', 07:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:10 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-VSwbgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:10 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Af_0AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:10 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-rX3hgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:10 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-wRW8yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-rEfYju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-7kw8UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-jt0YCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-8g39IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ET2uiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-BhlfEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Ub81bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-xufEOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-uB0yXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-4meGco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-_BJL1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-CLdqpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-S4zFA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:12 INFO - Running setup.py install for manifestparser 07:35:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Running setup.py install for mozcrash 07:35:12 INFO - Running setup.py install for mozdebug 07:35:12 INFO - Running setup.py install for mozdevice 07:35:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Running setup.py install for mozfile 07:35:13 INFO - Running setup.py install for mozhttpd 07:35:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Running setup.py install for mozinfo 07:35:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Running setup.py install for mozInstall 07:35:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Running setup.py install for mozleak 07:35:13 INFO - Running setup.py install for mozlog 07:35:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Running setup.py install for moznetwork 07:35:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:14 INFO - Running setup.py install for mozprocess 07:35:14 INFO - Running setup.py install for mozprofile 07:35:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:14 INFO - Running setup.py install for mozrunner 07:35:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:14 INFO - Running setup.py install for mozscreenshot 07:35:14 INFO - Running setup.py install for moztest 07:35:14 INFO - Running setup.py install for mozversion 07:35:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:14 INFO - Cleaning up... 07:35:14 INFO - Return code: 0 07:35:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:14 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:14 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 07:35:14 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 07:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:14 INFO - 'HOME': '/Users/cltbld', 07:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:14 INFO - 'LOGNAME': 'cltbld', 07:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:14 INFO - 'MOZ_NO_REMOTE': '1', 07:35:14 INFO - 'NO_EM_RESTART': '1', 07:35:14 INFO - 'PAGER': '/bin/cat', 07:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:14 INFO - 'PWD': '/builds/slave/test', 07:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:14 INFO - 'SHELL': '/bin/bash', 07:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:14 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:14 INFO - 'USER': 'cltbld', 07:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:14 INFO - 'XPC_FLAGS': '0x0', 07:35:14 INFO - 'XPC_SERVICE_NAME': '0', 07:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-6cC9Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-T0PGIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-MSMZnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-D8LaiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-juZjps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Ka7olP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-mDEvWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-G_H57W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-bPba0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-c_RDrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zVp9Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-gVC8nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Iy9R3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-hXLfo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-AhHAx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-kBQgrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:16 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)) 07:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:16 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-gcrbzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:17 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)) 07:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:17 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)) 07:35:17 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)) 07:35:17 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)) 07:35:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:19 INFO - Downloading blessings-1.6.tar.gz 07:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:19 INFO - Installing collected packages: blessings 07:35:19 INFO - Running setup.py install for blessings 07:35:19 INFO - Successfully installed blessings 07:35:19 INFO - Cleaning up... 07:35:19 INFO - Return code: 0 07:35:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:20 INFO - Reading from file tmpfile_stdout 07:35:20 INFO - Current package versions: 07:35:20 INFO - blessings == 1.6 07:35:20 INFO - blobuploader == 1.2.4 07:35:20 INFO - docopt == 0.6.1 07:35:20 INFO - functools32 == 3.2.3-2 07:35:20 INFO - jsonschema == 2.5.1 07:35:20 INFO - manifestparser == 1.1 07:35:20 INFO - mozInstall == 1.12 07:35:20 INFO - mozcrash == 1.0 07:35:20 INFO - mozdebug == 0.1 07:35:20 INFO - mozdevice == 0.48 07:35:20 INFO - mozfile == 1.2 07:35:20 INFO - mozhttpd == 0.7 07:35:20 INFO - mozinfo == 0.9 07:35:20 INFO - mozleak == 0.1 07:35:20 INFO - mozlog == 3.4 07:35:20 INFO - moznetwork == 0.27 07:35:20 INFO - mozprocess == 0.23 07:35:20 INFO - mozprofile == 0.28 07:35:20 INFO - mozrunner == 6.13 07:35:20 INFO - mozscreenshot == 0.1 07:35:20 INFO - mozsystemmonitor == 0.3 07:35:20 INFO - moztest == 0.7 07:35:20 INFO - mozversion == 1.4 07:35:20 INFO - psutil == 3.1.1 07:35:20 INFO - requests == 1.2.3 07:35:20 INFO - wsgiref == 0.1.2 07:35:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:21 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 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:21 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 07:35:21 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 07:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:21 INFO - 'HOME': '/Users/cltbld', 07:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:21 INFO - 'LOGNAME': 'cltbld', 07:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:21 INFO - 'MOZ_NO_REMOTE': '1', 07:35:21 INFO - 'NO_EM_RESTART': '1', 07:35:21 INFO - 'PAGER': '/bin/cat', 07:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:21 INFO - 'PWD': '/builds/slave/test', 07:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:21 INFO - 'SHELL': '/bin/bash', 07:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:21 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:21 INFO - 'USER': 'cltbld', 07:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:21 INFO - 'XPC_FLAGS': '0x0', 07:35:21 INFO - 'XPC_SERVICE_NAME': '0', 07:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 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)) 07:35:21 INFO - Cleaning up... 07:35:21 INFO - Return code: 0 07:35:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10deae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df05bc940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, '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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 07:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:21 INFO - 'HOME': '/Users/cltbld', 07:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:21 INFO - 'LOGNAME': 'cltbld', 07:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:21 INFO - 'MOZ_NO_REMOTE': '1', 07:35:21 INFO - 'NO_EM_RESTART': '1', 07:35:21 INFO - 'PAGER': '/bin/cat', 07:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:21 INFO - 'PWD': '/builds/slave/test', 07:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:21 INFO - 'SHELL': '/bin/bash', 07:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:21 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:21 INFO - 'USER': 'cltbld', 07:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:21 INFO - 'XPC_FLAGS': '0x0', 07:35:21 INFO - 'XPC_SERVICE_NAME': '0', 07:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:21 INFO - Cleaning up... 07:35:21 INFO - Return code: 0 07:35:21 INFO - Running post-action listener: _resource_record_post_action 07:35:21 INFO - Running post-action listener: _start_resource_monitoring 07:35:21 INFO - Starting resource monitoring. 07:35:21 INFO - [mozharness: 2016-11-15 15:35:21.975092Z] Finished create-virtualenv step (success) 07:35:21 INFO - [mozharness: 2016-11-15 15:35:21.976132Z] Running install step. 07:35:21 INFO - Running pre-action listener: _resource_record_pre_action 07:35:21 INFO - Running main action method: install 07:35:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:22 INFO - Reading from file tmpfile_stdout 07:35:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:22 INFO - Reading from file tmpfile_stdout 07:35:22 INFO - Output received: 07:35:22 INFO - Usage: mozinstall [options] installer 07:35:22 INFO - Options: 07:35:22 INFO - -h, --help show this help message and exit 07:35:22 INFO - -d DEST, --destination=DEST 07:35:22 INFO - Directory to install application into. [default: 07:35:22 INFO - "/builds/slave/test"] 07:35:22 INFO - --app=APP Application being installed. [default: firefox] 07:35:22 INFO - mkdir: /builds/slave/test/build/application 07:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:35:54 INFO - Reading from file tmpfile_stdout 07:35:54 INFO - Output received: 07:35:54 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:35:54 INFO - Running post-action listener: _resource_record_post_action 07:35:54 INFO - [mozharness: 2016-11-15 15:35:54.430756Z] Finished install step (success) 07:35:54 INFO - [mozharness: 2016-11-15 15:35:54.430895Z] Running run-tests step. 07:35:54 INFO - Running pre-action listener: _resource_record_pre_action 07:35:54 INFO - Running main action method: run_tests 07:35:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:54 INFO - 2016-11-15 07:35:54.445 screenresolution[1630:7421] starting screenresolution argv=screenresolution get 07:35:54 INFO - 2016-11-15 07:35:54.448 screenresolution[1630:7421] Display 0: 1600x1200x32@60 07:35:54 INFO - 2016-11-15 07:35:54.453 screenresolution[1631:7424] starting screenresolution argv=screenresolution list 07:35:54 INFO - Available Modes on Display 0 07:35:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:54 INFO - Intel Iris: 07:35:54 INFO - Chipset Model: Intel Iris 07:35:54 INFO - Type: GPU 07:35:54 INFO - Bus: Built-In 07:35:54 INFO - VRAM (Dynamic, Max): 1536 MB 07:35:54 INFO - Vendor: Intel (0x8086) 07:35:54 INFO - Device ID: 0x0a2e 07:35:54 INFO - Revision ID: 0x0009 07:35:54 INFO - Displays: 07:35:54 INFO - Display: 07:35:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:54 INFO - Display Serial Number: 1600x1200 60 07:35:54 INFO - Main Display: Yes 07:35:54 INFO - Mirror: Off 07:35:54 INFO - Online: Yes 07:35:54 INFO - Rotation: Supported 07:35:54 INFO - Return code: 0 07:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:54 INFO - Python 2.7.3 07:35:54 INFO - Return code: 0 07:35:54 INFO - grabbing minidump binary from tooltool 07:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:54 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 0x10dd4cd30>, '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 0x10dbb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd44b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:54 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 07:35:54 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 07:35:54 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 07:35:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:54 INFO - Return code: 0 07:35:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 07:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 07:35:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZihqnzbVbm/Render', 07:35:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:54 INFO - 'HOME': '/Users/cltbld', 07:35:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:54 INFO - 'LOGNAME': 'cltbld', 07:35:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:54 INFO - 'MOZ_NO_REMOTE': '1', 07:35:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:54 INFO - 'NO_EM_RESTART': '1', 07:35:54 INFO - 'PAGER': '/bin/cat', 07:35:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:54 INFO - 'PWD': '/builds/slave/test', 07:35:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:54 INFO - 'SHELL': '/bin/bash', 07:35:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQeN4vmXqW/Listeners', 07:35:54 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 07:35:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:54 INFO - 'USER': 'cltbld', 07:35:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:54 INFO - 'XPC_FLAGS': '0x0', 07:35:54 INFO - 'XPC_SERVICE_NAME': '0', 07:35:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 07:35:55 INFO - mozversion application_buildid: 20161115060313 07:35:55 INFO - mozversion application_changeset: bfaa16ab61ee71dd05d27e2b07244032207b5dad 07:35:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:35:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:55 INFO - mozversion application_name: Firefox 07:35:55 INFO - mozversion application_remotingname: firefox-dev 07:35:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:35:55 INFO - mozversion application_vendor: Mozilla 07:35:55 INFO - mozversion application_version: 52.0a2 07:35:55 INFO - mozversion platform_buildid: 20161115060313 07:35:55 INFO - mozversion platform_changeset: bfaa16ab61ee71dd05d27e2b07244032207b5dad 07:35:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:35:55 INFO - mozversion platform_version: 52.0a2 07:35:55 INFO - using testdate: 1479224155 07:35:55 INFO - actual date: 1479224155 07:35:55 INFO - starting webserver on 'localhost:49236' 07:35:55 INFO - SUITE-START | Running 2 tests 07:35:55 INFO - TEST-START | dromaeo_css 07:35:55 INFO - operating with platform_type : mac_ 07:35:55 INFO - Initialising browser for dromaeo_css test... 07:35:55 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpcgJqci/profile http://localhost:49236/getInfo.html) 07:35:56 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 07:35:57 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 07:35:57 INFO - PROCESS | 1641 | colorDepth:24 07:35:57 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 07:35:57 INFO - PROCESS | 1641 | __metrics 07:35:57 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:57 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:58 INFO - TEST-INFO | 1641: exit 0 07:35:58 INFO - Browser initialized. 07:35:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:58 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpcgJqci/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:10 INFO - PROCESS | 1643 | RSS: Main: 217686016 07:36:10 INFO - PROCESS | 1643 | 07:37:01 INFO - PROCESS | 1643 | 1479224221377 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] 07:39:15 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 07:39:18 INFO - PROCESS | 1643 | RSS: Main: 430493696 07:39:18 INFO - PROCESS | 1643 | 07:42:21 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 07:42:21 INFO - PROCESS | 1643 | RSS: Main: 353513472 07:42:21 INFO - PROCESS | 1643 | 07:45:24 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 07:45:24 INFO - PROCESS | 1643 | RSS: Main: 334065664 07:45:24 INFO - PROCESS | 1643 | 07:48:27 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 07:48:27 INFO - PROCESS | 1643 | RSS: Main: 332062720 07:48:27 INFO - PROCESS | 1643 | 07:51:31 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 07:51:31 INFO - PROCESS | 1643 | RSS: Main: 317341696 07:51:31 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 07:54:35 INFO - PROCESS | 1643 | RSS: Main: 400617472 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | __start_tp_report 07:54:35 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 07:54:35 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 07:54:35 INFO - PROCESS | 1643 | |i|pagename|runs| 07:54:35 INFO - PROCESS | 1643 | |0;dojo.html;3247.5778148840645;3332.4334863073277;3345.180430794456;3348.6316505184427;3396.5075064115704;4287;5665.943340566593;5724.484796368326;5731.369549349568;5764;5674.290713660793;5756.625819321741;5758.568107391941;5783.913241301373;5814.331351894522;4363;4715.929261061086;5233.162693968966;5292.259083728281;5380.677159370451;5189.143791274435;5199.558037566811;5204.3234379530795;5257.158854583248;5277.656952298107;5268.604854635918;5278.683279003253;5279.894402111955;5286.154215325549;5286.4449232830575;4508.571685689854;5148.897022059537;5283.603729720267;5287.947120528784;5298;5166.638335316529;5206.7917283309;5217.869553261161;5227.085260079509;5233.9738301308635;5756.510696590794;5758.165066065439;5762.74067666956;5762.855928601776;5794.942050579524;5154.252633368141;6118.893302669174;6154.046122850965;6157.938420615781;6165.784197553109;6241.531885108635;6264.467520260738;6265.7493700251935;6320.209973753281;6323.52573556985;5762.884742305172;5767.913481297784;5824.30108386992;5845.824625261249;5872.265966754156;6219.346968568326;6312.242530896322;6343.048542718537;6345.079963405326;6366.236051673829;6050.757969681252;6067.7269522871575;6088.4824789893355;6126.846828829226;6144.784932527429;6195.659238741822;6256.217972753406;6335.366463353628;6345.682715864188;6346.873062538816;6049.032154855202;6259.0924315973925;6261.342559031327;6266.404691554386;6273.341299163613;6125.632462052291;6126.639818174636;6153.938460615426;6208.068789681493;6229.314775374705;4918.040982008474;4930;4931.408231012301;4932.950670493249;4948.579370753454;4366.214081465303;4390.978045109818;4427.601515863587;4437.9570800861775;4464.732116073046;5710.172025056427;5758.654480731169;5761.625494342854;5833.241678581757;5837.503812175928;6313.842153946188;6349.428551430301;6352.7776527822225;6364.331745166784;6374.043893416025;5879.176915231871;5883.14694369314;5886.205362276038;5890.322612899486;5925.022371308772;5268.262443257947;5320.654157479828;5392.056390131711;5420.783168673288;5432.239486471897;5324.227986941949;6248.750049998131;6274.749010039547;6293.527985401021;6307.96846015767;6337.746490140343;6340.461060809883;6340.682965851597;6341.270753863365;6349.9682501587195;6200.81397558074;6275.717592708431;6298.464630506458;6316.873662526816;6318.526110541819;6023.939760602338;6108.17539632144;6118.755249789959;6129.664444256008;6143.784967526115;5233.241180028951;6062.333143354315;6339.619622822645;6343.714532845941;6366.522510811615;6078.908816367846;6127.172831667668;6139.3553676863285;6151.907721384094;6158.291796443287;5931.525477961839;5989.251343582052;6008.819735407945;6081.087836824335;6138.815835524942;5894.882102358015;5901.675407852437;5912.083627037816;5915.260592425947;5915.497182739343;6045.969770151121;6067.180930574493;6070.453659170519;6090.634561926298;6116.548817443993;5996.400359963969;6006.729697163725;6011.158437818796;6025.397460253939;6061.9393806063135 07:54:35 INFO - PROCESS | 1643 | |1;ext.html;458.44070234314137;468.31859644217667;523.0872128136401;524.5750941737195;536.0859734153266;28919.999999999975;30524;32717.83641081797;34231;41511.16977660445;39739.40390894132;40223.59776402235;40429.191416171656;40441.797791011006;40454.59545404545;9189.540522973857;9346.859797103014;9353.392029518094;9353.438793672367;9359.6724114656;9246.630134794601;9252.6298948042;9366.672166474174;9380.530973451334;9397.107274808917;9311.95344023279;9386.90613093867;9395.62417503299;9396.15434610885;9410.2471802256;9323.906760932405;9348.532573371303;9349.158575728148;9359.01730318317;9366.53167341637;9216.769580760467;9278.814423711488;9294.86057709135;9301.674441394518;9308.674196403093;37500.06249843749;37960.81019594884;38019.04952376213;38393.61606383928;38620.64827731016;3110.4090222857585;3277.950830737541;3284.310294838087;3328.900132996014;3332.100332910125;27329.590056149173;28204.153875383567;28732.569011464846;29131.271718207;29469.115926522238;2700.702922678504;3104.099811054791;3136.231623252295;3146.5122905949615;3193.6327322357993;471237;474336.99999999657;474945;474972;475173;32154.678453215638;55287;55675.44324556783;55692.72153639206;55755.442445575834;32653.51019734706;33659.831700841336;34031.489527657104;34079.46642401098;34080.829595851865;14054.297285135703;14108.153510789385;14184.290785460686;14195.432182712782;14198.864090872705;12007.699807504881;12103;12103.939480302543;12113.030957523377;12122.69693257658;6408.839779005562;7627.466077374531;7709.9614501927135;7724.304812566896;7737;2737.5893615957766;3140.4661207594763;3193.9361212775616;3194.9201269968435;3227.88702395415;903.2051794420868;918.8437965545739;931.2596485793811;958.0802429667597;1045.6131231444415;28740.856295718386;28925.553802208946;29101;29350.11949641514;29557.85221073924;957.7366224288377;969.2004096620317;1056.5562463765236;1097.9011888930036;1147.6270212181075;14564.563063108124;14916.403343866124;15094.922517315306;15307.15810630426;15479.5356139316;676214.6189269022;676445;678697;678818;680742;52384;52626;52657.2101418479;52686.736566316926;52693;1207.7463732616072;1255.353492951149;1325.151902782201;1362.0329566008047;1370.30799446279;28680.569791453563;29642.85178574093;29736.702632973393;30510;30519.847400762854;43716;52990;53764.462355375945;53999.92000159896;57487;621742;637673.8116309389;637707;639050;639336;34143.65856341405;34793.13017174591;36309.45535817018;40564.3915341276;41114.588854111076;36098.09754756152;43448.56551434445;44091.338629919934;44416.777916110215;44580.10839783251;36549;36704.81647591745;36747.89756307315;36787.44818827773;37573.2485350286;36711;36824.44763328606;36832.26335473329;37159.6284037167;37612.811935940146;35882.64117358793;36442;36714;36755.08112297214;37001.629983699815;30672.693273066983;32527.18682032968;32655.836720817195;32748.345033099682;32942.50586241256;24594.877025615475;24700.629490557298;24707;24792.500683790007;24970.62544061877 07:54:35 INFO - PROCESS | 1643 | |2;jquery.html;326.26264641909285;365.2840432751808;372.8750868459066;383.1895540930932;399.72419030868696;16291.918540407296;16353.487536850724;19116.044197790106;20368.777873327574;20521.692174617394;19355;19838.70241946372;20014.69977950332;20146.89926550369;20361.592768144626;5627.943720562804;5658.405867383927;5960.284765828107;5961.88076238475;5979.52163826895;5196.870078248036;5793.188953546507;5866.88266234675;5877.089051197071;5935.584509084366;5597.412271711472;5857.297124345085;5911.994960856643;5913.3199682036475;5915.319738230116;5722.79970201043;5731.942680573204;5745.1669507921115;5766.740496677618;5877.23595932526;5059.392872855244;5079.3650793650795;5147.356580427447;5153.665011774223;5171.870703232412;23951.520969580684;24611.261662150166;24767.761611919334;24832.503349933082;24994.875025624755;2236.731592208929;2360.8583484990954;2384.5588566115325;2454.361865914857;2981.2397838551246;14608.488702895347;14804.259787010606;15265.694686106215;15699.37202511898;15750.448734294245;1523.451557439321;1734.4969958711958;1777.2363974020393;1814.13828431494;1825.7078867381288;107552.4622376883;109029.45485272523;109280;109304.45347773211;110506.44746776295;10592.629257975934;10702.732431689114;11055;11553.942230288963;11730;14012.229327386887;14096.365663545164;14135.15189088658;14169.079009864327;14195.503157389441;8255.793605159919;8600.13998600135;8602.569871506525;8698.260647844878;8700.521471319138;8470.788230294293;8492.957535212408;8495.532745699045;8688.609012594448;8694.565271736514;6552.410283074546;6700.095487109178;6704.865902682017;6715.992601109872;6809.761658341934;1558.4000159938278;1675.3801093595205;1785.4643606918132;1833.1118947484113;1835.2292037344348;729.8868675355328;895.5880295064343;948.3645957208687;960.3085778239656;988.8035477072823;17270.309187632607;17965.640687186184;19763.505912352306;21706.023228954735;22015;881.7531091294447;885.818407226517;914.2092090341806;954.5990683912773;989.2548178803877;10519.064751766644;11203;11255.718607034725;11319;11340.886591134147;573884;586078;588407;609246;620021;122080;127128;128692.71307286994;129281.35359323332;129617;778.9221077892279;976.6581696406344;998.9100980911608;1013.5084484025242;1014.1227837920146;19139;19792.604147916674;19822.405327840188;19930.103145358782;20004.399868003984;51508.74245628748;51676.48323516867;52534.73732631312;53837;54703.63240919009;67897.9815302761;68091.63816723737;68494.65752671205;68623.65688171527;69027.3097269021;6355.014972679242;7322.64083528526;7374.856897180945;7518.173000969779;7758.340541054074;8960.417572857743;11257.71855703614;12013.939930300292;12392.442340094898;12489.625311240678;9696.466694331879;10516.053555180071;10611;10679.59709065454;10739.946300268448;10320.535575898952;10357.22320825926;10446.268761186644;10649.254552181274;10750.677479675622;9897.109260166619;9986.151177150025;10491.265611407129;10677.412742299248;10817.350958942488;7691.692332306869;7762.68949242024;8091.514509129471;8225.177482251727;8266.090730019572;9512.38169518979;9714.708558743248;10603;10857.022867941923;11178.10575154002 07:54:35 INFO - PROCESS | 1643 | |3;mootools.html;1298.7467443848448;1463.926803659817;1605.3097168217662;1812.2207450796168;1853.5273505256166;8153.836923261531;8584.356173287013;8586.184312490312;8589.141085891408;8589.441686290387;7498.175200727929;7764.883526747103;7780.260875216845;8122.59387030649;8336.291415229698;2272.9886350568268;2312.9421764455938;2316.5251123519724;2316.721993360799;2317.5596636638984;2272.5114100468395;2306.5732839424677;2315.8957846896847;2317.6639387288833;2321.071571371448;2279.3048120323297;2290.770922907704;2293.2317673579373;2300.5398920216026;2315.548468048731;2272.091163534583;2275.476640372707;2303.2169062518824;2304.953900921989;2306.8269879759087;2223.1885361842974;2251.0545570860277;2269.6368581027123;2269.841111122222;2290.03818396274;8285.54429506377;8485.32117430604;8489.151084891524;8513;8517.872231916526;4474.261746811805;5041.344625198737;5213.035588416155;5221.373435187764;5243.632945693803;3223.951640725391;3345.7825241359233;3595.137167079908;3599.1541987632886;3605.4591811228265;1035.927485076045;1042.8487869258915;1060.734816295926;1077.4774234496263;1083.8970297821695;10991.945040274748;11140.498677559448;11149.331040137618;11155;11212.439378030984;4516.322551617218;4555.863324100283;4764.6426518011285;4786.090642777861;4790.928136077961;9484.288678349152;9488.478133702713;9494.335396522178;9494.382865113883;9503.239740820718;5234.979179060047;5242.239875218072;5248.396434410015;5254.710990895537;5255.816046438356;4306.354046892991;4333.6046769777;4676.041411510632;4793.664443488922;4816.590589799836;3724.8137593120236;3771;3820.7898565578603;3874.2832575973534;3877.651011408987;1055.6885718712845;1214.5627574073326;1235.123062625528;1257.3650306595111;1258.1633213912828;799.9680012799423;824.2540500846743;841.3647695989611;892.6250974590688;927.2720914082548;5388.299521062237;5677.602567820296;5848.678322692208;5896.557758168069;5976.744883574411;926.8934072581604;930.1953809954341;940.3934462271933;947.7346343023964;989.1542730965065;3730.5709843367817;3806.1626442182674;3807.1053302473897;3891.9805400973382;3926.764394136361;9828.21374290055;10298.3820970742;10321.896781032094;10330.483475826179;10353.689389318333;10280.023397777199;10297.17622590191;10299.073083422378;10309.917458666881;10337.431441270803;6252.906206406908;7797.259260370256;7853.999999999885;7947.960260198662;7952.3638108951145;5590.161475778666;5597.888042239214;5760.222369979999;5798.478136967693;5816.447437493432;9179;9433.386829856312;9450.905490945277;9580.856287155837;9671.951640241754;9512.048795120432;9512.952435238056;9622.47076410804;9630.507271372948;9720.902790972283;6628.602283862983;6869.931300686929;6883.449324054164;7134.036905017963;7291.30732580404;7619.238076192337;7920.405969552191;7943.086545047162;8005.439619226599;8026.638801253841;7054.118235220598;7165.713371465083;7177.856442871009;7231.204567497676;7320.707171713072;6974.825629359104;7081.681324340314;7087.751928682472;7135.072440582899;7207.459440542085;6687.230968438497;6694.364035416627;6726.091977582963;6772.153480814898;6775.898361524482;4844.733539655212;4878.56092951636;4898.338724272177;4928.457869634266;4955.909699866023;4828.03439312146;4864.635152363658;4884.4871288515615;4989.301497790385;4994.32576602154 07:54:35 INFO - PROCESS | 1643 | |4;prototype.html;274.1884023291058;301.4513585274798;305.74928558581956;309.7212508742132;313.6753460168726;5161.5933483900635;5233.73831308435;5243.827484371957;5264;5269.578433725303;4220.683448741342;4815.807367705296;4896.4312453206885;5054.646174767759;5229.973850130754;3520.4543295789194;3599.5860476045195;3867.555231148419;3922.82347294371;3953.8220780064967;3925.979245396203;3958.44581758554;3965.8413663453425;3972.543157536877;4003.579624139467;3685.318216130011;3904.316744569703;3917.8236979335857;3936.1930804185217;3963.663088637469;3271.7055465008025;3890.1247219375696;3916.15802602439;3919.492583528936;3924.195539914325;3395.422778127724;3395.7453191010527;3406.9488957665653;3412.4028295048265;3414.641462646411;4636.397268355092;4909.8772530686665;5091.41448733393;5102.821401250939;5106.795728170869;3796.9832457131574;3840.9423858642144;4355.499117601485;4456.821727130943;4505.617022553087;4785.904281914342;4916.672498425441;5161.948380516184;5401.945980540184;5499.807506737245;3689.723270754704;3762.529683789526;3770.1517158639363;3770.453284273765;3779.962200378016;5287.603429742785;5652.604317697763;5666.914996275059;5738.626989245686;5770.16332631766;3186.9801663467933;3425.2978139481347;3645.5078564394;3720.790743008533;3753.324401607737;3201.6798320167795;3387.9491807622903;3611.115276757211;3777.9622203777612;3801.3157631626573;3872.9806350968065;4101.876943691694;4428.911421771547;4433.866983990485;4435.578620031092;5074.2895994560795;5173.379194496684;5178.886539394049;5474;5480.259870064968;1124.9550017999352;1246.1401632873287;1248.2337492448085;1255.7237407770276;1257.8553516300124;800.59895183429;813.5688085314792;820.9753707388788;841.7390608911257;861.814709837388;4160.687948403882;4899.951000490021;4927.014597080598;4930.728809915489;4956.770607009567;4596.195665758479;5352.598555108382;5389.434109418455;5408.702521361284;5415.729213539307;4865.537773911473;4868;4886.731229782325;5209.739513024334;5286.5506431952945;2316.652502124695;2555.8849851756345;2812.606235127084;2830.6178665880257;2841.303880549279;5104.234364845229;5183.740812959337;5440.483154100354;5620.297462817148;5639.334432618831;5093.465186155475;5108.2848401223855;5452.909418116393;5478.630342414396;5560.638558493685;5443.972780136074;5449.618526703092;5471.5896307777075;5511.476409741068;5596.908602822574;4856.004519073652;5019.899602008012;5070.898582028412;5139.89492259166;5141.100307446257;4655.6973796703105;4885.802978270346;5095.388553373471;5313.043652142652;5330;4932.358793356841;5083.694978301313;5144.279800827812;5589.773561719805;5612.550995920398;3346.6151392590164;3591.0842735102383;3609.783412995229;3612.313660404515;3618.656227658368;4666.953330466652;5231.659942103904;5608.747606357642;5664.971675141598;5699.344575373885;5492.780288788564;5510.421405752499;5513.476219759116;5539.19681646151;5578.581606379619;5155.690658560498;5171.069207542528;5575.414581468887;5580.246666700106;5582.804601838916;5161.922571161361;5406.270153529381;5434.565234781129;5436.997961875006;5439.156930675752;4596.4024676791805;4775.904481910412;4934.753262336941;5306.575473962151;5407.378151512627;5281.392639846313;5440.537554307928;5446.836594902159;5468.156558589431;5491.039068163135 07:54:35 INFO - PROCESS | 1643 | |5;yui.html;614.4285814192799;693.7259782385958;745.1728581274781;768.0706345322162;782.5656760497922;11420.14348923831;14688.853111468881;14737.263136843168;14754;14783.260836958149;14617.853821461782;14797.186154761484;14823.407063717439;14834.184119873402;14836.48072317469;644.5552568727563;670.7920544631155;674.0933444517117;794.7258195922398;817.1052697296481;788.3811208201563;800.9078955920056;815.2988429950238;817.9877301840477;819.1849110135394;837.7905523619095;858.1332853817657;859.5916939453772;859.9312055035614;862.038826708219;673.050998092687;695.7877847256585;828.2380210206625;853.2875049333813;853.5732133933034;634.43852190811;638.683851493509;638.6934271549636;639.2520750721667;641.0768493369533;14393.568192954228;14447.349869255908;14451.277436128152;14454.132752034806;14485.203313817736;10482.895171048345;12900.290484023375;13009.674758131028;13063.412146453338;13139.802902956464;10468.842967355497;12032.49608705372;12033.81949270753;12194.695132621666;12390.56633017849;4150.481189851269;4205.5794420557695;4216.051388437608;4250.171216612762;4468.664850136252;87398;90266.54866725624;90659.99999999935;90794.63808042885;91384;10162.03460671235;10183.289267041604;10202;10294.794104118026;10323.94838025805;19040;19054.2378304869;19176.904115479614;19193.32823351204;19216.807831921782;7151.463640227003;7236.782896513113;7303.525270857377;7534.3595794357;7576.81057973544;4121.464209652726;4200.91598168041;4247.384129301234;4300.290452075373;4378.474583050054;2967.629046369204;2982.925426864302;3024.7731420143577;3041.148478426044;3043.3000409905844;581.4069648958039;599.1731410653271;624.487919905673;633.2622494793605;649.0653459018997;592.3454582686156;603.471962033221;617.0682269772676;623.5261201486902;628.2429672244934;8098.959505202436;8516.494435612132;8583.068809517808;8644.308455323559;8850.77873053166;602.9728662210211;610.5237914426755;620.0791824141147;634.1977398590786;642.3512252624789;3988.700847436454;4461.308497182942;4676.50896655853;4774.785134668949;4786.760661966888;56550;63478;68097.65951170311;90642.09357906337;110224.4488777551;79094;100013;102618;102907.48546257221;103637;84409;88204.11795882088;89883;90201;93316;9279.489628070522;9493.430394176372;9495.66765163216;9500.049995000445;9522.428654280766;43254;57578.42421575898;57589.13616295843;57868.71065644645;58565.5358616038;78634;79843.60078199572;81935.18064819514;82621;83633;11763.235389699643;11917.22538035025;12287.201331913397;12306.876931230574;12374.75250494967;12948;13443.462261509821;14546.741362467455;14567.198804065878;14837.339894635215;11002.394868282321;13383.464661413824;13786.724265514835;13909.860901390857;13964.952628552695;12099.213551119148;13105.410256538287;13182.538611148564;13538.390772415461;13922.373493192628;12590.181638193488;12723.045771566984;12804.871951280367;13094.934525327313;13551.390187441786;10662;10903.454827258447;10973.61592344296;11344.943275283571;11395;10954.233203675667;11138;11237.887621123684;11392.601258955896;11395.487203076047 07:54:35 INFO - PROCESS | 1643 | __end_tp_report 07:54:35 INFO - PROCESS | 1643 | __start_cc_report 07:54:35 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2600 07:54:35 INFO - PROCESS | 1643 | __end_cc_report 07:54:35 INFO - PROCESS | 1643 | __startTimestamp1479225275462__endTimestamp 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | ------- Summary: start ------- 07:54:35 INFO - PROCESS | 1643 | Number of tests: 6 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5728.93 Median:5925.02 stddev:668.35 (11.3%) stddev-sans-first:641.43 07:54:35 INFO - PROCESS | 1643 | Values: 3247.6 3332.4 3345.2 3348.6 3396.5 4287.0 5665.9 5724.5 5731.4 5764.0 5674.3 5756.6 5758.6 5783.9 5814.3 4363.0 4715.9 5233.2 5292.3 5380.7 5189.1 5199.6 5204.3 5257.2 5277.7 5268.6 5278.7 5279.9 5286.2 5286.4 4508.6 5148.9 5283.6 5287.9 5298.0 5166.6 5206.8 5217.9 5227.1 5234.0 5756.5 5758.2 5762.7 5762.9 5794.9 5154.3 6118.9 6154.0 6157.9 6165.8 6241.5 6264.5 6265.7 6320.2 6323.5 5762.9 5767.9 5824.3 5845.8 5872.3 6219.3 6312.2 6343.0 6345.1 6366.2 6050.8 6067.7 6088.5 6126.8 6144.8 6195.7 6256.2 6335.4 6345.7 6346.9 6049.0 6259.1 6261.3 6266.4 6273.3 6125.6 6126.6 6153.9 6208.1 6229.3 4918.0 4930.0 4931.4 4933.0 4948.6 4366.2 4391.0 4427.6 4438.0 4464.7 5710.2 5758.7 5761.6 5833.2 5837.5 6313.8 6349.4 6352.8 6364.3 6374.0 5879.2 5883.1 5886.2 5890.3 5925.0 5268.3 5320.7 5392.1 5420.8 5432.2 5324.2 6248.8 6274.7 6293.5 6308.0 6337.7 6340.5 6340.7 6341.3 6350.0 6200.8 6275.7 6298.5 6316.9 6318.5 6023.9 6108.2 6118.8 6129.7 6143.8 5233.2 6062.3 6339.6 6343.7 6366.5 6078.9 6127.2 6139.4 6151.9 6158.3 5931.5 5989.3 6008.8 6081.1 6138.8 5894.9 5901.7 5912.1 5915.3 5915.5 6046.0 6067.2 6070.5 6090.6 6116.5 5996.4 6006.7 6011.2 6025.4 6061.9 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:70349.09 Median:37329.85 stddev:161707.73 (433.2%) stddev-sans-first:162076.22 07:54:35 INFO - PROCESS | 1643 | Values: 458.4 468.3 523.1 524.6 536.1 28920.0 30524.0 32717.8 34231.0 41511.2 39739.4 40223.6 40429.2 40441.8 40454.6 9189.5 9346.9 9353.4 9353.4 9359.7 9246.6 9252.6 9366.7 9380.5 9397.1 9312.0 9386.9 9395.6 9396.2 9410.2 9323.9 9348.5 9349.2 9359.0 9366.5 9216.8 9278.8 9294.9 9301.7 9308.7 37500.1 37960.8 38019.0 38393.6 38620.6 3110.4 3278.0 3284.3 3328.9 3332.1 27329.6 28204.2 28732.6 29131.3 29469.1 2700.7 3104.1 3136.2 3146.5 3193.6 471237.0 474337.0 474945.0 474972.0 475173.0 32154.7 55287.0 55675.4 55692.7 55755.4 32653.5 33659.8 34031.5 34079.5 34080.8 14054.3 14108.2 14184.3 14195.4 14198.9 12007.7 12103.0 12103.9 12113.0 12122.7 6408.8 7627.5 7710.0 7724.3 7737.0 2737.6 3140.5 3193.9 3194.9 3227.9 903.2 918.8 931.3 958.1 1045.6 28740.9 28925.6 29101.0 29350.1 29557.9 957.7 969.2 1056.6 1097.9 1147.6 14564.6 14916.4 15094.9 15307.2 15479.5 676214.6 676445.0 678697.0 678818.0 680742.0 52384.0 52626.0 52657.2 52686.7 52693.0 1207.7 1255.4 1325.2 1362.0 1370.3 28680.6 29642.9 29736.7 30510.0 30519.8 43716.0 52990.0 53764.5 53999.9 57487.0 621742.0 637673.8 637707.0 639050.0 639336.0 34143.7 34793.1 36309.5 40564.4 41114.6 36098.1 43448.6 44091.3 44416.8 44580.1 36549.0 36704.8 36747.9 36787.4 37573.2 36711.0 36824.4 36832.3 37159.6 37612.8 35882.6 36442.0 36714.0 36755.1 37001.6 30672.7 32527.2 32655.8 32748.3 32942.5 24594.9 24700.6 24707.0 24792.5 24970.6 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:34364.89 Median:1653.75 stddev:99144.55 (5995.1%) stddev-sans-first:99389.73 07:54:35 INFO - PROCESS | 1643 | Values: 326.3 365.3 372.9 383.2 399.7 16291.9 16353.5 19116.0 20368.8 20521.7 19355.0 19838.7 20014.7 20146.9 20361.6 5627.9 5658.4 5960.3 5961.9 5979.5 5196.9 5793.2 5866.9 5877.1 5935.6 5597.4 5857.3 5912.0 5913.3 5915.3 5722.8 5731.9 5745.2 5766.7 5877.2 5059.4 5079.4 5147.4 5153.7 5171.9 23951.5 24611.3 24767.8 24832.5 24994.9 2236.7 2360.9 2384.6 2454.4 2981.2 14608.5 14804.3 15265.7 15699.4 15750.4 1523.5 1734.5 1777.2 1814.1 1825.7 107552.5 109029.5 109280.0 109304.5 110506.4 10592.6 10702.7 11055.0 11553.9 11730.0 14012.2 14096.4 14135.2 14169.1 14195.5 8255.8 8600.1 8602.6 8698.3 8700.5 8470.8 8493.0 8495.5 8688.6 8694.6 6552.4 6700.1 6704.9 6716.0 6809.8 1558.4 1675.4 1785.5 1833.1 1835.2 729.9 895.6 948.4 960.3 988.8 17270.3 17965.6 19763.5 21706.0 22015.0 881.8 885.8 914.2 954.6 989.3 10519.1 11203.0 11255.7 11319.0 11340.9 573884.0 586078.0 588407.0 609246.0 620021.0 122080.0 127128.0 128692.7 129281.4 129617.0 778.9 976.7 998.9 1013.5 1014.1 19139.0 19792.6 19822.4 19930.1 20004.4 51508.7 51676.5 52534.7 53837.0 54703.6 67898.0 68091.6 68494.7 68623.7 69027.3 6355.0 7322.6 7374.9 7518.2 7758.3 8960.4 11257.7 12013.9 12392.4 12489.6 9696.5 10516.1 10611.0 10679.6 10739.9 10320.5 10357.2 10446.3 10649.3 10750.7 9897.1 9986.2 10491.3 10677.4 10817.4 7691.7 7762.7 8091.5 8225.2 8266.1 9512.4 9714.7 10603.0 10857.0 11178.1 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5489.33 Median:5127.19 stddev:3029.50 (59.1%) stddev-sans-first:3021.62 07:54:35 INFO - PROCESS | 1643 | Values: 1298.7 1463.9 1605.3 1812.2 1853.5 8153.8 8584.4 8586.2 8589.1 8589.4 7498.2 7764.9 7780.3 8122.6 8336.3 2273.0 2312.9 2316.5 2316.7 2317.6 2272.5 2306.6 2315.9 2317.7 2321.1 2279.3 2290.8 2293.2 2300.5 2315.5 2272.1 2275.5 2303.2 2305.0 2306.8 2223.2 2251.1 2269.6 2269.8 2290.0 8285.5 8485.3 8489.2 8513.0 8517.9 4474.3 5041.3 5213.0 5221.4 5243.6 3224.0 3345.8 3595.1 3599.2 3605.5 1035.9 1042.8 1060.7 1077.5 1083.9 10991.9 11140.5 11149.3 11155.0 11212.4 4516.3 4555.9 4764.6 4786.1 4790.9 9484.3 9488.5 9494.3 9494.4 9503.2 5235.0 5242.2 5248.4 5254.7 5255.8 4306.4 4333.6 4676.0 4793.7 4816.6 3724.8 3771.0 3820.8 3874.3 3877.7 1055.7 1214.6 1235.1 1257.4 1258.2 800.0 824.3 841.4 892.6 927.3 5388.3 5677.6 5848.7 5896.6 5976.7 926.9 930.2 940.4 947.7 989.2 3730.6 3806.2 3807.1 3892.0 3926.8 9828.2 10298.4 10321.9 10330.5 10353.7 10280.0 10297.2 10299.1 10309.9 10337.4 6252.9 7797.3 7854.0 7948.0 7952.4 5590.2 5597.9 5760.2 5798.5 5816.4 9179.0 9433.4 9450.9 9580.9 9672.0 9512.0 9513.0 9622.5 9630.5 9720.9 6628.6 6869.9 6883.4 7134.0 7291.3 7619.2 7920.4 7943.1 8005.4 8026.6 7054.1 7165.7 7177.9 7231.2 7320.7 6974.8 7081.7 7087.8 7135.1 7207.5 6687.2 6694.4 6726.1 6772.2 6775.9 4844.7 4878.6 4898.3 4928.5 4955.9 4828.0 4864.6 4884.5 4989.3 4994.3 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4348.61 Median:4931.54 stddev:1341.56 (27.2%) stddev-sans-first:1310.00 07:54:35 INFO - PROCESS | 1643 | Values: 274.2 301.5 305.7 309.7 313.7 5161.6 5233.7 5243.8 5264.0 5269.6 4220.7 4815.8 4896.4 5054.6 5230.0 3520.5 3599.6 3867.6 3922.8 3953.8 3926.0 3958.4 3965.8 3972.5 4003.6 3685.3 3904.3 3917.8 3936.2 3963.7 3271.7 3890.1 3916.2 3919.5 3924.2 3395.4 3395.7 3406.9 3412.4 3414.6 4636.4 4909.9 5091.4 5102.8 5106.8 3797.0 3840.9 4355.5 4456.8 4505.6 4785.9 4916.7 5161.9 5401.9 5499.8 3689.7 3762.5 3770.2 3770.5 3780.0 5287.6 5652.6 5666.9 5738.6 5770.2 3187.0 3425.3 3645.5 3720.8 3753.3 3201.7 3387.9 3611.1 3778.0 3801.3 3873.0 4101.9 4428.9 4433.9 4435.6 5074.3 5173.4 5178.9 5474.0 5480.3 1125.0 1246.1 1248.2 1255.7 1257.9 800.6 813.6 821.0 841.7 861.8 4160.7 4900.0 4927.0 4930.7 4956.8 4596.2 5352.6 5389.4 5408.7 5415.7 4865.5 4868.0 4886.7 5209.7 5286.6 2316.7 2555.9 2812.6 2830.6 2841.3 5104.2 5183.7 5440.5 5620.3 5639.3 5093.5 5108.3 5452.9 5478.6 5560.6 5444.0 5449.6 5471.6 5511.5 5596.9 4856.0 5019.9 5070.9 5139.9 5141.1 4655.7 4885.8 5095.4 5313.0 5330.0 4932.4 5083.7 5144.3 5589.8 5612.6 3346.6 3591.1 3609.8 3612.3 3618.7 4667.0 5231.7 5608.7 5665.0 5699.3 5492.8 5510.4 5513.5 5539.2 5578.6 5155.7 5171.1 5575.4 5580.2 5582.8 5161.9 5406.3 5434.6 5437.0 5439.2 4596.4 4775.9 4934.8 5306.6 5407.4 5281.4 5440.5 5446.8 5468.2 5491.0 07:54:35 INFO - PROCESS | 1643 | 07:54:35 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20102.20 Median:4419.89 stddev:28985.42 (655.8%) stddev-sans-first:29029.79 07:54:35 INFO - PROCESS | 1643 | Values: 614.4 693.7 745.2 768.1 782.6 11420.1 14688.9 14737.3 14754.0 14783.3 14617.9 14797.2 14823.4 14834.2 14836.5 644.6 670.8 674.1 794.7 817.1 788.4 800.9 815.3 818.0 819.2 837.8 858.1 859.6 859.9 862.0 673.1 695.8 828.2 853.3 853.6 634.4 638.7 638.7 639.3 641.1 14393.6 14447.3 14451.3 14454.1 14485.2 10482.9 12900.3 13009.7 13063.4 13139.8 10468.8 12032.5 12033.8 12194.7 12390.6 4150.5 4205.6 4216.1 4250.2 4468.7 87398.0 90266.5 90660.0 90794.6 91384.0 10162.0 10183.3 10202.0 10294.8 10323.9 19040.0 19054.2 19176.9 19193.3 19216.8 7151.5 7236.8 7303.5 7534.4 7576.8 4121.5 4200.9 4247.4 4300.3 4378.5 2967.6 2982.9 3024.8 3041.1 3043.3 581.4 599.2 624.5 633.3 649.1 592.3 603.5 617.1 623.5 628.2 8099.0 8516.5 8583.1 8644.3 8850.8 603.0 610.5 620.1 634.2 642.4 3988.7 4461.3 4676.5 4774.8 4786.8 56550.0 63478.0 68097.7 90642.1 110224.4 79094.0 100013.0 102618.0 102907.5 103637.0 84409.0 88204.1 89883.0 90201.0 93316.0 9279.5 9493.4 9495.7 9500.0 9522.4 43254.0 57578.4 57589.1 57868.7 58565.5 78634.0 79843.6 81935.2 82621.0 83633.0 11763.2 11917.2 12287.2 12306.9 12374.8 12948.0 13443.5 14546.7 14567.2 14837.3 11002.4 13383.5 13786.7 13909.9 13965.0 12099.2 13105.4 13182.5 13538.4 13922.4 12590.2 12723.0 12804.9 13094.9 13551.4 10662.0 10903.5 10973.6 11344.9 11395.0 10954.2 11138.0 11237.9 11392.6 11395.5 07:54:35 INFO - PROCESS | 1643 | -------- Summary: end -------- 07:54:35 INFO - PROCESS | 1643 | 07:54:36 INFO - TEST-INFO | 1643: exit 0 07:54:36 INFO - TEST-OK | dromaeo_css | took 1121059ms 07:54:36 INFO - TEST-START | kraken 07:54:36 INFO - operating with platform_type : mac_ 07:54:36 INFO - Initialising browser for kraken test... 07:54:36 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmp8tg8Xg/profile http://localhost:49236/getInfo.html) 07:54:37 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 07:54:38 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 07:54:38 INFO - PROCESS | 1652 | colorDepth:24 07:54:38 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 07:54:38 INFO - PROCESS | 1652 | __metrics 07:54:38 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:54:38 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:39 INFO - TEST-INFO | 1652: exit 0 07:54:39 INFO - Browser initialized. 07:54:39 INFO - Running cycle 1/1 for kraken test... 07:54:39 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmp8tg8Xg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:51 INFO - PROCESS | 1653 | RSS: Main: 217391104 07:54:51 INFO - PROCESS | 1653 | 07:54:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:55 INFO - PROCESS | 1653 | RSS: Main: 267829248 07:54:55 INFO - PROCESS | 1653 | 07:54:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 07:54:58 INFO - PROCESS | 1653 | RSS: Main: 278134784 07:54:58 INFO - PROCESS | 1653 | 07:55:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 07:55:02 INFO - PROCESS | 1653 | RSS: Main: 373628928 07:55:02 INFO - PROCESS | 1653 | 07:55:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 07:55:04 INFO - PROCESS | 1653 | RSS: Main: 277487616 07:55:04 INFO - PROCESS | 1653 | 07:55:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:07 INFO - PROCESS | 1653 | RSS: Main: 280080384 07:55:07 INFO - PROCESS | 1653 | 07:55:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:10 INFO - PROCESS | 1653 | RSS: Main: 320106496 07:55:10 INFO - PROCESS | 1653 | 07:55:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:14 INFO - PROCESS | 1653 | RSS: Main: 321466368 07:55:14 INFO - PROCESS | 1653 | 07:55:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 07:55:17 INFO - PROCESS | 1653 | RSS: Main: 318365696 07:55:17 INFO - PROCESS | 1653 | 07:55:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:19 INFO - PROCESS | 1653 | RSS: Main: 296685568 07:55:19 INFO - PROCESS | 1653 | 07:55:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:22 INFO - PROCESS | 1653 | RSS: Main: 298561536 07:55:22 INFO - PROCESS | 1653 | 07:55:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:25 INFO - PROCESS | 1653 | RSS: Main: 299876352 07:55:25 INFO - PROCESS | 1653 | 07:55:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:29 INFO - PROCESS | 1653 | RSS: Main: 317538304 07:55:29 INFO - PROCESS | 1653 | 07:55:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:32 INFO - PROCESS | 1653 | RSS: Main: 311492608 07:55:32 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 07:55:34 INFO - PROCESS | 1653 | RSS: Main: 355311616 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | __start_tp_report 07:55:34 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:55:34 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:55:34 INFO - PROCESS | 1653 | |i|pagename|runs| 07:55:34 INFO - PROCESS | 1653 | |0;ai-astar;116;114;113;115;114;115;119;167;152;114 07:55:34 INFO - PROCESS | 1653 | |1;audio-beat-detection;143;121;139;144;112;112;116;111;141;111 07:55:34 INFO - PROCESS | 1653 | |2;audio-dft;181;184;185;185;186;185;185;186;184;184 07:55:34 INFO - PROCESS | 1653 | |3;audio-fft;83;59;57;88;63;60;75;80;111;60 07:55:34 INFO - PROCESS | 1653 | |4;audio-oscillator;87;71;95;70;69;69;89;67;70;92 07:55:34 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;90;87;90;88;90;87;91;87;90;85 07:55:34 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;94;94;95;95;95;94;95;94;95 07:55:34 INFO - PROCESS | 1653 | |7;imaging-desaturate;84;80;89;82;80;84;83;84;81;82 07:55:34 INFO - PROCESS | 1653 | |8;json-parse-financial;55;54;53;54;55;57;58;56;57;57 07:55:34 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;76;70;81;73;67;72;70;69;69 07:55:34 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;84;75;80;101;103;103;102;84;85 07:55:34 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;148;141;151;159;152;151;149;148;189;155 07:55:34 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;166;171;229;195;166;169;167;166;168;168 07:55:34 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;69;80;88;91;66;66;65;64;65 07:55:34 INFO - PROCESS | 1653 | __end_tp_report 07:55:34 INFO - PROCESS | 1653 | __start_cc_report 07:55:34 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2031 07:55:34 INFO - PROCESS | 1653 | __end_cc_report 07:55:34 INFO - PROCESS | 1653 | __startTimestamp1479225334812__endTimestamp 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:55:34 INFO - PROCESS | 1653 | Number of tests: 14 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:123.90 Median:115.50 stddev:19.16 (16.6%) stddev-sans-first:20.11 07:55:34 INFO - PROCESS | 1653 | Values: 116.0 114.0 113.0 115.0 114.0 115.0 119.0 167.0 152.0 114.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:130.00 stddev:14.77 (11.4%) stddev-sans-first:14.16 07:55:34 INFO - PROCESS | 1653 | Values: 143.0 121.0 139.0 144.0 112.0 112.0 116.0 111.0 141.0 111.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.43 (0.8%) stddev-sans-first:0.78 07:55:34 INFO - PROCESS | 1653 | Values: 181.0 184.0 185.0 185.0 186.0 185.0 185.0 186.0 184.0 184.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:73.60 Median:69.00 stddev:17.35 (25.1%) stddev-sans-first:18.06 07:55:34 INFO - PROCESS | 1653 | Values: 83.0 59.0 57.0 88.0 63.0 60.0 75.0 80.0 111.0 60.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.00 stddev:11.29 (14.3%) stddev-sans-first:11.48 07:55:34 INFO - PROCESS | 1653 | Values: 87.0 71.0 95.0 70.0 69.0 69.0 89.0 67.0 70.0 92.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:90.00 stddev:1.96 (2.2%) stddev-sans-first:2.00 07:55:34 INFO - PROCESS | 1653 | Values: 90.0 87.0 90.0 88.0 90.0 87.0 91.0 87.0 90.0 85.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:55:34 INFO - PROCESS | 1653 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:82.90 Median:83.50 stddev:2.64 (3.2%) stddev-sans-first:2.77 07:55:34 INFO - PROCESS | 1653 | Values: 84.0 80.0 89.0 82.0 80.0 84.0 83.0 84.0 81.0 82.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:1.65 (2.9%) stddev-sans-first:1.73 07:55:34 INFO - PROCESS | 1653 | Values: 55.0 54.0 53.0 54.0 55.0 57.0 58.0 56.0 57.0 57.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:4.61 (6.5%) stddev-sans-first:4.31 07:55:34 INFO - PROCESS | 1653 | Values: 65.0 76.0 70.0 81.0 73.0 67.0 72.0 70.0 69.0 69.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:82.00 stddev:10.80 (13.2%) stddev-sans-first:11.29 07:55:34 INFO - PROCESS | 1653 | Values: 85.0 84.0 75.0 80.0 101.0 103.0 103.0 102.0 84.0 85.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:154.30 Median:151.50 stddev:13.07 (8.6%) stddev-sans-first:13.67 07:55:34 INFO - PROCESS | 1653 | Values: 148.0 141.0 151.0 159.0 152.0 151.0 149.0 148.0 189.0 155.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:168.50 stddev:20.41 (12.1%) stddev-sans-first:21.30 07:55:34 INFO - PROCESS | 1653 | Values: 166.0 171.0 229.0 195.0 166.0 169.0 167.0 166.0 168.0 168.0 07:55:34 INFO - PROCESS | 1653 | 07:55:34 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:67.50 stddev:10.33 (15.3%) stddev-sans-first:10.72 07:55:34 INFO - PROCESS | 1653 | Values: 66.0 69.0 80.0 88.0 91.0 66.0 66.0 65.0 64.0 65.0 07:55:34 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:55:34 INFO - PROCESS | 1653 | 07:55:35 INFO - TEST-INFO | 1653: exit 0 07:55:35 INFO - TEST-OK | kraken | took 59618ms 07:55:35 INFO - SUITE-END | took 1180s 07:55:35 INFO - Completed test suite (00:19:40) 07:55:35 INFO - javascript benchmark 07:55:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.5778148840645, 3332.4334863073277, 3345.180430794456, 3348.6316505184427, 3396.5075064115704, 4287.0, 5665.943340566593, 5724.484796368326, 5731.369549349568, 5764.0, 5674.290713660793, 5756.625819321741, 5758.568107391941, 5783.913241301373, 5814.331351894522, 4363.0, 4715.929261061086, 5233.162693968966, 5292.259083728281, 5380.677159370451, 5189.143791274435, 5199.558037566811, 5204.3234379530795, 5257.158854583248, 5277.656952298107, 5268.604854635918, 5278.683279003253, 5279.894402111955, 5286.154215325549, 5286.4449232830575, 4508.571685689854, 5148.897022059537, 5283.603729720267, 5287.947120528784, 5298.0, 5166.638335316529, 5206.7917283309, 5217.869553261161, 5227.085260079509, 5233.9738301308635, 5756.510696590794, 5758.165066065439, 5762.74067666956, 5762.855928601776, 5794.942050579524, 5154.252633368141, 6118.893302669174, 6154.046122850965, 6157.938420615781, 6165.784197553109, 6241.531885108635, 6264.467520260738, 6265.7493700251935, 6320.209973753281, 6323.52573556985, 5762.884742305172, 5767.913481297784, 5824.30108386992, 5845.824625261249, 5872.265966754156, 6219.346968568326, 6312.242530896322, 6343.048542718537, 6345.079963405326, 6366.236051673829, 6050.757969681252, 6067.7269522871575, 6088.4824789893355, 6126.846828829226, 6144.784932527429, 6195.659238741822, 6256.217972753406, 6335.366463353628, 6345.682715864188, 6346.873062538816, 6049.032154855202, 6259.0924315973925, 6261.342559031327, 6266.404691554386, 6273.341299163613, 6125.632462052291, 6126.639818174636, 6153.938460615426, 6208.068789681493, 6229.314775374705, 4918.040982008474, 4930.0, 4931.408231012301, 4932.950670493249, 4948.579370753454, 4366.214081465303, 4390.978045109818, 4427.601515863587, 4437.9570800861775, 4464.732116073046, 5710.172025056427, 5758.654480731169, 5761.625494342854, 5833.241678581757, 5837.503812175928, 6313.842153946188, 6349.428551430301, 6352.7776527822225, 6364.331745166784, 6374.043893416025, 5879.176915231871, 5883.14694369314, 5886.205362276038, 5890.322612899486, 5925.022371308772, 5268.262443257947, 5320.654157479828, 5392.056390131711, 5420.783168673288, 5432.239486471897, 5324.227986941949, 6248.750049998131, 6274.749010039547, 6293.527985401021, 6307.96846015767, 6337.746490140343, 6340.461060809883, 6340.682965851597, 6341.270753863365, 6349.9682501587195, 6200.81397558074, 6275.717592708431, 6298.464630506458, 6316.873662526816, 6318.526110541819, 6023.939760602338, 6108.17539632144, 6118.755249789959, 6129.664444256008, 6143.784967526115, 5233.241180028951, 6062.333143354315, 6339.619622822645, 6343.714532845941, 6366.522510811615, 6078.908816367846, 6127.172831667668, 6139.3553676863285, 6151.907721384094, 6158.291796443287, 5931.525477961839, 5989.251343582052, 6008.819735407945, 6081.087836824335, 6138.815835524942, 5894.882102358015, 5901.675407852437, 5912.083627037816, 5915.260592425947, 5915.497182739343, 6045.969770151121, 6067.180930574493, 6070.453659170519, 6090.634561926298, 6116.548817443993, 5996.400359963969, 6006.729697163725, 6011.158437818796, 6025.397460253939, 6061.9393806063135], "value": 5686.198930463324, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.44070234314137, 468.31859644217667, 523.0872128136401, 524.5750941737195, 536.0859734153266, 28919.999999999975, 30524.0, 32717.83641081797, 34231.0, 41511.16977660445, 39739.40390894132, 40223.59776402235, 40429.191416171656, 40441.797791011006, 40454.59545404545, 9189.540522973857, 9346.859797103014, 9353.392029518094, 9353.438793672367, 9359.6724114656, 9246.630134794601, 9252.6298948042, 9366.672166474174, 9380.530973451334, 9397.107274808917, 9311.95344023279, 9386.90613093867, 9395.62417503299, 9396.15434610885, 9410.2471802256, 9323.906760932405, 9348.532573371303, 9349.158575728148, 9359.01730318317, 9366.53167341637, 9216.769580760467, 9278.814423711488, 9294.86057709135, 9301.674441394518, 9308.674196403093, 37500.06249843749, 37960.81019594884, 38019.04952376213, 38393.61606383928, 38620.64827731016, 3110.4090222857585, 3277.950830737541, 3284.310294838087, 3328.900132996014, 3332.100332910125, 27329.590056149173, 28204.153875383567, 28732.569011464846, 29131.271718207, 29469.115926522238, 2700.702922678504, 3104.099811054791, 3136.231623252295, 3146.5122905949615, 3193.6327322357993, 471237.0, 474336.99999999657, 474945.0, 474972.0, 475173.0, 32154.678453215638, 55287.0, 55675.44324556783, 55692.72153639206, 55755.442445575834, 32653.51019734706, 33659.831700841336, 34031.489527657104, 34079.46642401098, 34080.829595851865, 14054.297285135703, 14108.153510789385, 14184.290785460686, 14195.432182712782, 14198.864090872705, 12007.699807504881, 12103.0, 12103.939480302543, 12113.030957523377, 12122.69693257658, 6408.839779005562, 7627.466077374531, 7709.9614501927135, 7724.304812566896, 7737.0, 2737.5893615957766, 3140.4661207594763, 3193.9361212775616, 3194.9201269968435, 3227.88702395415, 903.2051794420868, 918.8437965545739, 931.2596485793811, 958.0802429667597, 1045.6131231444415, 28740.856295718386, 28925.553802208946, 29101.0, 29350.11949641514, 29557.85221073924, 957.7366224288377, 969.2004096620317, 1056.5562463765236, 1097.9011888930036, 1147.6270212181075, 14564.563063108124, 14916.403343866124, 15094.922517315306, 15307.15810630426, 15479.5356139316, 676214.6189269022, 676445.0, 678697.0, 678818.0, 680742.0, 52384.0, 52626.0, 52657.2101418479, 52686.736566316926, 52693.0, 1207.7463732616072, 1255.353492951149, 1325.151902782201, 1362.0329566008047, 1370.30799446279, 28680.569791453563, 29642.85178574093, 29736.702632973393, 30510.0, 30519.847400762854, 43716.0, 52990.0, 53764.462355375945, 53999.92000159896, 57487.0, 621742.0, 637673.8116309389, 637707.0, 639050.0, 639336.0, 34143.65856341405, 34793.13017174591, 36309.45535817018, 40564.3915341276, 41114.588854111076, 36098.09754756152, 43448.56551434445, 44091.338629919934, 44416.777916110215, 44580.10839783251, 36549.0, 36704.81647591745, 36747.89756307315, 36787.44818827773, 37573.2485350286, 36711.0, 36824.44763328606, 36832.26335473329, 37159.6284037167, 37612.811935940146, 35882.64117358793, 36442.0, 36714.0, 36755.08112297214, 37001.629983699815, 30672.693273066983, 32527.18682032968, 32655.836720817195, 32748.345033099682, 32942.50586241256, 24594.877025615475, 24700.629490557298, 24707.0, 24792.500683790007, 24970.62544061877], "value": 18166.299191501374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.26264641909285, 365.2840432751808, 372.8750868459066, 383.1895540930932, 399.72419030868696, 16291.918540407296, 16353.487536850724, 19116.044197790106, 20368.777873327574, 20521.692174617394, 19355.0, 19838.70241946372, 20014.69977950332, 20146.89926550369, 20361.592768144626, 5627.943720562804, 5658.405867383927, 5960.284765828107, 5961.88076238475, 5979.52163826895, 5196.870078248036, 5793.188953546507, 5866.88266234675, 5877.089051197071, 5935.584509084366, 5597.412271711472, 5857.297124345085, 5911.994960856643, 5913.3199682036475, 5915.319738230116, 5722.79970201043, 5731.942680573204, 5745.1669507921115, 5766.740496677618, 5877.23595932526, 5059.392872855244, 5079.3650793650795, 5147.356580427447, 5153.665011774223, 5171.870703232412, 23951.520969580684, 24611.261662150166, 24767.761611919334, 24832.503349933082, 24994.875025624755, 2236.731592208929, 2360.8583484990954, 2384.5588566115325, 2454.361865914857, 2981.2397838551246, 14608.488702895347, 14804.259787010606, 15265.694686106215, 15699.37202511898, 15750.448734294245, 1523.451557439321, 1734.4969958711958, 1777.2363974020393, 1814.13828431494, 1825.7078867381288, 107552.4622376883, 109029.45485272523, 109280.0, 109304.45347773211, 110506.44746776295, 10592.629257975934, 10702.732431689114, 11055.0, 11553.942230288963, 11730.0, 14012.229327386887, 14096.365663545164, 14135.15189088658, 14169.079009864327, 14195.503157389441, 8255.793605159919, 8600.13998600135, 8602.569871506525, 8698.260647844878, 8700.521471319138, 8470.788230294293, 8492.957535212408, 8495.532745699045, 8688.609012594448, 8694.565271736514, 6552.410283074546, 6700.095487109178, 6704.865902682017, 6715.992601109872, 6809.761658341934, 1558.4000159938278, 1675.3801093595205, 1785.4643606918132, 1833.1118947484113, 1835.2292037344348, 729.8868675355328, 895.5880295064343, 948.3645957208687, 960.3085778239656, 988.8035477072823, 17270.309187632607, 17965.640687186184, 19763.505912352306, 21706.023228954735, 22015.0, 881.7531091294447, 885.818407226517, 914.2092090341806, 954.5990683912773, 989.2548178803877, 10519.064751766644, 11203.0, 11255.718607034725, 11319.0, 11340.886591134147, 573884.0, 586078.0, 588407.0, 609246.0, 620021.0, 122080.0, 127128.0, 128692.71307286994, 129281.35359323332, 129617.0, 778.9221077892279, 976.6581696406344, 998.9100980911608, 1013.5084484025242, 1014.1227837920146, 19139.0, 19792.604147916674, 19822.405327840188, 19930.103145358782, 20004.399868003984, 51508.74245628748, 51676.48323516867, 52534.73732631312, 53837.0, 54703.63240919009, 67897.9815302761, 68091.63816723737, 68494.65752671205, 68623.65688171527, 69027.3097269021, 6355.014972679242, 7322.64083528526, 7374.856897180945, 7518.173000969779, 7758.340541054074, 8960.417572857743, 11257.71855703614, 12013.939930300292, 12392.442340094898, 12489.625311240678, 9696.466694331879, 10516.053555180071, 10611.0, 10679.59709065454, 10739.946300268448, 10320.535575898952, 10357.22320825926, 10446.268761186644, 10649.254552181274, 10750.677479675622, 9897.109260166619, 9986.151177150025, 10491.265611407129, 10677.412742299248, 10817.350958942488, 7691.692332306869, 7762.68949242024, 8091.514509129471, 8225.177482251727, 8266.090730019572, 9512.38169518979, 9714.708558743248, 10603.0, 10857.022867941923, 11178.10575154002], "value": 9469.327505049558, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.7467443848448, 1463.926803659817, 1605.3097168217662, 1812.2207450796168, 1853.5273505256166, 8153.836923261531, 8584.356173287013, 8586.184312490312, 8589.141085891408, 8589.441686290387, 7498.175200727929, 7764.883526747103, 7780.260875216845, 8122.59387030649, 8336.291415229698, 2272.9886350568268, 2312.9421764455938, 2316.5251123519724, 2316.721993360799, 2317.5596636638984, 2272.5114100468395, 2306.5732839424677, 2315.8957846896847, 2317.6639387288833, 2321.071571371448, 2279.3048120323297, 2290.770922907704, 2293.2317673579373, 2300.5398920216026, 2315.548468048731, 2272.091163534583, 2275.476640372707, 2303.2169062518824, 2304.953900921989, 2306.8269879759087, 2223.1885361842974, 2251.0545570860277, 2269.6368581027123, 2269.841111122222, 2290.03818396274, 8285.54429506377, 8485.32117430604, 8489.151084891524, 8513.0, 8517.872231916526, 4474.261746811805, 5041.344625198737, 5213.035588416155, 5221.373435187764, 5243.632945693803, 3223.951640725391, 3345.7825241359233, 3595.137167079908, 3599.1541987632886, 3605.4591811228265, 1035.927485076045, 1042.8487869258915, 1060.734816295926, 1077.4774234496263, 1083.8970297821695, 10991.945040274748, 11140.498677559448, 11149.331040137618, 11155.0, 11212.439378030984, 4516.322551617218, 4555.863324100283, 4764.6426518011285, 4786.090642777861, 4790.928136077961, 9484.288678349152, 9488.478133702713, 9494.335396522178, 9494.382865113883, 9503.239740820718, 5234.979179060047, 5242.239875218072, 5248.396434410015, 5254.710990895537, 5255.816046438356, 4306.354046892991, 4333.6046769777, 4676.041411510632, 4793.664443488922, 4816.590589799836, 3724.8137593120236, 3771.0, 3820.7898565578603, 3874.2832575973534, 3877.651011408987, 1055.6885718712845, 1214.5627574073326, 1235.123062625528, 1257.3650306595111, 1258.1633213912828, 799.9680012799423, 824.2540500846743, 841.3647695989611, 892.6250974590688, 927.2720914082548, 5388.299521062237, 5677.602567820296, 5848.678322692208, 5896.557758168069, 5976.744883574411, 926.8934072581604, 930.1953809954341, 940.3934462271933, 947.7346343023964, 989.1542730965065, 3730.5709843367817, 3806.1626442182674, 3807.1053302473897, 3891.9805400973382, 3926.764394136361, 9828.21374290055, 10298.3820970742, 10321.896781032094, 10330.483475826179, 10353.689389318333, 10280.023397777199, 10297.17622590191, 10299.073083422378, 10309.917458666881, 10337.431441270803, 6252.906206406908, 7797.259260370256, 7853.999999999885, 7947.960260198662, 7952.3638108951145, 5590.161475778666, 5597.888042239214, 5760.222369979999, 5798.478136967693, 5816.447437493432, 9179.0, 9433.386829856312, 9450.905490945277, 9580.856287155837, 9671.951640241754, 9512.048795120432, 9512.952435238056, 9622.47076410804, 9630.507271372948, 9720.902790972283, 6628.602283862983, 6869.931300686929, 6883.449324054164, 7134.036905017963, 7291.30732580404, 7619.238076192337, 7920.405969552191, 7943.086545047162, 8005.439619226599, 8026.638801253841, 7054.118235220598, 7165.713371465083, 7177.856442871009, 7231.204567497676, 7320.707171713072, 6974.825629359104, 7081.681324340314, 7087.751928682472, 7135.072440582899, 7207.459440542085, 6687.230968438497, 6694.364035416627, 6726.091977582963, 6772.153480814898, 6775.898361524482, 4844.733539655212, 4878.56092951636, 4898.338724272177, 4928.457869634266, 4955.909699866023, 4828.03439312146, 4864.635152363658, 4884.4871288515615, 4989.301497790385, 4994.32576602154], "value": 4437.486289025111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.1884023291058, 301.4513585274798, 305.74928558581956, 309.7212508742132, 313.6753460168726, 5161.5933483900635, 5233.73831308435, 5243.827484371957, 5264.0, 5269.578433725303, 4220.683448741342, 4815.807367705296, 4896.4312453206885, 5054.646174767759, 5229.973850130754, 3520.4543295789194, 3599.5860476045195, 3867.555231148419, 3922.82347294371, 3953.8220780064967, 3925.979245396203, 3958.44581758554, 3965.8413663453425, 3972.543157536877, 4003.579624139467, 3685.318216130011, 3904.316744569703, 3917.8236979335857, 3936.1930804185217, 3963.663088637469, 3271.7055465008025, 3890.1247219375696, 3916.15802602439, 3919.492583528936, 3924.195539914325, 3395.422778127724, 3395.7453191010527, 3406.9488957665653, 3412.4028295048265, 3414.641462646411, 4636.397268355092, 4909.8772530686665, 5091.41448733393, 5102.821401250939, 5106.795728170869, 3796.9832457131574, 3840.9423858642144, 4355.499117601485, 4456.821727130943, 4505.617022553087, 4785.904281914342, 4916.672498425441, 5161.948380516184, 5401.945980540184, 5499.807506737245, 3689.723270754704, 3762.529683789526, 3770.1517158639363, 3770.453284273765, 3779.962200378016, 5287.603429742785, 5652.604317697763, 5666.914996275059, 5738.626989245686, 5770.16332631766, 3186.9801663467933, 3425.2978139481347, 3645.5078564394, 3720.790743008533, 3753.324401607737, 3201.6798320167795, 3387.9491807622903, 3611.115276757211, 3777.9622203777612, 3801.3157631626573, 3872.9806350968065, 4101.876943691694, 4428.911421771547, 4433.866983990485, 4435.578620031092, 5074.2895994560795, 5173.379194496684, 5178.886539394049, 5474.0, 5480.259870064968, 1124.9550017999352, 1246.1401632873287, 1248.2337492448085, 1255.7237407770276, 1257.8553516300124, 800.59895183429, 813.5688085314792, 820.9753707388788, 841.7390608911257, 861.814709837388, 4160.687948403882, 4899.951000490021, 4927.014597080598, 4930.728809915489, 4956.770607009567, 4596.195665758479, 5352.598555108382, 5389.434109418455, 5408.702521361284, 5415.729213539307, 4865.537773911473, 4868.0, 4886.731229782325, 5209.739513024334, 5286.5506431952945, 2316.652502124695, 2555.8849851756345, 2812.606235127084, 2830.6178665880257, 2841.303880549279, 5104.234364845229, 5183.740812959337, 5440.483154100354, 5620.297462817148, 5639.334432618831, 5093.465186155475, 5108.2848401223855, 5452.909418116393, 5478.630342414396, 5560.638558493685, 5443.972780136074, 5449.618526703092, 5471.5896307777075, 5511.476409741068, 5596.908602822574, 4856.004519073652, 5019.899602008012, 5070.898582028412, 5139.89492259166, 5141.100307446257, 4655.6973796703105, 4885.802978270346, 5095.388553373471, 5313.043652142652, 5330.0, 4932.358793356841, 5083.694978301313, 5144.279800827812, 5589.773561719805, 5612.550995920398, 3346.6151392590164, 3591.0842735102383, 3609.783412995229, 3612.313660404515, 3618.656227658368, 4666.953330466652, 5231.659942103904, 5608.747606357642, 5664.971675141598, 5699.344575373885, 5492.780288788564, 5510.421405752499, 5513.476219759116, 5539.19681646151, 5578.581606379619, 5155.690658560498, 5171.069207542528, 5575.414581468887, 5580.246666700106, 5582.804601838916, 5161.922571161361, 5406.270153529381, 5434.565234781129, 5436.997961875006, 5439.156930675752, 4596.4024676791805, 4775.904481910412, 4934.753262336941, 5306.575473962151, 5407.378151512627, 5281.392639846313, 5440.537554307928, 5446.836594902159, 5468.156558589431, 5491.039068163135], "value": 3917.17390146127, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.4285814192799, 693.7259782385958, 745.1728581274781, 768.0706345322162, 782.5656760497922, 11420.14348923831, 14688.853111468881, 14737.263136843168, 14754.0, 14783.260836958149, 14617.853821461782, 14797.186154761484, 14823.407063717439, 14834.184119873402, 14836.48072317469, 644.5552568727563, 670.7920544631155, 674.0933444517117, 794.7258195922398, 817.1052697296481, 788.3811208201563, 800.9078955920056, 815.2988429950238, 817.9877301840477, 819.1849110135394, 837.7905523619095, 858.1332853817657, 859.5916939453772, 859.9312055035614, 862.038826708219, 673.050998092687, 695.7877847256585, 828.2380210206625, 853.2875049333813, 853.5732133933034, 634.43852190811, 638.683851493509, 638.6934271549636, 639.2520750721667, 641.0768493369533, 14393.568192954228, 14447.349869255908, 14451.277436128152, 14454.132752034806, 14485.203313817736, 10482.895171048345, 12900.290484023375, 13009.674758131028, 13063.412146453338, 13139.802902956464, 10468.842967355497, 12032.49608705372, 12033.81949270753, 12194.695132621666, 12390.56633017849, 4150.481189851269, 4205.5794420557695, 4216.051388437608, 4250.171216612762, 4468.664850136252, 87398.0, 90266.54866725624, 90659.99999999935, 90794.63808042885, 91384.0, 10162.03460671235, 10183.289267041604, 10202.0, 10294.794104118026, 10323.94838025805, 19040.0, 19054.2378304869, 19176.904115479614, 19193.32823351204, 19216.807831921782, 7151.463640227003, 7236.782896513113, 7303.525270857377, 7534.3595794357, 7576.81057973544, 4121.464209652726, 4200.91598168041, 4247.384129301234, 4300.290452075373, 4378.474583050054, 2967.629046369204, 2982.925426864302, 3024.7731420143577, 3041.148478426044, 3043.3000409905844, 581.4069648958039, 599.1731410653271, 624.487919905673, 633.2622494793605, 649.0653459018997, 592.3454582686156, 603.471962033221, 617.0682269772676, 623.5261201486902, 628.2429672244934, 8098.959505202436, 8516.494435612132, 8583.068809517808, 8644.308455323559, 8850.77873053166, 602.9728662210211, 610.5237914426755, 620.0791824141147, 634.1977398590786, 642.3512252624789, 3988.700847436454, 4461.308497182942, 4676.50896655853, 4774.785134668949, 4786.760661966888, 56550.0, 63478.0, 68097.65951170311, 90642.09357906337, 110224.4488777551, 79094.0, 100013.0, 102618.0, 102907.48546257221, 103637.0, 84409.0, 88204.11795882088, 89883.0, 90201.0, 93316.0, 9279.489628070522, 9493.430394176372, 9495.66765163216, 9500.049995000445, 9522.428654280766, 43254.0, 57578.42421575898, 57589.13616295843, 57868.71065644645, 58565.5358616038, 78634.0, 79843.60078199572, 81935.18064819514, 82621.0, 83633.0, 11763.235389699643, 11917.22538035025, 12287.201331913397, 12306.876931230574, 12374.75250494967, 12948.0, 13443.462261509821, 14546.741362467455, 14567.198804065878, 14837.339894635215, 11002.394868282321, 13383.464661413824, 13786.724265514835, 13909.860901390857, 13964.952628552695, 12099.213551119148, 13105.410256538287, 13182.538611148564, 13538.390772415461, 13922.373493192628, 12590.181638193488, 12723.045771566984, 12804.871951280367, 13094.934525327313, 13551.390187441786, 10662.0, 10903.454827258447, 10973.61592344296, 11344.943275283571, 11395.0, 10954.233203675667, 11138.0, 11237.887621123684, 11392.601258955896, 11395.487203076047], "value": 7194.270121488078, "unit": "score"}], "name": "dromaeo_css", "value": 7045.712935269119, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 115.0, 114.0, 115.0, 119.0, 167.0, 152.0, 114.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 139.0, 144.0, 112.0, 112.0, 116.0, 111.0, 141.0, 111.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 185.0, 185.0, 186.0, 185.0, 185.0, 186.0, 184.0, 184.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 57.0, 88.0, 63.0, 60.0, 75.0, 80.0, 111.0, 60.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 95.0, 70.0, 69.0, 69.0, 89.0, 67.0, 70.0, 92.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 88.0, 90.0, 87.0, 91.0, 87.0, 90.0, 85.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 89.0, 82.0, 80.0, 84.0, 83.0, 84.0, 81.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 55.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 70.0, 81.0, 73.0, 67.0, 72.0, 70.0, 69.0, 69.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 75.0, 80.0, 101.0, 103.0, 103.0, 102.0, 84.0, 85.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 151.0, 159.0, 152.0, 151.0, 149.0, 148.0, 189.0, 155.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 229.0, 195.0, 166.0, 169.0, 167.0, 166.0, 168.0, 168.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 80.0, 88.0, 91.0, 66.0, 66.0, 65.0, 64.0, 65.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1470.6, "alertThreshold": 2.0}]} 07:55:36 INFO - Return code: 0 07:55:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:36 ERROR - # TBPL SUCCESS # 07:55:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:36 INFO - 2016-11-15 07:55:36.115 screenresolution[1657:10042] starting screenresolution argv=screenresolution get 07:55:36 INFO - 2016-11-15 07:55:36.117 screenresolution[1657:10042] Display 0: 1600x1200x32@60 07:55:36 INFO - 2016-11-15 07:55:36.123 screenresolution[1658:10046] starting screenresolution argv=screenresolution list 07:55:36 INFO - Available Modes on Display 0 07:55:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:36 INFO - Intel Iris: 07:55:36 INFO - Chipset Model: Intel Iris 07:55:36 INFO - Type: GPU 07:55:36 INFO - Bus: Built-In 07:55:36 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:36 INFO - Vendor: Intel (0x8086) 07:55:36 INFO - Device ID: 0x0a2e 07:55:36 INFO - Revision ID: 0x0009 07:55:36 INFO - Displays: 07:55:36 INFO - Display: 07:55:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:36 INFO - Display Serial Number: 1600x1200 60 07:55:36 INFO - Main Display: Yes 07:55:36 INFO - Mirror: Off 07:55:36 INFO - Online: Yes 07:55:36 INFO - Rotation: Supported 07:55:36 INFO - Return code: 0 07:55:36 INFO - Running post-action listener: _resource_record_post_action 07:55:36 INFO - [mozharness: 2016-11-15 15:55:36.374143Z] Finished run-tests step (success) 07:55:36 INFO - Running post-run listener: _resource_record_post_run 07:55:36 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 37446656; Write bytes: 651743232; Read time: 241; Write time: 1894 07:55:36 INFO - TinderboxPrint: CPU usage
53.5% 07:55:36 INFO - TinderboxPrint: I/O read bytes / time
37,446,656 / 241 07:55:36 INFO - TinderboxPrint: I/O write bytes / time
651,743,232 / 1,894 07:55:36 INFO - TinderboxPrint: CPU idle
2,256.1 (46.5%) 07:55:36 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 07:55:36 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 07:55:36 INFO - TinderboxPrint: Swap in / out
390,266,880 / 0 07:55:36 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 348459520; Write bytes: 346525184; Read time: 27556; Write time: 744 07:55:36 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 35464192; Write bytes: 294257152; Read time: 224; Write time: 1118 07:55:36 INFO - Running post-run listener: _upload_blobber_files 07:55:36 INFO - Blob upload gear active. 07:55:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:36 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 07:55:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:55:37 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:38 INFO - (blobuploader) - INFO - Done attempting. 07:55:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:55:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:39 INFO - (blobuploader) - INFO - Done attempting. 07:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:41 INFO - (blobuploader) - INFO - Done attempting. 07:55:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:41 INFO - Return code: 0 07:55:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a02c3de7128b77b08c5a8f89b4100a844f0a30077e9002a401f6994e15d93baef7e3b8c016dc4a17ecae8c222b43089d7dbcd45b6d41dcc56b7c071b0cdf69a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12aa654f0d69ebea9a5901df89efb004f8412e7610cda4627b1720e5c6804aa3a1f29058ae02ec1ff31ef6f50b4792ca4974d0f5cac2088b98a15da70d9f0f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1220542d8b77dd9c74b450be16b3ce1aa2cbb49bf711fa7d47dadeb824218513afca0a54953a954c22e569ade5e98053bffc00b7761f983c71ab4698abb9a4b1"} 07:55:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:41 INFO - Contents: 07:55:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a02c3de7128b77b08c5a8f89b4100a844f0a30077e9002a401f6994e15d93baef7e3b8c016dc4a17ecae8c222b43089d7dbcd45b6d41dcc56b7c071b0cdf69a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12aa654f0d69ebea9a5901df89efb004f8412e7610cda4627b1720e5c6804aa3a1f29058ae02ec1ff31ef6f50b4792ca4974d0f5cac2088b98a15da70d9f0f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1220542d8b77dd9c74b450be16b3ce1aa2cbb49bf711fa7d47dadeb824218513afca0a54953a954c22e569ade5e98053bffc00b7761f983c71ab4698abb9a4b1"} 07:55:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:41 INFO - Copying logs to upload dir... 07:55:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.871381 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-15 07:55:41.960498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 07:55:41.963732) ========= 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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a02c3de7128b77b08c5a8f89b4100a844f0a30077e9002a401f6994e15d93baef7e3b8c016dc4a17ecae8c222b43089d7dbcd45b6d41dcc56b7c071b0cdf69a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12aa654f0d69ebea9a5901df89efb004f8412e7610cda4627b1720e5c6804aa3a1f29058ae02ec1ff31ef6f50b4792ca4974d0f5cac2088b98a15da70d9f0f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1220542d8b77dd9c74b450be16b3ce1aa2cbb49bf711fa7d47dadeb824218513afca0a54953a954c22e569ade5e98053bffc00b7761f983c71ab4698abb9a4b1"} build_url:https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010700 build_url: 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a02c3de7128b77b08c5a8f89b4100a844f0a30077e9002a401f6994e15d93baef7e3b8c016dc4a17ecae8c222b43089d7dbcd45b6d41dcc56b7c071b0cdf69a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12aa654f0d69ebea9a5901df89efb004f8412e7610cda4627b1720e5c6804aa3a1f29058ae02ec1ff31ef6f50b4792ca4974d0f5cac2088b98a15da70d9f0f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1220542d8b77dd9c74b450be16b3ce1aa2cbb49bf711fa7d47dadeb824218513afca0a54953a954c22e569ade5e98053bffc00b7761f983c71ab4698abb9a4b1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 07:55:42.004471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:55:42.005126) ========= 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.ZihqnzbVbm/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.PQeN4vmXqW/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.005081 ========= master_lag: 0.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:55:42.522124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 07:55:42.522453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 07:55:42.523229) ========= ========= Total master_lag: 1.05 =========