builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0383 starttime: 1482349087.16 results: success (0) buildid: 20161221092053 builduid: d9cd92c2e1c74995a16a5b9419719058 revision: c3f401e19160ed979541940f21ff70a111cc5972 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.159425) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.159867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.160146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.186171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.186466) ========= 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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-12-21 11:38:07-- 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% 27.1M=0s 2016-12-21 11:38:07 (27.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092713 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.303229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.303540) ========= 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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.024610 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:07.351665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-21 11:38:07.352028) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3f401e19160ed979541940f21ff70a111cc5972 --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 c3f401e19160ed979541940f21ff70a111cc5972 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-12-21 11:38:07,449 truncating revision to first 12 chars 2016-12-21 11:38:07,450 Setting DEBUG logging. 2016-12-21 11:38:07,450 attempt 1/10 2016-12-21 11:38:07,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c3f401e19160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 11:38:09,461 unpacking tar archive at: mozilla-aurora-c3f401e19160/testing/mozharness/ program finished with exit code 0 elapsedTime=2.263263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-21 11:38:09.638775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:09.639120) ========= script_repo_revision: c3f401e19160ed979541940f21ff70a111cc5972 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:09.639502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:09.639780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 11:38:09.659777) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-21 11:38:09.660102) ========= /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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:09 INFO - MultiFileLogger online at 20161221 11:38:09 in /builds/slave/test 11:38:09 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 11:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:09 INFO - {'append_to_log': False, 11:38:09 INFO - 'base_work_dir': '/builds/slave/test', 11:38:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:09 INFO - 'branch': 'Mozilla-Aurora', 11:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:09 INFO - 'config_files': ('talos/mac_config.py',), 11:38:09 INFO - 'default_actions': ('clobber', 11:38:09 INFO - 'read-buildbot-config', 11:38:09 INFO - 'download-and-extract', 11:38:09 INFO - 'populate-webroot', 11:38:09 INFO - 'create-virtualenv', 11:38:09 INFO - 'install', 11:38:09 INFO - 'run-tests'), 11:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:09 INFO - 'download_minidump_stackwalk': True, 11:38:09 INFO - 'download_symbols': 'ondemand', 11:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:09 INFO - 'installer_path': 'installer.exe', 11:38:09 INFO - 'log_level': 'info', 11:38:09 INFO - 'log_name': 'talos', 11:38:09 INFO - 'log_to_console': True, 11:38:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:38:09 INFO - 'opt_config_files': (), 11:38:09 INFO - 'pip_index': False, 11:38:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:38:09 INFO - 'cmd': ('bash', 11:38:09 INFO - '-c', 11:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:38:09 INFO - 'enabled': True, 11:38:09 INFO - 'halt_on_failure': False, 11:38:09 INFO - 'name': 'check_screen_resolution'},), 11:38:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:38:09 INFO - 'cmd': ('bash', 11:38:09 INFO - '-c', 11:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:38:09 INFO - 'enabled': True, 11:38:09 INFO - 'halt_on_failure': False, 11:38:09 INFO - 'name': 'check_screen_resolution'},), 11:38:09 INFO - 'run_cmd_checks_enabled': True, 11:38:09 INFO - 'sps_profile': False, 11:38:09 INFO - 'sps_profile_interval': 0, 11:38:09 INFO - 'suite': 'dromaeojs', 11:38:09 INFO - 'system_bits': '32', 11:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:09 INFO - 'title': 't-yosemite-r7-0383', 11:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:09 INFO - 'use_talos_json': True, 11:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:09 INFO - 'work_dir': 'build'} 11:38:09 INFO - [mozharness: 2016-12-21 19:38:09.865942Z] Running clobber step. 11:38:09 INFO - Running pre-action listener: _resource_record_pre_action 11:38:09 INFO - Running main action method: clobber 11:38:09 INFO - rmtree: /builds/slave/test/build 11:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:12 INFO - Running post-action listener: _resource_record_post_action 11:38:12 INFO - [mozharness: 2016-12-21 19:38:12.151100Z] Finished clobber step (success) 11:38:12 INFO - [mozharness: 2016-12-21 19:38:12.151252Z] Running read-buildbot-config step. 11:38:12 INFO - Running pre-action listener: _resource_record_pre_action 11:38:12 INFO - Running main action method: read_buildbot_config 11:38:12 INFO - Using buildbot properties: 11:38:12 INFO - { 11:38:12 INFO - "project": "", 11:38:12 INFO - "product": "firefox", 11:38:12 INFO - "script_repo_revision": "production", 11:38:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:38:12 INFO - "repository": "", 11:38:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:38:12 INFO - "buildid": "20161221092053", 11:38:12 INFO - "pgo_build": "False", 11:38:12 INFO - "basedir": "/builds/slave/test", 11:38:12 INFO - "buildnumber": 21, 11:38:12 INFO - "slavename": "t-yosemite-r7-0383", 11:38:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:38:12 INFO - "platform": "yosemite_r7", 11:38:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:38:12 INFO - "branch": "mozilla-aurora", 11:38:12 INFO - "repo_path": "releases/mozilla-aurora", 11:38:12 INFO - "revision": "c3f401e19160ed979541940f21ff70a111cc5972", 11:38:12 INFO - "stage_platform": "macosx64", 11:38:12 INFO - "builduid": "d9cd92c2e1c74995a16a5b9419719058", 11:38:12 INFO - "slavebuilddir": "test" 11:38:12 INFO - } 11:38:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 11:38:12 INFO - Running post-action listener: _resource_record_post_action 11:38:12 INFO - [mozharness: 2016-12-21 19:38:12.154499Z] Finished read-buildbot-config step (success) 11:38:12 INFO - [mozharness: 2016-12-21 19:38:12.154632Z] Running download-and-extract step. 11:38:12 INFO - Running pre-action listener: _resource_record_pre_action 11:38:12 INFO - Running main action method: download_and_extract 11:38:12 INFO - mkdir: /builds/slave/test/build/tests 11:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:12 INFO - trying https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 11:38:12 INFO - Downloading https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/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 11:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/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 11:38:13 INFO - Downloaded 1199 bytes. 11:38:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:38:13 INFO - Using the following test package requirements: 11:38:13 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:38:13 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 11:38:13 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 11:38:13 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'jsshell-mac.zip'], 11:38:13 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 11:38:13 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:38:13 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 11:38:13 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 11:38:13 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 11:38:13 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:38:13 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 11:38:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:38:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:38:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:38:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:38:13 INFO - Http code: 200 11:38:13 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 11:38:13 INFO - x-amz-cf-id: veESsfLDgRFSJraL-1gcgbDGEg3xX7rOEmo9zbsQF-lKfyvNAU0bsA== 11:38:13 INFO - x-amz-version-id: favEv2CG.cMET8jBwMqut0_rcQZZKtwz 11:38:14 INFO - Expected file size: 16269681 11:38:14 INFO - Obtained file size: 16269681 11:38:20 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 11:38:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:38:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:38:20 INFO - Fetch https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:38:21 INFO - Http code: 200 11:38:21 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 11:38:21 INFO - x-amz-cf-id: loV5dvgmNbcFWsS8mMdigJ2bWnjv5F5UaNmzUhzjeAnS_4DQOKdnHA== 11:38:21 INFO - x-amz-version-id: favEv2CG.cMET8jBwMqut0_rcQZZKtwz 11:38:21 INFO - Expected file size: 16269681 11:38:21 INFO - Obtained file size: 16269681 11:38:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 11:38:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:38:27 INFO - Fetch https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 11:38:29 INFO - Http code: 200 11:38:29 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 11:38:29 INFO - x-amz-cf-id: R3rRR3Pw0QqjxmK-lyHIfKlmRaxEkblNltFvGfaZ1kVygwdsxleAaw== 11:38:29 INFO - x-amz-version-id: qs_85HPWVw_1y2ETnJmZouQipJWI19B3 11:38:29 INFO - Expected file size: 14409038 11:38:29 INFO - Obtained file size: 14409038 11:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:30 INFO - trying https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:38:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 11:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/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 11:38:33 INFO - Downloaded 109762557 bytes. 11:38:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:38:33 INFO - mkdir: /builds/slave/test/properties 11:38:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:38:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:38:33 INFO - Contents: 11:38:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:38:34 INFO - Running post-action listener: _resource_record_post_action 11:38:34 INFO - Running post-action listener: set_extra_try_arguments 11:38:34 INFO - [mozharness: 2016-12-21 19:38:34.388970Z] Finished download-and-extract step (success) 11:38:34 INFO - [mozharness: 2016-12-21 19:38:34.389146Z] Running populate-webroot step. 11:38:34 INFO - Running pre-action listener: _resource_record_pre_action 11:38:34 INFO - Running main action method: populate_webroot 11:38:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:34 INFO - '--tppagecycles', 11:38:34 INFO - '7'], 11:38:34 INFO - 'tests': ['tsvgm']}}, 11:38:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:38:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:38:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:38:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['damp', 'tps']}, 11:38:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'tests': ['damp', 'tps']}, 11:38:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['dromaeo_dom']}, 11:38:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['basic_compositor_video']}, 11:38:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:38:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['a11yr', 11:38:34 INFO - 'ts_paint', 11:38:34 INFO - 'tpaint', 11:38:34 INFO - 'sessionrestore', 11:38:34 INFO - 'sessionrestore_no_auto_restore', 11:38:34 INFO - 'tabpaint']}, 11:38:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:38:34 INFO - 'ts_paint', 11:38:34 INFO - 'tpaint', 11:38:34 INFO - 'sessionrestore', 11:38:34 INFO - 'sessionrestore_no_auto_restore', 11:38:34 INFO - 'tabpaint']}, 11:38:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:38:34 INFO - 'ts_paint', 11:38:34 INFO - 'tpaint', 11:38:34 INFO - 'sessionrestore', 11:38:34 INFO - 'sessionrestore_no_auto_restore', 11:38:34 INFO - 'tabpaint']}, 11:38:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:38:34 INFO - 'ts_paint', 11:38:34 INFO - 'tpaint', 11:38:34 INFO - 'sessionrestore', 11:38:34 INFO - 'sessionrestore_no_auto_restore', 11:38:34 INFO - 'tabpaint']}, 11:38:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['a11yr', 11:38:34 INFO - 'ts_paint', 11:38:34 INFO - 'tpaint', 11:38:34 INFO - 'sessionrestore', 11:38:34 INFO - 'sessionrestore_no_auto_restore', 11:38:34 INFO - 'tabpaint']}, 11:38:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['a11yr', 11:38:34 INFO - 'ts_paint', 11:38:34 INFO - 'tpaint', 11:38:34 INFO - 'sessionrestore', 11:38:34 INFO - 'sessionrestore_no_auto_restore', 11:38:34 INFO - 'tabpaint']}, 11:38:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['tsvgx', 11:38:34 INFO - 'tsvgr_opacity', 11:38:34 INFO - 'tart', 11:38:34 INFO - 'tscrollx', 11:38:34 INFO - 'cart']}, 11:38:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:38:34 INFO - 'tsvgr_opacity', 11:38:34 INFO - 'tart', 11:38:34 INFO - 'tscrollx', 11:38:34 INFO - 'cart']}, 11:38:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'talos_options': ['--disable-e10s'], 11:38:34 INFO - 'tests': ['tp5o']}, 11:38:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'tests': ['tp5o']}, 11:38:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'talos_options': ['--disable-e10s', 11:38:34 INFO - '--xperf_path', 11:38:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:34 INFO - 'tests': ['tp5n']}, 11:38:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:34 INFO - 'talos_options': ['--xperf_path', 11:38:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:34 INFO - 'tests': ['tp5n']}}, 11:38:34 INFO - 'talos.zip': {'path': '', 11:38:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:34 INFO - Running post-action listener: _resource_record_post_action 11:38:34 INFO - [mozharness: 2016-12-21 19:38:34.410007Z] Finished populate-webroot step (success) 11:38:34 INFO - [mozharness: 2016-12-21 19:38:34.410152Z] Running create-virtualenv step. 11:38:34 INFO - Running pre-action listener: _resource_record_pre_action 11:38:34 INFO - Running main action method: create_virtualenv 11:38:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:38:34 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 11:38:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:38:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:34 INFO - Using real prefix '/tools/python27' 11:38:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:38:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:38:38 INFO - Installing pip.................done. 11:38:38 INFO - Return code: 0 11:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:38:38 INFO - Reading from file tmpfile_stdout 11:38:38 INFO - Output received: 11:38:38 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) 11:38:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:38:38 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')]} 11:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:38 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')]} 11:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:38 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:38 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 11:38:38 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 11:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:38 INFO - 'HOME': '/Users/cltbld', 11:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:38 INFO - 'LOGNAME': 'cltbld', 11:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:38 INFO - 'MOZ_NO_REMOTE': '1', 11:38:38 INFO - 'NO_EM_RESTART': '1', 11:38:38 INFO - 'PAGER': '/bin/cat', 11:38:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:38 INFO - 'PWD': '/builds/slave/test', 11:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:38 INFO - 'SHELL': '/bin/bash', 11:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:38 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:38 INFO - 'USER': 'cltbld', 11:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:38 INFO - 'XPC_FLAGS': '0x0', 11:38:38 INFO - 'XPC_SERVICE_NAME': '0', 11:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:38 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 11:38:38 INFO - Cleaning up... 11:38:38 INFO - Return code: 0 11:38:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:38:38 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')]} 11:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:38 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')]} 11:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:38 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:38 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 11:38:38 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 11:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:38 INFO - 'HOME': '/Users/cltbld', 11:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:38 INFO - 'LOGNAME': 'cltbld', 11:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:38 INFO - 'MOZ_NO_REMOTE': '1', 11:38:38 INFO - 'NO_EM_RESTART': '1', 11:38:38 INFO - 'PAGER': '/bin/cat', 11:38:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:38 INFO - 'PWD': '/builds/slave/test', 11:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:38 INFO - 'SHELL': '/bin/bash', 11:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:38 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:38 INFO - 'USER': 'cltbld', 11:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:38 INFO - 'XPC_FLAGS': '0x0', 11:38:38 INFO - 'XPC_SERVICE_NAME': '0', 11:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:38 INFO - Downloading/unpacking psutil>=3.1.1 11:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:42 INFO - Installing collected packages: psutil 11:38:42 INFO - Running setup.py install for psutil 11:38:42 INFO - building 'psutil._psutil_osx' extension 11:38:42 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 11:38:43 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 11:38:43 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 11:38:43 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 11:38:43 INFO - building 'psutil._psutil_posix' extension 11:38:43 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 11:38:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:38:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:38:43 INFO - ^ 11:38:43 INFO - 1 warning generated. 11:38:43 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 11:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:43 INFO - Successfully installed psutil 11:38:43 INFO - Cleaning up... 11:38:43 INFO - Return code: 0 11:38:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:38:43 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')]} 11:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:43 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')]} 11:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:43 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:43 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 11:38:43 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 11:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:43 INFO - 'HOME': '/Users/cltbld', 11:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:43 INFO - 'LOGNAME': 'cltbld', 11:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:43 INFO - 'MOZ_NO_REMOTE': '1', 11:38:43 INFO - 'NO_EM_RESTART': '1', 11:38:43 INFO - 'PAGER': '/bin/cat', 11:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:43 INFO - 'PWD': '/builds/slave/test', 11:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:43 INFO - 'SHELL': '/bin/bash', 11:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:43 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:43 INFO - 'USER': 'cltbld', 11:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:43 INFO - 'XPC_FLAGS': '0x0', 11:38:43 INFO - 'XPC_SERVICE_NAME': '0', 11:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:38:43 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 11:38:43 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 11:38:43 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 11:38:43 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 11:38:43 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 11:38:43 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 11:38:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:46 INFO - Installing collected packages: mozsystemmonitor 11:38:46 INFO - Running setup.py install for mozsystemmonitor 11:38:46 INFO - Successfully installed mozsystemmonitor 11:38:46 INFO - Cleaning up... 11:38:46 INFO - Return code: 0 11:38:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:46 INFO - 'HOME': '/Users/cltbld', 11:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:46 INFO - 'LOGNAME': 'cltbld', 11:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:46 INFO - 'MOZ_NO_REMOTE': '1', 11:38:46 INFO - 'NO_EM_RESTART': '1', 11:38:46 INFO - 'PAGER': '/bin/cat', 11:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:46 INFO - 'PWD': '/builds/slave/test', 11:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:46 INFO - 'SHELL': '/bin/bash', 11:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:46 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:46 INFO - 'USER': 'cltbld', 11:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:46 INFO - 'XPC_FLAGS': '0x0', 11:38:46 INFO - 'XPC_SERVICE_NAME': '0', 11:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:47 INFO - Downloading/unpacking jsonschema==2.5.1 11:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:38:49 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 11:38:49 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 11:38:49 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 11:38:49 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 11:38:49 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 11:38:49 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 11:38:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:38:50 INFO - warning: no files found matching '*.txt' 11:38:50 INFO - no previously-included directories found matching 'build' 11:38:50 INFO - no previously-included directories found matching 'dist' 11:38:50 INFO - no previously-included directories found matching '.git*' 11:38:50 INFO - Installing collected packages: jsonschema, functools32 11:38:50 INFO - Running setup.py install for functools32 11:38:50 INFO - warning: no files found matching '*.txt' 11:38:50 INFO - no previously-included directories found matching 'build' 11:38:50 INFO - no previously-included directories found matching 'dist' 11:38:50 INFO - no previously-included directories found matching '.git*' 11:38:50 INFO - Successfully installed jsonschema functools32 11:38:50 INFO - Cleaning up... 11:38:50 INFO - Return code: 0 11:38:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:50 INFO - 'HOME': '/Users/cltbld', 11:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:50 INFO - 'LOGNAME': 'cltbld', 11:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:50 INFO - 'MOZ_NO_REMOTE': '1', 11:38:50 INFO - 'NO_EM_RESTART': '1', 11:38:50 INFO - 'PAGER': '/bin/cat', 11:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:50 INFO - 'PWD': '/builds/slave/test', 11:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:50 INFO - 'SHELL': '/bin/bash', 11:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:50 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:50 INFO - 'USER': 'cltbld', 11:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:50 INFO - 'XPC_FLAGS': '0x0', 11:38:50 INFO - 'XPC_SERVICE_NAME': '0', 11:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:38:50 INFO - Cleaning up... 11:38:50 INFO - Return code: 0 11:38:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:50 INFO - 'HOME': '/Users/cltbld', 11:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:50 INFO - 'LOGNAME': 'cltbld', 11:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:50 INFO - 'MOZ_NO_REMOTE': '1', 11:38:50 INFO - 'NO_EM_RESTART': '1', 11:38:50 INFO - 'PAGER': '/bin/cat', 11:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:50 INFO - 'PWD': '/builds/slave/test', 11:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:50 INFO - 'SHELL': '/bin/bash', 11:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:50 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:50 INFO - 'USER': 'cltbld', 11:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:50 INFO - 'XPC_FLAGS': '0x0', 11:38:50 INFO - 'XPC_SERVICE_NAME': '0', 11:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:51 INFO - Downloading/unpacking blobuploader==1.2.4 11:38:51 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 11:38:51 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 11:38:51 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 11:38:51 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 11:38:51 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 11:38:51 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 11:38:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:38:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:38: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 11:38: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 11:38: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 11:38: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 11:38: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 11:38: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 11:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:38:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:38:54 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 11:38:54 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 11:38:54 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 11:38:54 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 11:38:54 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 11:38:54 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 11:38:54 INFO - Downloading docopt-0.6.1.tar.gz 11:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:38:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:38:55 INFO - Running setup.py install for blobuploader 11:38:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:38:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:38:55 INFO - Running setup.py install for requests 11:38:55 INFO - Running setup.py install for docopt 11:38:55 INFO - Successfully installed blobuploader requests docopt 11:38:55 INFO - Cleaning up... 11:38:55 INFO - Return code: 0 11:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:55 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')]} 11:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:55 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')]} 11:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:55 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:38:55 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 11:38:55 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 11:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:55 INFO - 'HOME': '/Users/cltbld', 11:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:55 INFO - 'LOGNAME': 'cltbld', 11:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:55 INFO - 'MOZ_NO_REMOTE': '1', 11:38:55 INFO - 'NO_EM_RESTART': '1', 11:38:55 INFO - 'PAGER': '/bin/cat', 11:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:55 INFO - 'PWD': '/builds/slave/test', 11:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:55 INFO - 'SHELL': '/bin/bash', 11:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:38:55 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:55 INFO - 'USER': 'cltbld', 11:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:55 INFO - 'XPC_FLAGS': '0x0', 11:38:55 INFO - 'XPC_SERVICE_NAME': '0', 11:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-FQATB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-6Gody9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-M_fvl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Onmx4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-tTC2ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-kYnjZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-zgQlyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:56 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-JKiPl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-0___RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Vy6HEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-E9p1me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-IkbYmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-PvuCHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-4dVxYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-aN5ILq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-GfS7n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:57 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-3o6nxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:38:58 INFO - Running setup.py install for manifestparser 11:38:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:38:58 INFO - Running setup.py install for mozcrash 11:38:58 INFO - Running setup.py install for mozdebug 11:38:58 INFO - Running setup.py install for mozdevice 11:38:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:38:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:38:58 INFO - Running setup.py install for mozfile 11:38:58 INFO - Running setup.py install for mozhttpd 11:38:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:38:58 INFO - Running setup.py install for mozinfo 11:38:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Running setup.py install for mozInstall 11:38:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Running setup.py install for mozleak 11:38:59 INFO - Running setup.py install for mozlog 11:38:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Running setup.py install for moznetwork 11:38:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Running setup.py install for mozprocess 11:38:59 INFO - Running setup.py install for mozprofile 11:38:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:38:59 INFO - Running setup.py install for mozrunner 11:39:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:00 INFO - Running setup.py install for mozscreenshot 11:39:00 INFO - Running setup.py install for moztest 11:39:00 INFO - Running setup.py install for mozversion 11:39:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:00 INFO - Cleaning up... 11:39:00 INFO - Return code: 0 11:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:00 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')]} 11:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:00 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')]} 11:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:00 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:39:00 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 11:39:00 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 11:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:00 INFO - 'HOME': '/Users/cltbld', 11:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:00 INFO - 'LOGNAME': 'cltbld', 11:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:00 INFO - 'MOZ_NO_REMOTE': '1', 11:39:00 INFO - 'NO_EM_RESTART': '1', 11:39:00 INFO - 'PAGER': '/bin/cat', 11:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:00 INFO - 'PWD': '/builds/slave/test', 11:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:00 INFO - 'SHELL': '/bin/bash', 11:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:39:00 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:00 INFO - 'USER': 'cltbld', 11:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:00 INFO - 'XPC_FLAGS': '0x0', 11:39:00 INFO - 'XPC_SERVICE_NAME': '0', 11:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:00 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-5bomAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:00 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)) 11:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:00 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-PWGeJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-yNBabK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-GBoozi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-pDoRYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-T7VhBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-QpzXvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-hqtb7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-meQZko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-cKgNGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:01 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)) 11:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:01 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-abkKPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:02 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)) 11:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:02 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-q0VAy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:02 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)) 11:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:02 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-AjwIv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:02 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)) 11:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:02 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-XkNWlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:02 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)) 11:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:02 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Hmfwf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:02 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)) 11:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:02 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-TtWQij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:02 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)) 11:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:02 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-BBIEEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:02 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)) 11:39:02 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)) 11:39:02 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)) 11:39:02 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)) 11:39:02 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)) 11:39:02 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)) 11:39:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:02 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 11:39:02 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 11:39:02 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 11:39:02 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 11:39:02 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 11:39:02 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 11:39:05 INFO - Downloading blessings-1.6.tar.gz 11:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:05 INFO - Installing collected packages: blessings 11:39:05 INFO - Running setup.py install for blessings 11:39:05 INFO - Successfully installed blessings 11:39:05 INFO - Cleaning up... 11:39:06 INFO - Return code: 0 11:39:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:06 INFO - Reading from file tmpfile_stdout 11:39:06 INFO - Current package versions: 11:39:06 INFO - blessings == 1.6 11:39:06 INFO - blobuploader == 1.2.4 11:39:06 INFO - docopt == 0.6.1 11:39:06 INFO - functools32 == 3.2.3-2 11:39:06 INFO - jsonschema == 2.5.1 11:39:06 INFO - manifestparser == 1.1 11:39:06 INFO - mozInstall == 1.12 11:39:06 INFO - mozcrash == 1.0 11:39:06 INFO - mozdebug == 0.1 11:39:06 INFO - mozdevice == 0.48 11:39:06 INFO - mozfile == 1.2 11:39:06 INFO - mozhttpd == 0.7 11:39:06 INFO - mozinfo == 0.9 11:39:06 INFO - mozleak == 0.1 11:39:06 INFO - mozlog == 3.4 11:39:06 INFO - moznetwork == 0.27 11:39:06 INFO - mozprocess == 0.23 11:39:06 INFO - mozprofile == 0.28 11:39:06 INFO - mozrunner == 6.13 11:39:06 INFO - mozscreenshot == 0.1 11:39:06 INFO - mozsystemmonitor == 0.3 11:39:06 INFO - moztest == 0.7 11:39:06 INFO - mozversion == 1.4 11:39:06 INFO - psutil == 3.1.1 11:39:06 INFO - requests == 1.2.3 11:39:06 INFO - wsgiref == 0.1.2 11:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:06 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')]} 11:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:06 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')]} 11:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:06 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:39:06 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 11:39:06 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 11:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:06 INFO - 'HOME': '/Users/cltbld', 11:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:06 INFO - 'LOGNAME': 'cltbld', 11:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:06 INFO - 'MOZ_NO_REMOTE': '1', 11:39:06 INFO - 'NO_EM_RESTART': '1', 11:39:06 INFO - 'PAGER': '/bin/cat', 11:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:06 INFO - 'PWD': '/builds/slave/test', 11:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:06 INFO - 'SHELL': '/bin/bash', 11:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:39:06 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:06 INFO - 'USER': 'cltbld', 11:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:06 INFO - 'XPC_FLAGS': '0x0', 11:39:06 INFO - 'XPC_SERVICE_NAME': '0', 11:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 INFO - Cleaning up... 11:39:06 INFO - Return code: 0 11:39:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:06 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')]} 11:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:06 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')]} 11:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:06 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 0x107ad6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a4c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7bd5ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, '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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 11:39:06 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 11:39:06 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 11:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:06 INFO - 'HOME': '/Users/cltbld', 11:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:06 INFO - 'LOGNAME': 'cltbld', 11:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:06 INFO - 'MOZ_NO_REMOTE': '1', 11:39:06 INFO - 'NO_EM_RESTART': '1', 11:39:06 INFO - 'PAGER': '/bin/cat', 11:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:06 INFO - 'PWD': '/builds/slave/test', 11:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:06 INFO - 'SHELL': '/bin/bash', 11:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:39:06 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:06 INFO - 'USER': 'cltbld', 11:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:06 INFO - 'XPC_FLAGS': '0x0', 11:39:06 INFO - 'XPC_SERVICE_NAME': '0', 11:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:07 INFO - Cleaning up... 11:39:07 INFO - Return code: 0 11:39:07 INFO - Running post-action listener: _resource_record_post_action 11:39:07 INFO - Running post-action listener: _start_resource_monitoring 11:39:07 INFO - Starting resource monitoring. 11:39:07 INFO - [mozharness: 2016-12-21 19:39:07.266269Z] Finished create-virtualenv step (success) 11:39:07 INFO - [mozharness: 2016-12-21 19:39:07.267341Z] Running install step. 11:39:07 INFO - Running pre-action listener: _resource_record_pre_action 11:39:07 INFO - Running main action method: install 11:39:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:07 INFO - Reading from file tmpfile_stdout 11:39:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:07 INFO - Reading from file tmpfile_stdout 11:39:07 INFO - Output received: 11:39:07 INFO - Usage: mozinstall [options] installer 11:39:07 INFO - Options: 11:39:07 INFO - -h, --help show this help message and exit 11:39:07 INFO - -d DEST, --destination=DEST 11:39:07 INFO - Directory to install application into. [default: 11:39:07 INFO - "/builds/slave/test"] 11:39:07 INFO - --app=APP Application being installed. [default: firefox] 11:39:07 INFO - mkdir: /builds/slave/test/build/application 11:39:07 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'] 11:39:07 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 11:39:38 INFO - Reading from file tmpfile_stdout 11:39:38 INFO - Output received: 11:39:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:39:38 INFO - Running post-action listener: _resource_record_post_action 11:39:38 INFO - [mozharness: 2016-12-21 19:39:38.570830Z] Finished install step (success) 11:39:38 INFO - [mozharness: 2016-12-21 19:39:38.570973Z] Running run-tests step. 11:39:38 INFO - Running pre-action listener: _resource_record_pre_action 11:39:38 INFO - Running main action method: run_tests 11:39:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:39:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:39:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:39:38 INFO - 2016-12-21 11:39:38.585 screenresolution[1623:7323] starting screenresolution argv=screenresolution get 11:39:38 INFO - 2016-12-21 11:39:38.587 screenresolution[1623:7323] Display 0: 1600x1200x32@60 11:39:38 INFO - 2016-12-21 11:39:38.593 screenresolution[1624:7325] starting screenresolution argv=screenresolution list 11:39:38 INFO - Available Modes on Display 0 11:39:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:39:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:39:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:39:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:39:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:39:38 INFO - Intel Iris: 11:39:38 INFO - Chipset Model: Intel Iris 11:39:38 INFO - Type: GPU 11:39:38 INFO - Bus: Built-In 11:39:38 INFO - VRAM (Dynamic, Max): 1536 MB 11:39:38 INFO - Vendor: Intel (0x8086) 11:39:38 INFO - Device ID: 0x0a2e 11:39:38 INFO - Revision ID: 0x0009 11:39:38 INFO - Displays: 11:39:38 INFO - Display: 11:39:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:39:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:39:38 INFO - Display Serial Number: 1600x1200 60 11:39:38 INFO - Main Display: Yes 11:39:38 INFO - Mirror: Off 11:39:38 INFO - Online: Yes 11:39:38 INFO - Rotation: Supported 11:39:38 INFO - Return code: 0 11:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:38 INFO - Python 2.7.3 11:39:38 INFO - Return code: 0 11:39:38 INFO - grabbing minidump binary from tooltool 11:39:38 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')]} 11:39:38 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 0x1078ead30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:38 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 11:39:38 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 11:39:38 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 11:39:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:38 INFO - Return code: 0 11:39:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:39:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:39:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:38 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/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 11:39:38 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/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0383 --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 11:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MVMC1RS2Hl/Render', 11:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:38 INFO - 'HOME': '/Users/cltbld', 11:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:38 INFO - 'LOGNAME': 'cltbld', 11:39:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:38 INFO - 'MOZ_NO_REMOTE': '1', 11:39:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:38 INFO - 'NO_EM_RESTART': '1', 11:39:38 INFO - 'PAGER': '/bin/cat', 11:39:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:38 INFO - 'PWD': '/builds/slave/test', 11:39:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:38 INFO - 'SHELL': '/bin/bash', 11:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gp9Z1UykCB/Listeners', 11:39:38 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 11:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:38 INFO - 'USER': 'cltbld', 11:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:38 INFO - 'XPC_FLAGS': '0x0', 11:39:38 INFO - 'XPC_SERVICE_NAME': '0', 11:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:38 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/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 11:39:39 INFO - mozversion application_buildid: 20161221092053 11:39:39 INFO - mozversion application_changeset: c3f401e19160ed979541940f21ff70a111cc5972 11:39:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:39:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:39 INFO - mozversion application_name: Firefox 11:39:39 INFO - mozversion application_remotingname: firefox-dev 11:39:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:39:39 INFO - mozversion application_vendor: Mozilla 11:39:39 INFO - mozversion application_version: 52.0a2 11:39:39 INFO - mozversion platform_buildid: 20161221092053 11:39:39 INFO - mozversion platform_changeset: c3f401e19160ed979541940f21ff70a111cc5972 11:39:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:39:39 INFO - mozversion platform_version: 52.0a2 11:39:39 INFO - using testdate: 1482349179 11:39:39 INFO - actual date: 1482349179 11:39:39 INFO - starting webserver on 'localhost:49236' 11:39:39 INFO - SUITE-START | Running 2 tests 11:39:39 INFO - TEST-START | dromaeo_css 11:39:39 INFO - operating with platform_type : mac_ 11:39:39 INFO - Initialising browser for dromaeo_css test... 11:39:39 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpgN7qmz/profile http://localhost:49236/getInfo.html) 11:39:42 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 11:39:42 INFO - PROCESS | 1634 | colorDepth:24 11:39:42 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 11:39:42 INFO - PROCESS | 1634 | __metrics 11:39:42 INFO - PROCESS | 1634 | 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" 11:39:42 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:43 INFO - TEST-INFO | 1634: exit 0 11:39:43 INFO - Browser initialized. 11:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:43 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpgN7qmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:55 INFO - PROCESS | 1636 | RSS: Main: 222134272 11:39:55 INFO - PROCESS | 1636 | 11:40:46 INFO - PROCESS | 1636 | 1482349246336 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] 11:43:01 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 11:43:03 INFO - PROCESS | 1636 | RSS: Main: 390844416 11:43:03 INFO - PROCESS | 1636 | 11:46:06 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 11:46:06 INFO - PROCESS | 1636 | RSS: Main: 345952256 11:46:06 INFO - PROCESS | 1636 | 11:49:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 11:49:09 INFO - PROCESS | 1636 | RSS: Main: 345878528 11:49:09 INFO - PROCESS | 1636 | 11:52:11 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 11:52:12 INFO - PROCESS | 1636 | RSS: Main: 319520768 11:52:12 INFO - PROCESS | 1636 | 11:55:15 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 11:55:16 INFO - PROCESS | 1636 | RSS: Main: 308244480 11:55:16 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 11:58:19 INFO - PROCESS | 1636 | RSS: Main: 363454464 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | __start_tp_report 11:58:19 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 11:58:19 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 11:58:19 INFO - PROCESS | 1636 | |i|pagename|runs| 11:58:19 INFO - PROCESS | 1636 | |0;dojo.html;2513.824032317738;3276.8689252429904;3303.7852539584924;3317.8387564352465;3321.3689399014183;5464.4262352453015;5519.254900588419;5522.530584900288;5570.2480165177685;5576.219329293902;5419.810306639269;5436.891262174754;5436.91844622331;5457.181422786584;5467.480589344016;5006.474320196382;5007.549320561149;5034.471380505049;5115.360579927509;5128.435872054071;5036.7481625918745;5042.546170844624;5056.014077254937;5135.794568217267;5143.639945203838;5092.185250359943;5125.794968201268;5139.306193663845;5149.562287205592;5153;5126.487351264881;5141.100307446182;5141.665791723563;5144.84565463033;5145.536901678867;4998.050370429643;5098.770555325019;5111.642185047048;5112.079825631385;5117.769700363456;5581.10702287632;5590.8043218487155;5593.916091258634;5596.188552659842;5599.272094627713;5926.259217597801;5962;5964.552658550582;5964.956132676808;5979.342272350038;5049.64652474327;6057.757689692407;6059.6364218147055;6071.666058366788;6075.574709770318;4639.257718765015;5539.390667026624;5544.002079625666;5590.161475778625;5596.4123767004285;6269.529785266078;6275.18422605063;6280.277768056732;6286.994080947026;6300.180976473121;5636.154576813429;5698.601097923106;5708.1723150143;5771.336296325892;5805.912911306334;6016.879662406727;6037.9433599119975;6042.093685947143;6049.697515124226;6061.151438798572;6020.939790602126;6034.818955431344;6038.939610603926;6050.42520960508;6089.786857460056;5866.560007999417;5894.793682221101;5913.113033045078;5918.763249470059;6068.968275393194;4797.784099715521;4809.687370320988;4818.180909245437;4818.301346304766;4820.903581928342;4317.84887528935;4319.114581510783;4324.005478739908;4337.414449049401;4347.673924455678;5611.607187496836;5669;5743.942560574341;5763.221965034667;5782.797602083991;6039.698015099228;6043.395660433922;6097.420745029215;6098.969505152535;6102.420270074336;5721.542276617944;5727.083666613322;5729.312482502043;5729.369769325371;5730.111832665943;4265.786710664516;5202.843914682566;5242.554382877498;5252.632315737938;5259.237410575445;5289.973550132225;6250.687465626791;6269.247690277196;6281.497480201573;6287.993920972623;6041.516678665784;6081.422264884829;6089.756409743561;6090.451859332504;6097.725602347817;6168.938310616836;6283.183186185766;6286;6289;6307.306196318493;4506.1213063452315;5985.461308482258;5986.970065149646;6004.8799024020145;6034.517238620988;5941.673207973603;6077.453029227391;6090.665013424305;6103.511719062376;6105.450509453993;5509.146082357241;5691.772329106955;5757.165211044459;5772.451617096369;5798.1302804579655;4936.605071594192;5828.300603927556;5858.531317494505;5938.109283607493;5985.6408615483215;5648.661080335193;5798.159266906359;5798.884022319446;5811.709414529341;5841;5924.4667979882015;5928.644281343133;5933.970330148321;5942.257217847769;5943.58394912352;5636.718164091697;5676.375598684224;5688.345840228261;5726;5734.139879018181 11:58:19 INFO - PROCESS | 1636 | |1;ext.html;452.7713504680136;518.4530320511858;527.0591993291974;531.0838803064713;534.7780321964312;25221;29828.70171298289;30848.228794280127;37822;39033.60966390342;39476.60523394765;39930.602428914994;39955.20089598206;40047.799761001224;40114.79942600283;9215.58529866156;9396.389234699722;9401;9407.482588457631;9410.153086222239;9280.582373793162;9399;9400.952995235015;9403.153716165543;9414.105659962293;9362.859557106649;9403.294752893526;9421.15209631133;9434.764130896714;9453.716388508321;9317.627294908196;9387.10822471871;9397.436153830724;9403.670871519498;9412.294077944112;9201.953990230006;9281.53592320388;9284.25725941923;9306.53467326631;9324.86012709803;38045.429318560244;38308.04229894247;38397.23205535902;38422;38467.42298865519;3261.575995120619;3322.352141332441;3491.825408729553;3562.1806984393734;3690.944635830465;27661.585076223873;27776.888924443;27920;29081;29560.70439295601;2622.9213123606323;3158.3051728619666;3168.7940283881476;3186.617605887285;3207.294395233045;479930;480129;480280;480407;481060;32120.03639890807;53979.460205397445;54414.639634009465;54528.727356362964;54590.72704636451;33074.503882441786;34147.829260853534;34182;34223;34286.314273714386;13732.862671373357;13850.376733047036;13857.584272471842;13859.584212473643;13884.51404200848;11691.473883675086;11760.58837940668;11775.587854425054;11782.705432364259;11798.646040618623;7650.655720492591;7694.807629809187;7763.573003484749;7781;7784.9610751945875;2915.3731947631363;3223.854926528312;3266.4936934775146;3271.329377477611;3272.5254838048827;924.5007695844304;936.6534382278601;1007.5868893753526;1014.5130337438071;1123.1913022623862;22756.544869102527;28248;28879.42241155165;28980;29012.85493572561;997.2221667099674;1011.7420057885192;1094.9069329106956;1120.199057673751;1129.8870112988636;14469.421223151166;14919.552413427615;14936.551903442914;15219.467318643794;15230.46693365749;652731;658959.7052014709;659808;660464;660952;53565;54050;54079.72960135253;54121.72939135279;54336.72831635895;1222.3277197541317;1261.5458434963407;1293.2563775828935;1350.959471215865;1370.9588712338646;28395.574066388606;29222.977195798045;29396.853015734785;29894.701052989192;29991.70008299889;45211.773941130086;45700.314495281935;45722.08555828798;45781.31328030016;45813.31280030736;496034;498610;504906;508503;509057;18753.90623046876;21816.781832181474;23096.653550197098;23156.07375704953;25330;42919.7854010728;43211.56788432076;43520.56479435165;43585.78207109071;43596.34605480984;35946.28107437785;36529;36612.633873660925;36707.81646091752;36848.63151368452;36244.81877590595;36488.31417720091;36600;37443.62556374401;37814.810925945196;35049;35225.11937201488;35245;35787.10532236715;36128.27743445169;30809.69190308158;32321.707131715408;32437.67562324441;32478.512822308156;32704.34591308208;24213.515729684954;24498.387540311636;24722.752772472046;24856.627150593118;24994.000239990197 11:58:19 INFO - PROCESS | 1636 | |2;jquery.html;373.2199702621521;374.29071908732953;385.9150986782907;397.42373558340415;404.93723472861717;18256.26974921003;19952.60094798103;19986.100625471852;20404.285849995253;20578.48553786156;16255.431059912906;16660.137363318547;19971.301004464847;20070;20452.38642840717;4747.572718455338;5721.34204566476;5965.46310832025;5982.61113027654;5983.611065280765;5809.419058094199;5875.9118613220835;5922.763089476437;5928.496077833368;5939.287285525743;5221.21681747739;5551.694656793875;5784.884302313952;5846.064629659255;5880.852978675546;5760.36635970043;5813.941860581383;5814.098814683731;5816.709164541777;5821.010428227211;3733.869314574004;4223.809928553192;5045.798168073273;5153.969206158783;5158.664686795346;24512.387190320205;24556.754432455804;25026.874865625738;25030.123945661995;25323;2293.9655905161435;2376.0258294099335;2406.602910519762;2446;2912.4175164966878;13692.931535342259;15038.54884353471;15467.149306788235;15469.613259668486;15854.603634909105;1812.1392338639173;1858.1916866163263;1868.093974422404;1883.256113835041;1939.350317643591;120520.39739801333;122218;122805;123063;123305.38347308295;7726.806829829299;8003.239692229346;10532.89467105319;10677.199210059276;11289.435528223556;13350.532731354357;13368;13375.063745537718;13382.996275279393;13419.194848309133;8200.58997050145;8251.2986396157;8302.958485207535;8333.499990000619;8452.61963211657;7675.884861727079;8299.253067223979;8320;8473.025602055719;8484.787880303042;6121.418465245794;6589.604623722592;6593.505487088488;6594.373534514213;6601.141851559362;1787.8122797106378;1824.5894673698576;1831.102759647763;1836.8622353323287;1855.7123645834918;700.5131433653562;713.6228518116075;920.1994264989369;947.8530827721714;1036.9481525923825;20882.791172088084;20944;21394.893025534773;21869.368807247796;22009.66985495219;954.0411886054471;962.4225464721111;983.9950800245953;984.3995162950595;1009.4347165587294;10653.84019239712;11091.168162387854;11249.550017999189;11289.983901448744;11303.321800691985;614538;616077;619327;635224;636232.8188359028;82662;85893.57053214694;112563;133025.33487332502;135470;955.9808803823885;984.7882705218412;998.7652901568125;1011.8229309870891;1012.367270455965;18509.629807403508;18583.25666973306;19037.524061898563;19285.93927333954;19356.612867742286;56432.30703078914;56895.57761056007;57052.144217837595;58073.128903067336;58259.70870145622;68530.94407167794;82214.17785822065;82515.76226356729;83432.7485087712;84334.73497897659;7827.373810095292;7867.055953285642;7937.404694647809;8430.662773488992;8456.2812160967;9238.722838314861;11891.464884080064;12701.93649031749;13264.734705306033;13283.402246899106;10974.945125274322;10980.835287470854;11045.061169800658;11431.028362589273;11491.770164596828;9596.376235544667;10834.783304333712;10975.83536246941;11112.833307500232;11555.133364997491;10888.07451366611;10956.561737530728;11452.3701196435;11505.942470287595;11802.232854864405;7045.471589630695;7447.739329123671;7449.92550074514;8087.393445491494;8215.548144852091;10592.205584581341;11033.944830275797;11088.501017454395;11168.274062185932;11520.88479115198 11:58:19 INFO - PROCESS | 1636 | |3;mootools.html;1443.74012677718;1475.2992328643895;1592.1163754116467;1760.6654735600243;1798.8470979966703;6907.930920690792;8382;8398.244158025784;8403.957980210105;8414.074451810297;7146.571205727647;7453;7738.18749031352;7738.574378409199;8121.634526446309;2204;2236.2173239366252;2239.5744808486334;2250.336150835499;2250.5386395788905;1948.8928108954;2250.797428231459;2273.6816845641624;2283.4633861042644;2286.4055345610177;2254.199759085526;2279.817614590837;2280.1107568048474;2314.259436980167;2350.753170917055;2301.5857145713767;2307.515421761432;2327.9883600582057;2330.7203135623836;2336.894839732216;2196.088623221361;2207.701960235364;2208.8232941364654;2209.2709405896017;2210.502636906683;8226.341892648574;8392.118827523083;8395.412321137523;8403.789905252357;8424.705135320235;5089.185730283174;5222;5230.8692282692855;5231.424543300234;5237.13587258102;3252.788568743024;3264.951025734616;3532.3288575170636;3548.822558872072;3568.107973006748;989.50030234731;1001.6293971230691;1004.3020101029787;1075.575147816608;1081.8160912644792;10816.513256903458;10829.241953063289;10942.507587158598;10947.56209751609;10969.83545246822;3797.867074652374;4628.722276663411;4740.810367585327;4740.95259047412;4749.1926372516755;9362;9378.249740020781;9447.622095116118;9460.763480912894;9470.573824177929;5213.765380557884;5228.529432351107;5232.686038837682;5234.371875374979;5235.424103348705;4248.85129020489;4536.228841097021;4757.405324334458;4789.3294938708605;4822.348982887335;3410.4543273076188;3770.7171962102952;3775.207206486614;3871.2257548490416;3890.513685789276;1072.624581396505;1254.1095821966505;1258.1947553565726;1265.7721610110084;1270.783966725659;762.3862790453738;857.9828403431897;901.7925877048316;907.2016625369764;910.3581974707815;5469.671819690751;5520;5579.576793987588;5736.225609542742;5858.47273745365;955.5986485676033;981.3032746749744;994.8955359687128;1005.527402121002;1012.711377257478;3609.8556057757396;3664.2488289900507;3754.755940863835;3771.7944491891344;3839.827207775657;9718.222542196607;10159.238057145743;10181.33821301613;10184.745381365525;10201.795964080677;9491.193248573949;9940.25448091396;9948;10063.597456101821;10075.496225188712;6335.936640633627;7801.985741853637;7823.139454659983;7823.960880195449;7831.882521762178;5585.106382978866;5648.237487939075;5656.123300888369;5659.26429564154;5811.186433899173;9280.535973201448;9305.209057230211;9431.434113953184;9433.198178154658;9437.103475169848;9199.26405887514;9437.339386242897;9530.428174309563;9555.187809036031;9561.808763824545;6615.140031795836;6829.965850170717;6995.615241161785;7070.823229419306;7218.484118335208;7846.489978151402;7892.921070789219;7997.320227780704;7997.7600671979935;8000.51996880189;6187.938120618736;7081.4334853210585;7170.749023784142;7179.138503379628;7271.054762880792;6809.93190068093;6980.759375264337;7031.22656507794;7060.082189315356;7105.50261481712;6608.603483790988;6630.569013014138;6725.260221375743;6726;6726.461883049442;4817.807287708452;4830.565249127595;4853.466118727008;4881.096997055556;4936.629752768485;4291.570842915684;4795.400574928134;4799.952000479951;4977.228529577921;5061.620378471555 11:58:19 INFO - PROCESS | 1636 | |4;prototype.html;246.43689170245986;271.7959439682207;304.43831131562257;309.194548201934;318.3473878548974;5005.674631148972;5169.9660067986415;5205.609579281555;5280.960065549857;5293.52358287754;4276.850310239134;5046.343975283217;5060.734816295926;5095.464976177504;5281.841544753654;3708.6105958874336;3885.3589157789074;4015.6787457003516;4034.4150098235737;4060.28944934636;3345.832708364572;3477.495763114347;3980.46752000479;4020.9396859047138;4037.7375470594466;3682.2156712165906;3931.056546428865;3966.940495892564;3996.600339965995;4005.1589166275116;3561.5904171020275;4037.354023356278;4046.8349433053177;4049.6355328020327;4052.8449391923455;3271.9018429447156;3377.8817741378934;3508.8947331580093;3509.508668786372;3527.94708079379;4084.591540845892;4255.914881702349;5118.232265160219;5118.2578526113875;5122.692638441706;4022.738521996061;4366.4105345778235;4406.515283318832;4412.514623391425;4589.5181005994555;5156.149235376159;5410.94486575118;5485.533729632946;5494.719691328094;5513.61404701671;3383.0865666270215;3579.565895191295;3594.2991116732246;3869.3808990561656;3882.9029274268087;5501.2091116263655;5629.971850140764;5737.3688894221605;5759.395263497315;5770.798022069207;3909.257241124177;3918.7060970427333;3928.03763078042;3933.468981687493;3936.5079365079364;3358.714509266691;3971.5631280559114;3995.92008159841;4001.199760047944;4026.6778657707314;3588.748787584844;4272.594103560157;4576.839810606612;4597.448306203277;4606.677532572688;4881.829135980223;5049.520295571915;5149.433562308143;5503.367112782002;5509.807156749494;1273.9044571657162;1287.4013583683632;1289.9806502902463;1297.903271735382;1298.337847697662;763.8968739220135;797.0355869397978;850.4259624753266;871.4292138649195;896.8565029595234;4134.4005119258145;4943.728094954812;4946.332245146859;4958.628102892298;5017.397912250553;5049.141645920203;5301.469853014668;5370.892582148335;5372.179605706957;5449.291592093082;4188.392683061;4908.01839632075;5003.874903127451;5405.081196175302;5407.188921661704;2365.243122200879;2542.669452971139;2745.052956729925;2849.7435230829324;2852.9001484947926;5194.480551944851;5469.453054694499;5496.065668836308;5500.724963751796;5784.768609255582;4863.562279394871;4966.850994470172;5197.948020519822;5249.763760630781;5609.747561359749;4997.700137991732;5376.822386933298;5750.6262092963825;5767.250257466587;5775.595708300379;4799.904001920012;5085.974570127126;5297.629165958346;5439.37447193562;5502.367227768857;4773.880652983703;4939.481354457874;5058.974705126451;5330.375344765596;5353.732313384393;5180.585553155664;5314.671332166959;5608.971955140199;5746.827595172152;5781.306243250837;3075.6924307569957;3350.564426624523;3492.8253587320023;3629.765879600948;3706.9814650926573;4781.6891902026255;4932.926006109839;5012.348394708664;5681.943180568307;5703.914441283301;4813.253945638432;5065.087574644668;5371.811986580451;5496.80761173357;5532.889342213052;4681.695689780154;4910.680805747615;4960.379952505937;5221.222581338185;5516.386766667839;4092.4270602115134;5252.082989708805;5402.460843403594;5443.673379597237;5478.91781623268;4519.661025423041;4997;5420.457954204548;5505;5536.252605898152;5307.938412317475;5345.9465405347;5443.482869127427;5458.727063646881;5497.47773961473 11:58:19 INFO - PROCESS | 1636 | |5;yui.html;670.8356452669096;687.8280429892527;690.6719308328543;700.2892064554478;749.9538144288719;14053.016288859772;14325.92837035816;14336.569902902917;14343.856561434395;14357.425702971896;12660.620181394574;12787.872121278784;12788.104832661717;12799.680007999805;12806.871931280684;643.6234802640461;742.9777106686809;796.6454927557239;797.7327595255597;800.1278606319111;654.1561385812297;790.3677058353323;809.3444310108802;815.604431850552;823.3166471828398;877.442823806884;878.508035500122;879.1033146190881;880.3221519430035;881.6870011146048;871.8605023196258;872.3239489395737;873.4497266721988;873.8514452543083;875.5972252763704;497.3519236401003;508.8905885234692;509.69163655988336;510.1582389058047;512.9615278854101;12659.493620255178;13116.344182790823;13142.934285328512;13443.596692099252;13450;11501.827472587918;12451.190672606343;12945.288009159493;13316.600501984956;13597.932010339984;9740.659076932274;11154.776904461947;11264.831027534512;11686;11751.647450576496;3476.6523347665284;3652.324320000782;3661.6155303692994;3661.7986010769396;3753.530808648919;78795.8180627291;79462.20537794605;80628.59685701533;82297;82376.94057648547;10124.69200328524;10233.59065637381;10247.128994035442;10266.384016959006;10434.269601128;19125.426237212905;19377.321793737152;19392.903035485015;19393.709094363596;19399.90300048491;7421.369183619453;7528.1719010908755;7533.397328213729;7649.923500764921;7751.379889608817;4124.52567954683;4213.852515162016;4232.682548808852;4283.143371325685;4355.715064056111;3291.4075466416275;3384;3403.0811680846527;3408.199073217792;3410.965890341065;611.4741322462678;666.7233098264263;695.1415002471944;697.8624841508309;708.348319546019;594.4946795224025;638.1321402892063;652.3769799841141;655.7213184396708;658.9209294884645;7363.963180184065;8906.955465222632;9049;9175.58709858058;9239.90760092404;590.5924911810837;621.183144165421;646.6637348578713;668.12809283885;679.4055201698513;4408.316710909814;4470.731756094645;4486.842960496367;4499.4150760400935;4596.954030459719;106374;108206.3769043465;108207.45896270625;108467;108494;54606.907861843334;59667.50831229167;62293.37706622876;78387;84419.57790211009;80766.3846723074;83236;83687;85834.57082714672;86616;8370.87443688333;8662.82674346522;8735;8779.692710755093;8930.598123084346;55779.884402312535;55944.60138496407;56558.717206413705;56889.43110569007;56988.43011569831;76748.23251767634;77995.61002194953;81138.59430703045;82532.58733706293;82606;10871.891281087088;10992.780144396907;11253.381064041556;11293.209475336647;11632.825507617561;12154.878451215374;12213.389330533615;12275;12280.263184208976;12569.685757856127;11611.941940290244;11741.706457338634;11792.410379481164;11805.173637845612;11897;10058.849117263393;11506.252093613888;11790.587329443428;12226.388680566113;12928.901043411415;12192.08559358034;12530.310832904277;12945.417456214305;12948.482060717466;13015.349232538525;10038.993616968606;11036.172287078341;11045.171612128961;11063.834042489209;11299.548018079513;11012.559497620005;11184.552617895193;11293.604723834625;11370.94314528422;11487.54049837997 11:58:19 INFO - PROCESS | 1636 | __end_tp_report 11:58:19 INFO - PROCESS | 1636 | __start_cc_report 11:58:19 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1910 11:58:19 INFO - PROCESS | 1636 | __end_cc_report 11:58:19 INFO - PROCESS | 1636 | __startTimestamp1482350299673__endTimestamp 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | ------- Summary: start ------- 11:58:19 INFO - PROCESS | 1636 | Number of tests: 6 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5550.38 Median:5727.08 stddev:649.22 (11.3%) stddev-sans-first:605.94 11:58:19 INFO - PROCESS | 1636 | Values: 2513.8 3276.9 3303.8 3317.8 3321.4 5464.4 5519.3 5522.5 5570.2 5576.2 5419.8 5436.9 5436.9 5457.2 5467.5 5006.5 5007.5 5034.5 5115.4 5128.4 5036.7 5042.5 5056.0 5135.8 5143.6 5092.2 5125.8 5139.3 5149.6 5153.0 5126.5 5141.1 5141.7 5144.8 5145.5 4998.1 5098.8 5111.6 5112.1 5117.8 5581.1 5590.8 5593.9 5596.2 5599.3 5926.3 5962.0 5964.6 5965.0 5979.3 5049.6 6057.8 6059.6 6071.7 6075.6 4639.3 5539.4 5544.0 5590.2 5596.4 6269.5 6275.2 6280.3 6287.0 6300.2 5636.2 5698.6 5708.2 5771.3 5805.9 6016.9 6037.9 6042.1 6049.7 6061.2 6020.9 6034.8 6038.9 6050.4 6089.8 5866.6 5894.8 5913.1 5918.8 6069.0 4797.8 4809.7 4818.2 4818.3 4820.9 4317.8 4319.1 4324.0 4337.4 4347.7 5611.6 5669.0 5743.9 5763.2 5782.8 6039.7 6043.4 6097.4 6099.0 6102.4 5721.5 5727.1 5729.3 5729.4 5730.1 4265.8 5202.8 5242.6 5252.6 5259.2 5290.0 6250.7 6269.2 6281.5 6288.0 6041.5 6081.4 6089.8 6090.5 6097.7 6168.9 6283.2 6286.0 6289.0 6307.3 4506.1 5985.5 5987.0 6004.9 6034.5 5941.7 6077.5 6090.7 6103.5 6105.5 5509.1 5691.8 5757.2 5772.5 5798.1 4936.6 5828.3 5858.5 5938.1 5985.6 5648.7 5798.2 5798.9 5811.7 5841.0 5924.5 5928.6 5934.0 5942.3 5943.6 5636.7 5676.4 5688.3 5726.0 5734.1 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:65620.91 Median:36660.23 stddev:148297.55 (404.5%) stddev-sans-first:148632.85 11:58:19 INFO - PROCESS | 1636 | Values: 452.8 518.5 527.1 531.1 534.8 25221.0 29828.7 30848.2 37822.0 39033.6 39476.6 39930.6 39955.2 40047.8 40114.8 9215.6 9396.4 9401.0 9407.5 9410.2 9280.6 9399.0 9401.0 9403.2 9414.1 9362.9 9403.3 9421.2 9434.8 9453.7 9317.6 9387.1 9397.4 9403.7 9412.3 9202.0 9281.5 9284.3 9306.5 9324.9 38045.4 38308.0 38397.2 38422.0 38467.4 3261.6 3322.4 3491.8 3562.2 3690.9 27661.6 27776.9 27920.0 29081.0 29560.7 2622.9 3158.3 3168.8 3186.6 3207.3 479930.0 480129.0 480280.0 480407.0 481060.0 32120.0 53979.5 54414.6 54528.7 54590.7 33074.5 34147.8 34182.0 34223.0 34286.3 13732.9 13850.4 13857.6 13859.6 13884.5 11691.5 11760.6 11775.6 11782.7 11798.6 7650.7 7694.8 7763.6 7781.0 7785.0 2915.4 3223.9 3266.5 3271.3 3272.5 924.5 936.7 1007.6 1014.5 1123.2 22756.5 28248.0 28879.4 28980.0 29012.9 997.2 1011.7 1094.9 1120.2 1129.9 14469.4 14919.6 14936.6 15219.5 15230.5 652731.0 658959.7 659808.0 660464.0 660952.0 53565.0 54050.0 54079.7 54121.7 54336.7 1222.3 1261.5 1293.3 1351.0 1371.0 28395.6 29223.0 29396.9 29894.7 29991.7 45211.8 45700.3 45722.1 45781.3 45813.3 496034.0 498610.0 504906.0 508503.0 509057.0 18753.9 21816.8 23096.7 23156.1 25330.0 42919.8 43211.6 43520.6 43585.8 43596.3 35946.3 36529.0 36612.6 36707.8 36848.6 36244.8 36488.3 36600.0 37443.6 37814.8 35049.0 35225.1 35245.0 35787.1 36128.3 30809.7 32321.7 32437.7 32478.5 32704.3 24213.5 24498.4 24722.8 24856.6 24994.0 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:35543.37 Median:25176.56 stddev:103780.97 (412.2%) stddev-sans-first:104038.50 11:58:19 INFO - PROCESS | 1636 | Values: 373.2 374.3 385.9 397.4 404.9 18256.3 19952.6 19986.1 20404.3 20578.5 16255.4 16660.1 19971.3 20070.0 20452.4 4747.6 5721.3 5965.5 5982.6 5983.6 5809.4 5875.9 5922.8 5928.5 5939.3 5221.2 5551.7 5784.9 5846.1 5880.9 5760.4 5813.9 5814.1 5816.7 5821.0 3733.9 4223.8 5045.8 5154.0 5158.7 24512.4 24556.8 25026.9 25030.1 25323.0 2294.0 2376.0 2406.6 2446.0 2912.4 13692.9 15038.5 15467.1 15469.6 15854.6 1812.1 1858.2 1868.1 1883.3 1939.4 120520.4 122218.0 122805.0 123063.0 123305.4 7726.8 8003.2 10532.9 10677.2 11289.4 13350.5 13368.0 13375.1 13383.0 13419.2 8200.6 8251.3 8303.0 8333.5 8452.6 7675.9 8299.3 8320.0 8473.0 8484.8 6121.4 6589.6 6593.5 6594.4 6601.1 1787.8 1824.6 1831.1 1836.9 1855.7 700.5 713.6 920.2 947.9 1036.9 20882.8 20944.0 21394.9 21869.4 22009.7 954.0 962.4 984.0 984.4 1009.4 10653.8 11091.2 11249.6 11290.0 11303.3 614538.0 616077.0 619327.0 635224.0 636232.8 82662.0 85893.6 112563.0 133025.3 135470.0 956.0 984.8 998.8 1011.8 1012.4 18509.6 18583.3 19037.5 19285.9 19356.6 56432.3 56895.6 57052.1 58073.1 58259.7 68530.9 82214.2 82515.8 83432.7 84334.7 7827.4 7867.1 7937.4 8430.7 8456.3 9238.7 11891.5 12701.9 13264.7 13283.4 10974.9 10980.8 11045.1 11431.0 11491.8 9596.4 10834.8 10975.8 11112.8 11555.1 10888.1 10956.6 11452.4 11505.9 11802.2 7045.5 7447.7 7449.9 8087.4 8215.5 10592.2 11033.9 11088.5 11168.3 11520.9 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5410.67 Median:5229.70 stddev:2969.65 (56.8%) stddev-sans-first:2963.02 11:58:19 INFO - PROCESS | 1636 | Values: 1443.7 1475.3 1592.1 1760.7 1798.8 6907.9 8382.0 8398.2 8404.0 8414.1 7146.6 7453.0 7738.2 7738.6 8121.6 2204.0 2236.2 2239.6 2250.3 2250.5 1948.9 2250.8 2273.7 2283.5 2286.4 2254.2 2279.8 2280.1 2314.3 2350.8 2301.6 2307.5 2328.0 2330.7 2336.9 2196.1 2207.7 2208.8 2209.3 2210.5 8226.3 8392.1 8395.4 8403.8 8424.7 5089.2 5222.0 5230.9 5231.4 5237.1 3252.8 3265.0 3532.3 3548.8 3568.1 989.5 1001.6 1004.3 1075.6 1081.8 10816.5 10829.2 10942.5 10947.6 10969.8 3797.9 4628.7 4740.8 4741.0 4749.2 9362.0 9378.2 9447.6 9460.8 9470.6 5213.8 5228.5 5232.7 5234.4 5235.4 4248.9 4536.2 4757.4 4789.3 4822.3 3410.5 3770.7 3775.2 3871.2 3890.5 1072.6 1254.1 1258.2 1265.8 1270.8 762.4 858.0 901.8 907.2 910.4 5469.7 5520.0 5579.6 5736.2 5858.5 955.6 981.3 994.9 1005.5 1012.7 3609.9 3664.2 3754.8 3771.8 3839.8 9718.2 10159.2 10181.3 10184.7 10201.8 9491.2 9940.3 9948.0 10063.6 10075.5 6335.9 7802.0 7823.1 7824.0 7831.9 5585.1 5648.2 5656.1 5659.3 5811.2 9280.5 9305.2 9431.4 9433.2 9437.1 9199.3 9437.3 9530.4 9555.2 9561.8 6615.1 6830.0 6995.6 7070.8 7218.5 7846.5 7892.9 7997.3 7997.8 8000.5 6187.9 7081.4 7170.7 7179.1 7271.1 6809.9 6980.8 7031.2 7060.1 7105.5 6608.6 6630.6 6725.3 6726.0 6726.5 4817.8 4830.6 4853.5 4881.1 4936.6 4291.6 4795.4 4800.0 4977.2 5061.6 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4369.65 Median:4959.50 stddev:1335.19 (26.9%) stddev-sans-first:1302.58 11:58:19 INFO - PROCESS | 1636 | Values: 246.4 271.8 304.4 309.2 318.3 5005.7 5170.0 5205.6 5281.0 5293.5 4276.9 5046.3 5060.7 5095.5 5281.8 3708.6 3885.4 4015.7 4034.4 4060.3 3345.8 3477.5 3980.5 4020.9 4037.7 3682.2 3931.1 3966.9 3996.6 4005.2 3561.6 4037.4 4046.8 4049.6 4052.8 3271.9 3377.9 3508.9 3509.5 3527.9 4084.6 4255.9 5118.2 5118.3 5122.7 4022.7 4366.4 4406.5 4412.5 4589.5 5156.1 5410.9 5485.5 5494.7 5513.6 3383.1 3579.6 3594.3 3869.4 3882.9 5501.2 5630.0 5737.4 5759.4 5770.8 3909.3 3918.7 3928.0 3933.5 3936.5 3358.7 3971.6 3995.9 4001.2 4026.7 3588.7 4272.6 4576.8 4597.4 4606.7 4881.8 5049.5 5149.4 5503.4 5509.8 1273.9 1287.4 1290.0 1297.9 1298.3 763.9 797.0 850.4 871.4 896.9 4134.4 4943.7 4946.3 4958.6 5017.4 5049.1 5301.5 5370.9 5372.2 5449.3 4188.4 4908.0 5003.9 5405.1 5407.2 2365.2 2542.7 2745.1 2849.7 2852.9 5194.5 5469.5 5496.1 5500.7 5784.8 4863.6 4966.9 5197.9 5249.8 5609.7 4997.7 5376.8 5750.6 5767.3 5775.6 4799.9 5086.0 5297.6 5439.4 5502.4 4773.9 4939.5 5059.0 5330.4 5353.7 5180.6 5314.7 5609.0 5746.8 5781.3 3075.7 3350.6 3492.8 3629.8 3707.0 4781.7 4932.9 5012.3 5681.9 5703.9 4813.3 5065.1 5371.8 5496.8 5532.9 4681.7 4910.7 4960.4 5221.2 5516.4 4092.4 5252.1 5402.5 5443.7 5478.9 4519.7 4997.0 5420.5 5505.0 5536.3 5307.9 5345.9 5443.5 5458.7 5497.5 11:58:19 INFO - PROCESS | 1636 | 11:58:19 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19444.34 Median:4478.79 stddev:28231.28 (630.3%) stddev-sans-first:28275.29 11:58:19 INFO - PROCESS | 1636 | Values: 670.8 687.8 690.7 700.3 750.0 14053.0 14325.9 14336.6 14343.9 14357.4 12660.6 12787.9 12788.1 12799.7 12806.9 643.6 743.0 796.6 797.7 800.1 654.2 790.4 809.3 815.6 823.3 877.4 878.5 879.1 880.3 881.7 871.9 872.3 873.4 873.9 875.6 497.4 508.9 509.7 510.2 513.0 12659.5 13116.3 13142.9 13443.6 13450.0 11501.8 12451.2 12945.3 13316.6 13597.9 9740.7 11154.8 11264.8 11686.0 11751.6 3476.7 3652.3 3661.6 3661.8 3753.5 78795.8 79462.2 80628.6 82297.0 82376.9 10124.7 10233.6 10247.1 10266.4 10434.3 19125.4 19377.3 19392.9 19393.7 19399.9 7421.4 7528.2 7533.4 7649.9 7751.4 4124.5 4213.9 4232.7 4283.1 4355.7 3291.4 3384.0 3403.1 3408.2 3411.0 611.5 666.7 695.1 697.9 708.3 594.5 638.1 652.4 655.7 658.9 7364.0 8907.0 9049.0 9175.6 9239.9 590.6 621.2 646.7 668.1 679.4 4408.3 4470.7 4486.8 4499.4 4597.0 106374.0 108206.4 108207.5 108467.0 108494.0 54606.9 59667.5 62293.4 78387.0 84419.6 80766.4 83236.0 83687.0 85834.6 86616.0 8370.9 8662.8 8735.0 8779.7 8930.6 55779.9 55944.6 56558.7 56889.4 56988.4 76748.2 77995.6 81138.6 82532.6 82606.0 10871.9 10992.8 11253.4 11293.2 11632.8 12154.9 12213.4 12275.0 12280.3 12569.7 11611.9 11741.7 11792.4 11805.2 11897.0 10058.8 11506.3 11790.6 12226.4 12928.9 12192.1 12530.3 12945.4 12948.5 13015.3 10039.0 11036.2 11045.2 11063.8 11299.5 11012.6 11184.6 11293.6 11370.9 11487.5 11:58:19 INFO - PROCESS | 1636 | -------- Summary: end -------- 11:58:19 INFO - PROCESS | 1636 | 11:58:20 INFO - TEST-INFO | 1636: exit 0 11:58:20 INFO - TEST-OK | dromaeo_css | took 1121196ms 11:58:20 INFO - TEST-START | kraken 11:58:20 INFO - operating with platform_type : mac_ 11:58:20 INFO - Initialising browser for kraken test... 11:58:20 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpaSRjts/profile http://localhost:49236/getInfo.html) 11:58:23 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 11:58:23 INFO - PROCESS | 1646 | colorDepth:24 11:58:23 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 11:58:23 INFO - PROCESS | 1646 | __metrics 11:58:23 INFO - PROCESS | 1646 | 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" 11:58:23 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:58:24 INFO - TEST-INFO | 1646: exit 0 11:58:24 INFO - Browser initialized. 11:58:24 INFO - Running cycle 1/1 for kraken test... 11:58:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpaSRjts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:36 INFO - PROCESS | 1647 | RSS: Main: 222855168 11:58:36 INFO - PROCESS | 1647 | 11:58:39 INFO - PROCESS | 1647 | 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) 11:58:40 INFO - PROCESS | 1647 | RSS: Main: 270516224 11:58:40 INFO - PROCESS | 1647 | 11:58:42 INFO - PROCESS | 1647 | 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) 11:58:43 INFO - PROCESS | 1647 | RSS: Main: 284909568 11:58:43 INFO - PROCESS | 1647 | 11:58:46 INFO - PROCESS | 1647 | 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) 11:58:47 INFO - PROCESS | 1647 | RSS: Main: 382308352 11:58:47 INFO - PROCESS | 1647 | 11:58:49 INFO - PROCESS | 1647 | 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) 11:58:49 INFO - PROCESS | 1647 | RSS: Main: 285478912 11:58:49 INFO - PROCESS | 1647 | 11:58:51 INFO - PROCESS | 1647 | 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) 11:58:52 INFO - PROCESS | 1647 | RSS: Main: 286789632 11:58:52 INFO - PROCESS | 1647 | 11:58:55 INFO - PROCESS | 1647 | 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) 11:58:55 INFO - PROCESS | 1647 | RSS: Main: 328052736 11:58:55 INFO - PROCESS | 1647 | 11:58:58 INFO - PROCESS | 1647 | 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) 11:58:59 INFO - PROCESS | 1647 | RSS: Main: 327278592 11:58:59 INFO - PROCESS | 1647 | 11:59:01 INFO - PROCESS | 1647 | 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) 11:59:02 INFO - PROCESS | 1647 | RSS: Main: 325558272 11:59:02 INFO - PROCESS | 1647 | 11:59:04 INFO - PROCESS | 1647 | 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) 11:59:04 INFO - PROCESS | 1647 | RSS: Main: 299266048 11:59:04 INFO - PROCESS | 1647 | 11:59:06 INFO - PROCESS | 1647 | 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) 11:59:07 INFO - PROCESS | 1647 | RSS: Main: 301486080 11:59:07 INFO - PROCESS | 1647 | 11:59:09 INFO - PROCESS | 1647 | 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) 11:59:10 INFO - PROCESS | 1647 | RSS: Main: 303341568 11:59:10 INFO - PROCESS | 1647 | 11:59:12 INFO - PROCESS | 1647 | 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) 11:59:13 INFO - PROCESS | 1647 | RSS: Main: 320815104 11:59:13 INFO - PROCESS | 1647 | 11:59:16 INFO - PROCESS | 1647 | 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) 11:59:17 INFO - PROCESS | 1647 | RSS: Main: 314138624 11:59:17 INFO - PROCESS | 1647 | 11:59:18 INFO - PROCESS | 1647 | 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) 11:59:19 INFO - PROCESS | 1647 | RSS: Main: 358141952 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | __start_tp_report 11:59:19 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 11:59:19 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 11:59:19 INFO - PROCESS | 1647 | |i|pagename|runs| 11:59:19 INFO - PROCESS | 1647 | |0;ai-astar;103;114;116;114;115;115;112;115;114;113 11:59:19 INFO - PROCESS | 1647 | |1;audio-beat-detection;145;111;108;148;110;109;107;108;138;109 11:59:19 INFO - PROCESS | 1647 | |2;audio-dft;184;182;184;185;185;183;179;184;185;183 11:59:19 INFO - PROCESS | 1647 | |3;audio-fft;83;69;80;90;62;75;82;82;92;58 11:59:19 INFO - PROCESS | 1647 | |4;audio-oscillator;85;69;96;69;68;68;90;68;68;92 11:59:19 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;87;86;88;83;87;84;88;85;90;84 11:59:19 INFO - PROCESS | 1647 | |6;imaging-darkroom;94;95;95;100;94;95;94;95;95;99 11:59:19 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;83;82;82;83;84;86;81;85;84 11:59:19 INFO - PROCESS | 1647 | |8;json-parse-financial;55;54;54;53;55;57;55;64;81;85 11:59:19 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;64;68;78;73;71;70;69;68;70;69 11:59:19 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;83;85;85;84;81;82;83;83;84;83 11:59:19 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;142;137;141;140;141;144;143;142;179;139 11:59:19 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;167;163;159;163;163;164;165;163;164;164 11:59:19 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;68;67;67;68;66;67;67;65;67;67 11:59:19 INFO - PROCESS | 1647 | __end_tp_report 11:59:19 INFO - PROCESS | 1647 | __start_cc_report 11:59:19 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1969 11:59:19 INFO - PROCESS | 1647 | __end_cc_report 11:59:19 INFO - PROCESS | 1647 | __startTimestamp1482350359002__endTimestamp 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | ------- Summary: start ------- 11:59:19 INFO - PROCESS | 1647 | Number of tests: 14 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:3.73 (3.3%) stddev-sans-first:1.20 11:59:19 INFO - PROCESS | 1647 | Values: 103.0 114.0 116.0 114.0 115.0 115.0 112.0 115.0 114.0 113.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:110.50 stddev:17.02 (15.4%) stddev-sans-first:15.31 11:59:19 INFO - PROCESS | 1647 | Values: 145.0 111.0 108.0 148.0 110.0 109.0 107.0 108.0 138.0 109.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.84 (1.0%) stddev-sans-first:1.94 11:59:19 INFO - PROCESS | 1647 | Values: 184.0 182.0 184.0 185.0 185.0 183.0 179.0 184.0 185.0 183.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:77.30 Median:82.00 stddev:11.26 (13.7%) stddev-sans-first:11.76 11:59:19 INFO - PROCESS | 1647 | Values: 83.0 69.0 80.0 90.0 62.0 75.0 82.0 82.0 92.0 58.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.00 stddev:11.88 (15.4%) stddev-sans-first:12.27 11:59:19 INFO - PROCESS | 1647 | Values: 85.0 69.0 96.0 69.0 68.0 68.0 90.0 68.0 68.0 92.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:2.20 (2.5%) stddev-sans-first:2.32 11:59:19 INFO - PROCESS | 1647 | Values: 87.0 86.0 88.0 83.0 87.0 84.0 88.0 85.0 90.0 84.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:95.00 stddev:2.12 (2.2%) stddev-sans-first:2.17 11:59:19 INFO - PROCESS | 1647 | Values: 94.0 95.0 95.0 100.0 94.0 95.0 94.0 95.0 95.0 99.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.71 (2.0%) stddev-sans-first:1.58 11:59:19 INFO - PROCESS | 1647 | Values: 86.0 83.0 82.0 82.0 83.0 84.0 86.0 81.0 85.0 84.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:56.00 stddev:11.88 (21.2%) stddev-sans-first:12.38 11:59:19 INFO - PROCESS | 1647 | Values: 55.0 54.0 54.0 53.0 55.0 57.0 55.0 64.0 81.0 85.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:3.65 (5.2%) stddev-sans-first:3.16 11:59:19 INFO - PROCESS | 1647 | Values: 64.0 68.0 78.0 73.0 71.0 70.0 69.0 68.0 70.0 69.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.25 (1.5%) stddev-sans-first:1.32 11:59:19 INFO - PROCESS | 1647 | Values: 83.0 85.0 85.0 84.0 81.0 82.0 83.0 83.0 84.0 83.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:142.00 stddev:12.18 (8.6%) stddev-sans-first:12.88 11:59:19 INFO - PROCESS | 1647 | Values: 142.0 137.0 141.0 140.0 141.0 144.0 143.0 142.0 179.0 139.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:2.01 (1.2%) stddev-sans-first:1.69 11:59:19 INFO - PROCESS | 1647 | Values: 167.0 163.0 159.0 163.0 163.0 164.0 165.0 163.0 164.0 164.0 11:59:19 INFO - PROCESS | 1647 | 11:59:19 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 11:59:19 INFO - PROCESS | 1647 | Values: 68.0 67.0 67.0 68.0 66.0 67.0 67.0 65.0 67.0 67.0 11:59:19 INFO - PROCESS | 1647 | -------- Summary: end -------- 11:59:19 INFO - PROCESS | 1647 | 11:59:20 INFO - TEST-INFO | 1647: exit 0 11:59:20 INFO - TEST-OK | kraken | took 59697ms 11:59:20 INFO - SUITE-END | took 1180s 11:59:20 INFO - Completed test suite (00:19:40) 11:59:20 INFO - javascript benchmark 11:59:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2513.824032317738, 3276.8689252429904, 3303.7852539584924, 3317.8387564352465, 3321.3689399014183, 5464.4262352453015, 5519.254900588419, 5522.530584900288, 5570.2480165177685, 5576.219329293902, 5419.810306639269, 5436.891262174754, 5436.91844622331, 5457.181422786584, 5467.480589344016, 5006.474320196382, 5007.549320561149, 5034.471380505049, 5115.360579927509, 5128.435872054071, 5036.7481625918745, 5042.546170844624, 5056.014077254937, 5135.794568217267, 5143.639945203838, 5092.185250359943, 5125.794968201268, 5139.306193663845, 5149.562287205592, 5153.0, 5126.487351264881, 5141.100307446182, 5141.665791723563, 5144.84565463033, 5145.536901678867, 4998.050370429643, 5098.770555325019, 5111.642185047048, 5112.079825631385, 5117.769700363456, 5581.10702287632, 5590.8043218487155, 5593.916091258634, 5596.188552659842, 5599.272094627713, 5926.259217597801, 5962.0, 5964.552658550582, 5964.956132676808, 5979.342272350038, 5049.64652474327, 6057.757689692407, 6059.6364218147055, 6071.666058366788, 6075.574709770318, 4639.257718765015, 5539.390667026624, 5544.002079625666, 5590.161475778625, 5596.4123767004285, 6269.529785266078, 6275.18422605063, 6280.277768056732, 6286.994080947026, 6300.180976473121, 5636.154576813429, 5698.601097923106, 5708.1723150143, 5771.336296325892, 5805.912911306334, 6016.879662406727, 6037.9433599119975, 6042.093685947143, 6049.697515124226, 6061.151438798572, 6020.939790602126, 6034.818955431344, 6038.939610603926, 6050.42520960508, 6089.786857460056, 5866.560007999417, 5894.793682221101, 5913.113033045078, 5918.763249470059, 6068.968275393194, 4797.784099715521, 4809.687370320988, 4818.180909245437, 4818.301346304766, 4820.903581928342, 4317.84887528935, 4319.114581510783, 4324.005478739908, 4337.414449049401, 4347.673924455678, 5611.607187496836, 5669.0, 5743.942560574341, 5763.221965034667, 5782.797602083991, 6039.698015099228, 6043.395660433922, 6097.420745029215, 6098.969505152535, 6102.420270074336, 5721.542276617944, 5727.083666613322, 5729.312482502043, 5729.369769325371, 5730.111832665943, 4265.786710664516, 5202.843914682566, 5242.554382877498, 5252.632315737938, 5259.237410575445, 5289.973550132225, 6250.687465626791, 6269.247690277196, 6281.497480201573, 6287.993920972623, 6041.516678665784, 6081.422264884829, 6089.756409743561, 6090.451859332504, 6097.725602347817, 6168.938310616836, 6283.183186185766, 6286.0, 6289.0, 6307.306196318493, 4506.1213063452315, 5985.461308482258, 5986.970065149646, 6004.8799024020145, 6034.517238620988, 5941.673207973603, 6077.453029227391, 6090.665013424305, 6103.511719062376, 6105.450509453993, 5509.146082357241, 5691.772329106955, 5757.165211044459, 5772.451617096369, 5798.1302804579655, 4936.605071594192, 5828.300603927556, 5858.531317494505, 5938.109283607493, 5985.6408615483215, 5648.661080335193, 5798.159266906359, 5798.884022319446, 5811.709414529341, 5841.0, 5924.4667979882015, 5928.644281343133, 5933.970330148321, 5942.257217847769, 5943.58394912352, 5636.718164091697, 5676.375598684224, 5688.345840228261, 5726.0, 5734.139879018181], "value": 5508.915206256091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.7713504680136, 518.4530320511858, 527.0591993291974, 531.0838803064713, 534.7780321964312, 25221.0, 29828.70171298289, 30848.228794280127, 37822.0, 39033.60966390342, 39476.60523394765, 39930.602428914994, 39955.20089598206, 40047.799761001224, 40114.79942600283, 9215.58529866156, 9396.389234699722, 9401.0, 9407.482588457631, 9410.153086222239, 9280.582373793162, 9399.0, 9400.952995235015, 9403.153716165543, 9414.105659962293, 9362.859557106649, 9403.294752893526, 9421.15209631133, 9434.764130896714, 9453.716388508321, 9317.627294908196, 9387.10822471871, 9397.436153830724, 9403.670871519498, 9412.294077944112, 9201.953990230006, 9281.53592320388, 9284.25725941923, 9306.53467326631, 9324.86012709803, 38045.429318560244, 38308.04229894247, 38397.23205535902, 38422.0, 38467.42298865519, 3261.575995120619, 3322.352141332441, 3491.825408729553, 3562.1806984393734, 3690.944635830465, 27661.585076223873, 27776.888924443, 27920.0, 29081.0, 29560.70439295601, 2622.9213123606323, 3158.3051728619666, 3168.7940283881476, 3186.617605887285, 3207.294395233045, 479930.0, 480129.0, 480280.0, 480407.0, 481060.0, 32120.03639890807, 53979.460205397445, 54414.639634009465, 54528.727356362964, 54590.72704636451, 33074.503882441786, 34147.829260853534, 34182.0, 34223.0, 34286.314273714386, 13732.862671373357, 13850.376733047036, 13857.584272471842, 13859.584212473643, 13884.51404200848, 11691.473883675086, 11760.58837940668, 11775.587854425054, 11782.705432364259, 11798.646040618623, 7650.655720492591, 7694.807629809187, 7763.573003484749, 7781.0, 7784.9610751945875, 2915.3731947631363, 3223.854926528312, 3266.4936934775146, 3271.329377477611, 3272.5254838048827, 924.5007695844304, 936.6534382278601, 1007.5868893753526, 1014.5130337438071, 1123.1913022623862, 22756.544869102527, 28248.0, 28879.42241155165, 28980.0, 29012.85493572561, 997.2221667099674, 1011.7420057885192, 1094.9069329106956, 1120.199057673751, 1129.8870112988636, 14469.421223151166, 14919.552413427615, 14936.551903442914, 15219.467318643794, 15230.46693365749, 652731.0, 658959.7052014709, 659808.0, 660464.0, 660952.0, 53565.0, 54050.0, 54079.72960135253, 54121.72939135279, 54336.72831635895, 1222.3277197541317, 1261.5458434963407, 1293.2563775828935, 1350.959471215865, 1370.9588712338646, 28395.574066388606, 29222.977195798045, 29396.853015734785, 29894.701052989192, 29991.70008299889, 45211.773941130086, 45700.314495281935, 45722.08555828798, 45781.31328030016, 45813.31280030736, 496034.0, 498610.0, 504906.0, 508503.0, 509057.0, 18753.90623046876, 21816.781832181474, 23096.653550197098, 23156.07375704953, 25330.0, 42919.7854010728, 43211.56788432076, 43520.56479435165, 43585.78207109071, 43596.34605480984, 35946.28107437785, 36529.0, 36612.633873660925, 36707.81646091752, 36848.63151368452, 36244.81877590595, 36488.31417720091, 36600.0, 37443.62556374401, 37814.810925945196, 35049.0, 35225.11937201488, 35245.0, 35787.10532236715, 36128.27743445169, 30809.69190308158, 32321.707131715408, 32437.67562324441, 32478.512822308156, 32704.34591308208, 24213.515729684954, 24498.387540311636, 24722.752772472046, 24856.627150593118, 24994.000239990197], "value": 17747.42345460236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2199702621521, 374.29071908732953, 385.9150986782907, 397.42373558340415, 404.93723472861717, 18256.26974921003, 19952.60094798103, 19986.100625471852, 20404.285849995253, 20578.48553786156, 16255.431059912906, 16660.137363318547, 19971.301004464847, 20070.0, 20452.38642840717, 4747.572718455338, 5721.34204566476, 5965.46310832025, 5982.61113027654, 5983.611065280765, 5809.419058094199, 5875.9118613220835, 5922.763089476437, 5928.496077833368, 5939.287285525743, 5221.21681747739, 5551.694656793875, 5784.884302313952, 5846.064629659255, 5880.852978675546, 5760.36635970043, 5813.941860581383, 5814.098814683731, 5816.709164541777, 5821.010428227211, 3733.869314574004, 4223.809928553192, 5045.798168073273, 5153.969206158783, 5158.664686795346, 24512.387190320205, 24556.754432455804, 25026.874865625738, 25030.123945661995, 25323.0, 2293.9655905161435, 2376.0258294099335, 2406.602910519762, 2446.0, 2912.4175164966878, 13692.931535342259, 15038.54884353471, 15467.149306788235, 15469.613259668486, 15854.603634909105, 1812.1392338639173, 1858.1916866163263, 1868.093974422404, 1883.256113835041, 1939.350317643591, 120520.39739801333, 122218.0, 122805.0, 123063.0, 123305.38347308295, 7726.806829829299, 8003.239692229346, 10532.89467105319, 10677.199210059276, 11289.435528223556, 13350.532731354357, 13368.0, 13375.063745537718, 13382.996275279393, 13419.194848309133, 8200.58997050145, 8251.2986396157, 8302.958485207535, 8333.499990000619, 8452.61963211657, 7675.884861727079, 8299.253067223979, 8320.0, 8473.025602055719, 8484.787880303042, 6121.418465245794, 6589.604623722592, 6593.505487088488, 6594.373534514213, 6601.141851559362, 1787.8122797106378, 1824.5894673698576, 1831.102759647763, 1836.8622353323287, 1855.7123645834918, 700.5131433653562, 713.6228518116075, 920.1994264989369, 947.8530827721714, 1036.9481525923825, 20882.791172088084, 20944.0, 21394.893025534773, 21869.368807247796, 22009.66985495219, 954.0411886054471, 962.4225464721111, 983.9950800245953, 984.3995162950595, 1009.4347165587294, 10653.84019239712, 11091.168162387854, 11249.550017999189, 11289.983901448744, 11303.321800691985, 614538.0, 616077.0, 619327.0, 635224.0, 636232.8188359028, 82662.0, 85893.57053214694, 112563.0, 133025.33487332502, 135470.0, 955.9808803823885, 984.7882705218412, 998.7652901568125, 1011.8229309870891, 1012.367270455965, 18509.629807403508, 18583.25666973306, 19037.524061898563, 19285.93927333954, 19356.612867742286, 56432.30703078914, 56895.57761056007, 57052.144217837595, 58073.128903067336, 58259.70870145622, 68530.94407167794, 82214.17785822065, 82515.76226356729, 83432.7485087712, 84334.73497897659, 7827.373810095292, 7867.055953285642, 7937.404694647809, 8430.662773488992, 8456.2812160967, 9238.722838314861, 11891.464884080064, 12701.93649031749, 13264.734705306033, 13283.402246899106, 10974.945125274322, 10980.835287470854, 11045.061169800658, 11431.028362589273, 11491.770164596828, 9596.376235544667, 10834.783304333712, 10975.83536246941, 11112.833307500232, 11555.133364997491, 10888.07451366611, 10956.561737530728, 11452.3701196435, 11505.942470287595, 11802.232854864405, 7045.471589630695, 7447.739329123671, 7449.92550074514, 8087.393445491494, 8215.548144852091, 10592.205584581341, 11033.944830275797, 11088.501017454395, 11168.274062185932, 11520.88479115198], "value": 9595.67292353143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.74012677718, 1475.2992328643895, 1592.1163754116467, 1760.6654735600243, 1798.8470979966703, 6907.930920690792, 8382.0, 8398.244158025784, 8403.957980210105, 8414.074451810297, 7146.571205727647, 7453.0, 7738.18749031352, 7738.574378409199, 8121.634526446309, 2204.0, 2236.2173239366252, 2239.5744808486334, 2250.336150835499, 2250.5386395788905, 1948.8928108954, 2250.797428231459, 2273.6816845641624, 2283.4633861042644, 2286.4055345610177, 2254.199759085526, 2279.817614590837, 2280.1107568048474, 2314.259436980167, 2350.753170917055, 2301.5857145713767, 2307.515421761432, 2327.9883600582057, 2330.7203135623836, 2336.894839732216, 2196.088623221361, 2207.701960235364, 2208.8232941364654, 2209.2709405896017, 2210.502636906683, 8226.341892648574, 8392.118827523083, 8395.412321137523, 8403.789905252357, 8424.705135320235, 5089.185730283174, 5222.0, 5230.8692282692855, 5231.424543300234, 5237.13587258102, 3252.788568743024, 3264.951025734616, 3532.3288575170636, 3548.822558872072, 3568.107973006748, 989.50030234731, 1001.6293971230691, 1004.3020101029787, 1075.575147816608, 1081.8160912644792, 10816.513256903458, 10829.241953063289, 10942.507587158598, 10947.56209751609, 10969.83545246822, 3797.867074652374, 4628.722276663411, 4740.810367585327, 4740.95259047412, 4749.1926372516755, 9362.0, 9378.249740020781, 9447.622095116118, 9460.763480912894, 9470.573824177929, 5213.765380557884, 5228.529432351107, 5232.686038837682, 5234.371875374979, 5235.424103348705, 4248.85129020489, 4536.228841097021, 4757.405324334458, 4789.3294938708605, 4822.348982887335, 3410.4543273076188, 3770.7171962102952, 3775.207206486614, 3871.2257548490416, 3890.513685789276, 1072.624581396505, 1254.1095821966505, 1258.1947553565726, 1265.7721610110084, 1270.783966725659, 762.3862790453738, 857.9828403431897, 901.7925877048316, 907.2016625369764, 910.3581974707815, 5469.671819690751, 5520.0, 5579.576793987588, 5736.225609542742, 5858.47273745365, 955.5986485676033, 981.3032746749744, 994.8955359687128, 1005.527402121002, 1012.711377257478, 3609.8556057757396, 3664.2488289900507, 3754.755940863835, 3771.7944491891344, 3839.827207775657, 9718.222542196607, 10159.238057145743, 10181.33821301613, 10184.745381365525, 10201.795964080677, 9491.193248573949, 9940.25448091396, 9948.0, 10063.597456101821, 10075.496225188712, 6335.936640633627, 7801.985741853637, 7823.139454659983, 7823.960880195449, 7831.882521762178, 5585.106382978866, 5648.237487939075, 5656.123300888369, 5659.26429564154, 5811.186433899173, 9280.535973201448, 9305.209057230211, 9431.434113953184, 9433.198178154658, 9437.103475169848, 9199.26405887514, 9437.339386242897, 9530.428174309563, 9555.187809036031, 9561.808763824545, 6615.140031795836, 6829.965850170717, 6995.615241161785, 7070.823229419306, 7218.484118335208, 7846.489978151402, 7892.921070789219, 7997.320227780704, 7997.7600671979935, 8000.51996880189, 6187.938120618736, 7081.4334853210585, 7170.749023784142, 7179.138503379628, 7271.054762880792, 6809.93190068093, 6980.759375264337, 7031.22656507794, 7060.082189315356, 7105.50261481712, 6608.603483790988, 6630.569013014138, 6725.260221375743, 6726.0, 6726.461883049442, 4817.807287708452, 4830.565249127595, 4853.466118727008, 4881.096997055556, 4936.629752768485, 4291.570842915684, 4795.400574928134, 4799.952000479951, 4977.228529577921, 5061.620378471555], "value": 4388.112337048956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [246.43689170245986, 271.7959439682207, 304.43831131562257, 309.194548201934, 318.3473878548974, 5005.674631148972, 5169.9660067986415, 5205.609579281555, 5280.960065549857, 5293.52358287754, 4276.850310239134, 5046.343975283217, 5060.734816295926, 5095.464976177504, 5281.841544753654, 3708.6105958874336, 3885.3589157789074, 4015.6787457003516, 4034.4150098235737, 4060.28944934636, 3345.832708364572, 3477.495763114347, 3980.46752000479, 4020.9396859047138, 4037.7375470594466, 3682.2156712165906, 3931.056546428865, 3966.940495892564, 3996.600339965995, 4005.1589166275116, 3561.5904171020275, 4037.354023356278, 4046.8349433053177, 4049.6355328020327, 4052.8449391923455, 3271.9018429447156, 3377.8817741378934, 3508.8947331580093, 3509.508668786372, 3527.94708079379, 4084.591540845892, 4255.914881702349, 5118.232265160219, 5118.2578526113875, 5122.692638441706, 4022.738521996061, 4366.4105345778235, 4406.515283318832, 4412.514623391425, 4589.5181005994555, 5156.149235376159, 5410.94486575118, 5485.533729632946, 5494.719691328094, 5513.61404701671, 3383.0865666270215, 3579.565895191295, 3594.2991116732246, 3869.3808990561656, 3882.9029274268087, 5501.2091116263655, 5629.971850140764, 5737.3688894221605, 5759.395263497315, 5770.798022069207, 3909.257241124177, 3918.7060970427333, 3928.03763078042, 3933.468981687493, 3936.5079365079364, 3358.714509266691, 3971.5631280559114, 3995.92008159841, 4001.199760047944, 4026.6778657707314, 3588.748787584844, 4272.594103560157, 4576.839810606612, 4597.448306203277, 4606.677532572688, 4881.829135980223, 5049.520295571915, 5149.433562308143, 5503.367112782002, 5509.807156749494, 1273.9044571657162, 1287.4013583683632, 1289.9806502902463, 1297.903271735382, 1298.337847697662, 763.8968739220135, 797.0355869397978, 850.4259624753266, 871.4292138649195, 896.8565029595234, 4134.4005119258145, 4943.728094954812, 4946.332245146859, 4958.628102892298, 5017.397912250553, 5049.141645920203, 5301.469853014668, 5370.892582148335, 5372.179605706957, 5449.291592093082, 4188.392683061, 4908.01839632075, 5003.874903127451, 5405.081196175302, 5407.188921661704, 2365.243122200879, 2542.669452971139, 2745.052956729925, 2849.7435230829324, 2852.9001484947926, 5194.480551944851, 5469.453054694499, 5496.065668836308, 5500.724963751796, 5784.768609255582, 4863.562279394871, 4966.850994470172, 5197.948020519822, 5249.763760630781, 5609.747561359749, 4997.700137991732, 5376.822386933298, 5750.6262092963825, 5767.250257466587, 5775.595708300379, 4799.904001920012, 5085.974570127126, 5297.629165958346, 5439.37447193562, 5502.367227768857, 4773.880652983703, 4939.481354457874, 5058.974705126451, 5330.375344765596, 5353.732313384393, 5180.585553155664, 5314.671332166959, 5608.971955140199, 5746.827595172152, 5781.306243250837, 3075.6924307569957, 3350.564426624523, 3492.8253587320023, 3629.765879600948, 3706.9814650926573, 4781.6891902026255, 4932.926006109839, 5012.348394708664, 5681.943180568307, 5703.914441283301, 4813.253945638432, 5065.087574644668, 5371.811986580451, 5496.80761173357, 5532.889342213052, 4681.695689780154, 4910.680805747615, 4960.379952505937, 5221.222581338185, 5516.386766667839, 4092.4270602115134, 5252.082989708805, 5402.460843403594, 5443.673379597237, 5478.91781623268, 4519.661025423041, 4997.0, 5420.457954204548, 5505.0, 5536.252605898152, 5307.938412317475, 5345.9465405347, 5443.482869127427, 5458.727063646881, 5497.47773961473], "value": 3940.833733348046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.8356452669096, 687.8280429892527, 690.6719308328543, 700.2892064554478, 749.9538144288719, 14053.016288859772, 14325.92837035816, 14336.569902902917, 14343.856561434395, 14357.425702971896, 12660.620181394574, 12787.872121278784, 12788.104832661717, 12799.680007999805, 12806.871931280684, 643.6234802640461, 742.9777106686809, 796.6454927557239, 797.7327595255597, 800.1278606319111, 654.1561385812297, 790.3677058353323, 809.3444310108802, 815.604431850552, 823.3166471828398, 877.442823806884, 878.508035500122, 879.1033146190881, 880.3221519430035, 881.6870011146048, 871.8605023196258, 872.3239489395737, 873.4497266721988, 873.8514452543083, 875.5972252763704, 497.3519236401003, 508.8905885234692, 509.69163655988336, 510.1582389058047, 512.9615278854101, 12659.493620255178, 13116.344182790823, 13142.934285328512, 13443.596692099252, 13450.0, 11501.827472587918, 12451.190672606343, 12945.288009159493, 13316.600501984956, 13597.932010339984, 9740.659076932274, 11154.776904461947, 11264.831027534512, 11686.0, 11751.647450576496, 3476.6523347665284, 3652.324320000782, 3661.6155303692994, 3661.7986010769396, 3753.530808648919, 78795.8180627291, 79462.20537794605, 80628.59685701533, 82297.0, 82376.94057648547, 10124.69200328524, 10233.59065637381, 10247.128994035442, 10266.384016959006, 10434.269601128, 19125.426237212905, 19377.321793737152, 19392.903035485015, 19393.709094363596, 19399.90300048491, 7421.369183619453, 7528.1719010908755, 7533.397328213729, 7649.923500764921, 7751.379889608817, 4124.52567954683, 4213.852515162016, 4232.682548808852, 4283.143371325685, 4355.715064056111, 3291.4075466416275, 3384.0, 3403.0811680846527, 3408.199073217792, 3410.965890341065, 611.4741322462678, 666.7233098264263, 695.1415002471944, 697.8624841508309, 708.348319546019, 594.4946795224025, 638.1321402892063, 652.3769799841141, 655.7213184396708, 658.9209294884645, 7363.963180184065, 8906.955465222632, 9049.0, 9175.58709858058, 9239.90760092404, 590.5924911810837, 621.183144165421, 646.6637348578713, 668.12809283885, 679.4055201698513, 4408.316710909814, 4470.731756094645, 4486.842960496367, 4499.4150760400935, 4596.954030459719, 106374.0, 108206.3769043465, 108207.45896270625, 108467.0, 108494.0, 54606.907861843334, 59667.50831229167, 62293.37706622876, 78387.0, 84419.57790211009, 80766.3846723074, 83236.0, 83687.0, 85834.57082714672, 86616.0, 8370.87443688333, 8662.82674346522, 8735.0, 8779.692710755093, 8930.598123084346, 55779.884402312535, 55944.60138496407, 56558.717206413705, 56889.43110569007, 56988.43011569831, 76748.23251767634, 77995.61002194953, 81138.59430703045, 82532.58733706293, 82606.0, 10871.891281087088, 10992.780144396907, 11253.381064041556, 11293.209475336647, 11632.825507617561, 12154.878451215374, 12213.389330533615, 12275.0, 12280.263184208976, 12569.685757856127, 11611.941940290244, 11741.706457338634, 11792.410379481164, 11805.173637845612, 11897.0, 10058.849117263393, 11506.252093613888, 11790.587329443428, 12226.388680566113, 12928.901043411415, 12192.08559358034, 12530.310832904277, 12945.417456214305, 12948.482060717466, 13015.349232538525, 10038.993616968606, 11036.172287078341, 11045.171612128961, 11063.834042489209, 11299.548018079513, 11012.559497620005, 11184.552617895193, 11293.604723834625, 11370.94314528422, 11487.54049837997], "value": 7006.817792207193, "unit": "score"}], "name": "dromaeo_css", "value": 6960.1426204622785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 116.0, 114.0, 115.0, 115.0, 112.0, 115.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 108.0, 148.0, 110.0, 109.0, 107.0, 108.0, 138.0, 109.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 185.0, 185.0, 183.0, 179.0, 184.0, 185.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 80.0, 90.0, 62.0, 75.0, 82.0, 82.0, 92.0, 58.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 96.0, 69.0, 68.0, 68.0, 90.0, 68.0, 68.0, 92.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 83.0, 87.0, 84.0, 88.0, 85.0, 90.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 100.0, 94.0, 95.0, 94.0, 95.0, 95.0, 99.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 82.0, 82.0, 83.0, 84.0, 86.0, 81.0, 85.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 55.0, 57.0, 55.0, 64.0, 81.0, 85.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 78.0, 73.0, 71.0, 70.0, 69.0, 68.0, 70.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 84.0, 81.0, 82.0, 83.0, 83.0, 84.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 141.0, 140.0, 141.0, 144.0, 143.0, 142.0, 179.0, 139.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 159.0, 163.0, 163.0, 164.0, 165.0, 163.0, 164.0, 164.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 65.0, 67.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1425.6000000000001, "alertThreshold": 2.0}]} 11:59:20 INFO - Return code: 0 11:59:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:20 INFO - # TBPL SUCCESS # 11:59:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:59:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:59:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:59:20 INFO - 2016-12-21 11:59:20.304 screenresolution[1651:9758] starting screenresolution argv=screenresolution get 11:59:20 INFO - 2016-12-21 11:59:20.307 screenresolution[1651:9758] Display 0: 1600x1200x32@60 11:59:20 INFO - 2016-12-21 11:59:20.313 screenresolution[1652:9761] starting screenresolution argv=screenresolution list 11:59:20 INFO - Available Modes on Display 0 11:59:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:59:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:59:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:59:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:59:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:59:20 INFO - Intel Iris: 11:59:20 INFO - Chipset Model: Intel Iris 11:59:20 INFO - Type: GPU 11:59:20 INFO - Bus: Built-In 11:59:20 INFO - VRAM (Dynamic, Max): 1536 MB 11:59:20 INFO - Vendor: Intel (0x8086) 11:59:20 INFO - Device ID: 0x0a2e 11:59:20 INFO - Revision ID: 0x0009 11:59:20 INFO - Displays: 11:59:20 INFO - Display: 11:59:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:59:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:59:20 INFO - Display Serial Number: 1600x1200 60 11:59:20 INFO - Main Display: Yes 11:59:20 INFO - Mirror: Off 11:59:20 INFO - Online: Yes 11:59:20 INFO - Rotation: Supported 11:59:20 INFO - Return code: 0 11:59:20 INFO - Running post-action listener: _resource_record_post_action 11:59:20 INFO - [mozharness: 2016-12-21 19:59:20.566780Z] Finished run-tests step (success) 11:59:20 INFO - Running post-run listener: _resource_record_post_run 11:59:20 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37712896; Write bytes: 653525504; Read time: 242; Write time: 1864 11:59:20 INFO - TinderboxPrint: CPU usage
53.6% 11:59:20 INFO - TinderboxPrint: I/O read bytes / time
37,712,896 / 242 11:59:20 INFO - TinderboxPrint: I/O write bytes / time
653,525,504 / 1,864 11:59:20 INFO - TinderboxPrint: CPU idle
2,250.5 (46.4%) 11:59:20 INFO - TinderboxPrint: CPU system
973.3 (20.1%) 11:59:20 INFO - TinderboxPrint: CPU user
1,625.9 (33.5%) 11:59:20 INFO - TinderboxPrint: Swap in / out
386,670,592 / 0 11:59:20 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 345967104; Write bytes: 345323520; Read time: 26798; Write time: 701 11:59:20 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35591168; Write bytes: 301050368; Read time: 220; Write time: 1133 11:59:21 INFO - Running post-run listener: _upload_blobber_files 11:59:21 INFO - Blob upload gear active. 11:59:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:21 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 11:59:21 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'] 11:59:21 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 11:59:21 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:59:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:59:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:22 INFO - (blobuploader) - INFO - Done attempting. 11:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:23 INFO - (blobuploader) - INFO - Done attempting. 11:59:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:59:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:26 INFO - (blobuploader) - INFO - Done attempting. 11:59:26 INFO - (blobuploader) - INFO - Iteration through files over. 11:59:26 INFO - Return code: 0 11:59:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:59:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:59:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af6b852ed0a046619f0afc602d60d99ffc02859a2affb1d018494b19b44f89c518b63875942c713c823ec45a347203379b6fdd85f65b411782d32d092fa8c7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/235faac1affa8876ae9b6681544e6a199af72756a9bbc029ff17eb2933f98f9e8b043181326e239d8fac7850b2d47750cd7a437caf294b8289bce4394272abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be692bce0073fe472a27ecbf9a03ff40b074c17caa28642efd6614842f143fa5a96b6cc53bb227167e2b057fec24a9fa1852a5feef077ad526c7b8105db919f7"} 11:59:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:59:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:59:26 INFO - Contents: 11:59:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af6b852ed0a046619f0afc602d60d99ffc02859a2affb1d018494b19b44f89c518b63875942c713c823ec45a347203379b6fdd85f65b411782d32d092fa8c7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/235faac1affa8876ae9b6681544e6a199af72756a9bbc029ff17eb2933f98f9e8b043181326e239d8fac7850b2d47750cd7a437caf294b8289bce4394272abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be692bce0073fe472a27ecbf9a03ff40b074c17caa28642efd6614842f143fa5a96b6cc53bb227167e2b057fec24a9fa1852a5feef077ad526c7b8105db919f7"} 11:59:26 INFO - Running post-run listener: copy_logs_to_upload_dir 11:59:26 INFO - Copying logs to upload dir... 11:59:26 INFO - mkdir: /builds/slave/test/build/upload/logs 11:59:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.495384 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-21 11:59:26.194843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 11:59:26.198081) ========= 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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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/af6b852ed0a046619f0afc602d60d99ffc02859a2affb1d018494b19b44f89c518b63875942c713c823ec45a347203379b6fdd85f65b411782d32d092fa8c7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/235faac1affa8876ae9b6681544e6a199af72756a9bbc029ff17eb2933f98f9e8b043181326e239d8fac7850b2d47750cd7a437caf294b8289bce4394272abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be692bce0073fe472a27ecbf9a03ff40b074c17caa28642efd6614842f143fa5a96b6cc53bb227167e2b057fec24a9fa1852a5feef077ad526c7b8105db919f7"} build_url:https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/BxhOnofXRnWMaQG_c-F1Jw/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/af6b852ed0a046619f0afc602d60d99ffc02859a2affb1d018494b19b44f89c518b63875942c713c823ec45a347203379b6fdd85f65b411782d32d092fa8c7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/235faac1affa8876ae9b6681544e6a199af72756a9bbc029ff17eb2933f98f9e8b043181326e239d8fac7850b2d47750cd7a437caf294b8289bce4394272abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be692bce0073fe472a27ecbf9a03ff40b074c17caa28642efd6614842f143fa5a96b6cc53bb227167e2b057fec24a9fa1852a5feef077ad526c7b8105db919f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 11:59:26.231577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:59:26.231884) ========= 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.MVMC1RS2Hl/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.gp9Z1UykCB/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.004521 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:59:26.279311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 11:59:26.279601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 11:59:26.279890) ========= ========= Total master_lag: 0.18 =========