builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1469599137.03 results: success (0) buildid: 20160726203413 builduid: 61b716ac94bc4295b197f9b9c8593644 revision: 820cfffb1fe2b87a09d1c57d06d02107be8ac778 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.031932) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.032408) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.032683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.047808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.048121) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 22:58:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-07-26 22:58:57 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076943 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.139084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.139443) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015861 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.189778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.190124) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 820cfffb1fe2b87a09d1c57d06d02107be8ac778 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 820cfffb1fe2b87a09d1c57d06d02107be8ac778 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 22:58:57,725 truncating revision to first 12 chars 2016-07-26 22:58:57,725 Setting DEBUG logging. 2016-07-26 22:58:57,725 attempt 1/10 2016-07-26 22:58:57,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/820cfffb1fe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 22:58:58,038 unpacking tar archive at: fx-team-820cfffb1fe2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.922501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.922818) ========= script_repo_revision: 820cfffb1fe2b87a09d1c57d06d02107be8ac778 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.923191) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.923466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 22:58:57.932686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-26 22:58:57.932976) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:58 INFO - MultiFileLogger online at 20160726 22:58:58 in /builds/slave/test 22:58:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:58:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:58:58 INFO - {'append_to_log': False, 22:58:58 INFO - 'base_work_dir': '/builds/slave/test', 22:58:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:58:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:58:58 INFO - 'branch': 'Fx-Team-Non-PGO', 22:58:58 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:58 INFO - 'config_files': ('talos/linux_config.py',), 22:58:58 INFO - 'default_actions': ('clobber', 22:58:58 INFO - 'read-buildbot-config', 22:58:58 INFO - 'download-and-extract', 22:58:58 INFO - 'populate-webroot', 22:58:58 INFO - 'create-virtualenv', 22:58:58 INFO - 'install', 22:58:58 INFO - 'run-tests'), 22:58:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:58 INFO - 'download_minidump_stackwalk': True, 22:58:58 INFO - 'download_symbols': 'ondemand', 22:58:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:58 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:58 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:58 INFO - 'installer_path': 'installer.exe', 22:58:58 INFO - 'log_level': 'info', 22:58:58 INFO - 'log_name': 'talos', 22:58:58 INFO - 'log_to_console': True, 22:58:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:58 INFO - 'opt_config_files': (), 22:58:58 INFO - 'pip_index': False, 22:58:58 INFO - 'sps_profile': False, 22:58:58 INFO - 'sps_profile_interval': 0, 22:58:58 INFO - 'suite': 'dromaeojs', 22:58:58 INFO - 'system_bits': '32', 22:58:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:58 INFO - 'title': 'talos-linux64-ix-049', 22:58:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:58 INFO - 'use_talos_json': True, 22:58:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:58:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:58 INFO - 'work_dir': 'build'} 22:58:58 INFO - [mozharness: 2016-07-27 05:58:58.550619Z] Running clobber step. 22:58:58 INFO - Running pre-action listener: _resource_record_pre_action 22:58:58 INFO - Running main action method: clobber 22:58:58 INFO - rmtree: /builds/slave/test/build 22:58:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:58:59 INFO - Running post-action listener: _resource_record_post_action 22:58:59 INFO - [mozharness: 2016-07-27 05:58:59.042249Z] Finished clobber step (success) 22:58:59 INFO - [mozharness: 2016-07-27 05:58:59.042351Z] Running read-buildbot-config step. 22:58:59 INFO - Running pre-action listener: _resource_record_pre_action 22:58:59 INFO - Running main action method: read_buildbot_config 22:58:59 INFO - Using buildbot properties: 22:58:59 INFO - { 22:58:59 INFO - "project": "", 22:58:59 INFO - "product": "firefox", 22:58:59 INFO - "script_repo_revision": "production", 22:58:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:58:59 INFO - "repository": "", 22:58:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:58:59 INFO - "buildid": "20160726203413", 22:58:59 INFO - "pgo_build": "False", 22:58:59 INFO - "basedir": "/builds/slave/test", 22:58:59 INFO - "buildnumber": 2016, 22:58:59 INFO - "slavename": "talos-linux64-ix-049", 22:58:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:58:59 INFO - "platform": "ubuntu64_hw", 22:58:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:58:59 INFO - "branch": "fx-team", 22:58:59 INFO - "repo_path": "integration/fx-team", 22:58:59 INFO - "revision": "820cfffb1fe2b87a09d1c57d06d02107be8ac778", 22:58:59 INFO - "stage_platform": "linux64", 22:58:59 INFO - "builduid": "61b716ac94bc4295b197f9b9c8593644", 22:58:59 INFO - "slavebuilddir": "test" 22:58:59 INFO - } 22:58:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:58:59 INFO - Running post-action listener: _resource_record_post_action 22:58:59 INFO - [mozharness: 2016-07-27 05:58:59.044788Z] Finished read-buildbot-config step (success) 22:58:59 INFO - [mozharness: 2016-07-27 05:58:59.044877Z] Running download-and-extract step. 22:58:59 INFO - Running pre-action listener: _resource_record_pre_action 22:58:59 INFO - Running main action method: download_and_extract 22:58:59 INFO - mkdir: /builds/slave/test/build/tests 22:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:59 INFO - https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:58:59 INFO - Downloaded 1361 bytes. 22:58:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:59 INFO - Using the following test package requirements: 22:58:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:58:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'jsshell-linux-x86_64.zip'], 22:58:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:59 INFO - https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:59:00 INFO - Downloaded 22744359 bytes. 22:59:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:59:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:59:01 INFO - Return code: 0 22:59:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:01 INFO - https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:59:03 INFO - Downloaded 22744359 bytes. 22:59:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:59:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:59:05 INFO - Return code: 0 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:59:06 INFO - Downloaded 14413725 bytes. 22:59:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:59:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:59:06 INFO - Return code: 0 22:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:06 INFO - https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:59:08 INFO - Downloaded 57170651 bytes. 22:59:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:08 INFO - mkdir: /builds/slave/test/properties 22:59:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:59:08 INFO - Writing to file /builds/slave/test/properties/build_url 22:59:08 INFO - Contents: 22:59:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:09 INFO - Running post-action listener: _resource_record_post_action 22:59:09 INFO - Running post-action listener: set_extra_try_arguments 22:59:09 INFO - [mozharness: 2016-07-27 05:59:09.099368Z] Finished download-and-extract step (success) 22:59:09 INFO - [mozharness: 2016-07-27 05:59:09.099690Z] Running populate-webroot step. 22:59:09 INFO - Running pre-action listener: _resource_record_pre_action 22:59:09 INFO - Running main action method: populate_webroot 22:59:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:59:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:59:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:59:09 INFO - '--tppagecycles', 22:59:09 INFO - '7'], 22:59:09 INFO - 'tests': ['tsvgm']}}, 22:59:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:59:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:59:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:59:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:59:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['damp', 'tps']}, 22:59:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'tests': ['damp', 'tps']}, 22:59:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['dromaeo_dom']}, 22:59:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:59:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['basic_compositor_video']}, 22:59:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:59:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['a11yr', 22:59:09 INFO - 'ts_paint', 22:59:09 INFO - 'tpaint', 22:59:09 INFO - 'sessionrestore', 22:59:09 INFO - 'sessionrestore_no_auto_restore', 22:59:09 INFO - 'tabpaint']}, 22:59:09 INFO - 'other-e10s': {'tests': ['a11yr', 22:59:09 INFO - 'ts_paint', 22:59:09 INFO - 'tpaint', 22:59:09 INFO - 'sessionrestore', 22:59:09 INFO - 'sessionrestore_no_auto_restore', 22:59:09 INFO - 'tabpaint']}, 22:59:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:59:09 INFO - 'ts_paint', 22:59:09 INFO - 'tpaint', 22:59:09 INFO - 'sessionrestore', 22:59:09 INFO - 'sessionrestore_no_auto_restore', 22:59:09 INFO - 'tabpaint']}, 22:59:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:59:09 INFO - 'ts_paint', 22:59:09 INFO - 'tpaint', 22:59:09 INFO - 'sessionrestore', 22:59:09 INFO - 'sessionrestore_no_auto_restore', 22:59:09 INFO - 'tabpaint']}, 22:59:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['a11yr', 22:59:09 INFO - 'ts_paint', 22:59:09 INFO - 'tpaint', 22:59:09 INFO - 'sessionrestore', 22:59:09 INFO - 'sessionrestore_no_auto_restore', 22:59:09 INFO - 'tabpaint']}, 22:59:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['a11yr', 22:59:09 INFO - 'ts_paint', 22:59:09 INFO - 'tpaint', 22:59:09 INFO - 'sessionrestore', 22:59:09 INFO - 'sessionrestore_no_auto_restore', 22:59:09 INFO - 'tabpaint']}, 22:59:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['tsvgx', 22:59:09 INFO - 'tsvgr_opacity', 22:59:09 INFO - 'tart', 22:59:09 INFO - 'tscrollx', 22:59:09 INFO - 'cart']}, 22:59:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:59:09 INFO - 'tsvgr_opacity', 22:59:09 INFO - 'tart', 22:59:09 INFO - 'tscrollx', 22:59:09 INFO - 'cart']}, 22:59:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'talos_options': ['--disable-e10s'], 22:59:09 INFO - 'tests': ['tp5o']}, 22:59:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'tests': ['tp5o']}, 22:59:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'talos_options': ['--disable-e10s', 22:59:09 INFO - '--xperf_path', 22:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:09 INFO - 'tests': ['tp5n']}, 22:59:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:09 INFO - 'talos_options': ['--xperf_path', 22:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:09 INFO - 'tests': ['tp5n']}}, 22:59:09 INFO - 'talos.zip': {'path': '', 22:59:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:59:09 INFO - Running post-action listener: _resource_record_post_action 22:59:09 INFO - [mozharness: 2016-07-27 05:59:09.119549Z] Finished populate-webroot step (success) 22:59:09 INFO - [mozharness: 2016-07-27 05:59:09.119639Z] Running create-virtualenv step. 22:59:09 INFO - Running pre-action listener: _resource_record_pre_action 22:59:09 INFO - Running main action method: create_virtualenv 22:59:09 INFO - Creating virtualenv /builds/slave/test/build/venv 22:59:09 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 22:59:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:59:09 INFO - Using real prefix '/usr' 22:59:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 22:59:11 INFO - Installing pip.................done. 22:59:11 INFO - Return code: 0 22:59:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:11 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 22:59:11 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 22:59:11 INFO - Using env: {'DISPLAY': ':0', 22:59:11 INFO - 'HOME': '/home/cltbld', 22:59:11 INFO - 'LANG': 'en_US.UTF-8', 22:59:11 INFO - 'LANGUAGE': 'en_US:en', 22:59:11 INFO - 'LOGNAME': 'cltbld', 22:59:11 INFO - 'MAIL': '/var/mail/cltbld', 22:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:11 INFO - 'MOZ_NO_REMOTE': '1', 22:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:11 INFO - 'NO_EM_RESTART': '1', 22:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:11 INFO - 'PWD': '/builds/slave/test', 22:59:11 INFO - 'SHELL': '/bin/bash', 22:59:11 INFO - 'SHLVL': '1', 22:59:11 INFO - 'TERM': 'linux', 22:59:11 INFO - 'TMOUT': '86400', 22:59:11 INFO - 'USER': 'cltbld', 22:59:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:11 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 22:59:11 INFO - Cleaning up... 22:59:11 INFO - Return code: 0 22:59:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:11 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 22:59:11 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 22:59:11 INFO - Using env: {'DISPLAY': ':0', 22:59:11 INFO - 'HOME': '/home/cltbld', 22:59:11 INFO - 'LANG': 'en_US.UTF-8', 22:59:11 INFO - 'LANGUAGE': 'en_US:en', 22:59:11 INFO - 'LOGNAME': 'cltbld', 22:59:11 INFO - 'MAIL': '/var/mail/cltbld', 22:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:11 INFO - 'MOZ_NO_REMOTE': '1', 22:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:11 INFO - 'NO_EM_RESTART': '1', 22:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:11 INFO - 'PWD': '/builds/slave/test', 22:59:11 INFO - 'SHELL': '/bin/bash', 22:59:11 INFO - 'SHLVL': '1', 22:59:11 INFO - 'TERM': 'linux', 22:59:11 INFO - 'TMOUT': '86400', 22:59:11 INFO - 'USER': 'cltbld', 22:59:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:12 INFO - Downloading/unpacking psutil>=3.1.1 22:59:12 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 22:59:12 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 22:59:12 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 22:59:12 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 22:59:12 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 22:59:12 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 22:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:14 INFO - Installing collected packages: psutil 22:59:14 INFO - Running setup.py install for psutil 22:59:14 INFO - building 'psutil._psutil_linux' extension 22:59:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:59:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:59:14 INFO - building 'psutil._psutil_posix' extension 22:59:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:59:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:14 INFO - Successfully installed psutil 22:59:14 INFO - Cleaning up... 22:59:14 INFO - Return code: 0 22:59:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:14 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:14 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 22:59:14 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 22:59:14 INFO - Using env: {'DISPLAY': ':0', 22:59:14 INFO - 'HOME': '/home/cltbld', 22:59:14 INFO - 'LANG': 'en_US.UTF-8', 22:59:14 INFO - 'LANGUAGE': 'en_US:en', 22:59:14 INFO - 'LOGNAME': 'cltbld', 22:59:14 INFO - 'MAIL': '/var/mail/cltbld', 22:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:14 INFO - 'MOZ_NO_REMOTE': '1', 22:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:14 INFO - 'NO_EM_RESTART': '1', 22:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:14 INFO - 'PWD': '/builds/slave/test', 22:59:14 INFO - 'SHELL': '/bin/bash', 22:59:14 INFO - 'SHLVL': '1', 22:59:14 INFO - 'TERM': 'linux', 22:59:14 INFO - 'TMOUT': '86400', 22:59:14 INFO - 'USER': 'cltbld', 22:59:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:14 INFO - '_': '/tools/buildbot/bin/python'} 22:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:59:14 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 22:59:14 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 22:59:14 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 22:59:14 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 22:59:14 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 22:59:14 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 22:59:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:59:16 INFO - Installing collected packages: mozsystemmonitor 22:59:16 INFO - Running setup.py install for mozsystemmonitor 22:59:17 INFO - Successfully installed mozsystemmonitor 22:59:17 INFO - Cleaning up... 22:59:17 INFO - Return code: 0 22:59:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:59:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:17 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:17 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 22:59:17 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 22:59:17 INFO - Using env: {'DISPLAY': ':0', 22:59:17 INFO - 'HOME': '/home/cltbld', 22:59:17 INFO - 'LANG': 'en_US.UTF-8', 22:59:17 INFO - 'LANGUAGE': 'en_US:en', 22:59:17 INFO - 'LOGNAME': 'cltbld', 22:59:17 INFO - 'MAIL': '/var/mail/cltbld', 22:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:17 INFO - 'MOZ_NO_REMOTE': '1', 22:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:17 INFO - 'NO_EM_RESTART': '1', 22:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:17 INFO - 'PWD': '/builds/slave/test', 22:59:17 INFO - 'SHELL': '/bin/bash', 22:59:17 INFO - 'SHLVL': '1', 22:59:17 INFO - 'TERM': 'linux', 22:59:17 INFO - 'TMOUT': '86400', 22:59:17 INFO - 'USER': 'cltbld', 22:59:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:17 INFO - '_': '/tools/buildbot/bin/python'} 22:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:17 INFO - Downloading/unpacking jsonschema==2.5.1 22:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:19 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:19 INFO - warning: no files found matching '*.txt' 22:59:19 INFO - no previously-included directories found matching 'build' 22:59:19 INFO - no previously-included directories found matching 'dist' 22:59:19 INFO - no previously-included directories found matching '.git*' 22:59:19 INFO - Installing collected packages: jsonschema, functools32 22:59:19 INFO - Running setup.py install for functools32 22:59:19 INFO - warning: no files found matching '*.txt' 22:59:19 INFO - no previously-included directories found matching 'build' 22:59:19 INFO - no previously-included directories found matching 'dist' 22:59:19 INFO - no previously-included directories found matching '.git*' 22:59:19 INFO - Successfully installed jsonschema functools32 22:59:19 INFO - Cleaning up... 22:59:19 INFO - Return code: 0 22:59:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:59:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:59:19 INFO - Using env: {'DISPLAY': ':0', 22:59:19 INFO - 'HOME': '/home/cltbld', 22:59:19 INFO - 'LANG': 'en_US.UTF-8', 22:59:19 INFO - 'LANGUAGE': 'en_US:en', 22:59:19 INFO - 'LOGNAME': 'cltbld', 22:59:19 INFO - 'MAIL': '/var/mail/cltbld', 22:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:19 INFO - 'MOZ_NO_REMOTE': '1', 22:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:19 INFO - 'NO_EM_RESTART': '1', 22:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:19 INFO - 'PWD': '/builds/slave/test', 22:59:19 INFO - 'SHELL': '/bin/bash', 22:59:19 INFO - 'SHLVL': '1', 22:59:19 INFO - 'TERM': 'linux', 22:59:19 INFO - 'TMOUT': '86400', 22:59:19 INFO - 'USER': 'cltbld', 22:59:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:19 INFO - '_': '/tools/buildbot/bin/python'} 22:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:59:19 INFO - Cleaning up... 22:59:19 INFO - Return code: 0 22:59:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:59:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:59:19 INFO - Using env: {'DISPLAY': ':0', 22:59:19 INFO - 'HOME': '/home/cltbld', 22:59:19 INFO - 'LANG': 'en_US.UTF-8', 22:59:19 INFO - 'LANGUAGE': 'en_US:en', 22:59:19 INFO - 'LOGNAME': 'cltbld', 22:59:19 INFO - 'MAIL': '/var/mail/cltbld', 22:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:19 INFO - 'MOZ_NO_REMOTE': '1', 22:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:19 INFO - 'NO_EM_RESTART': '1', 22:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:19 INFO - 'PWD': '/builds/slave/test', 22:59:19 INFO - 'SHELL': '/bin/bash', 22:59:19 INFO - 'SHLVL': '1', 22:59:19 INFO - 'TERM': 'linux', 22:59:19 INFO - 'TMOUT': '86400', 22:59:19 INFO - 'USER': 'cltbld', 22:59:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:19 INFO - '_': '/tools/buildbot/bin/python'} 22:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:20 INFO - Downloading/unpacking blobuploader==1.2.4 22:59:20 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 22:59:20 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 22:59:20 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 22:59:20 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 22:59:20 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 22:59:20 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 22:59:21 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:59:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:22 INFO - Downloading docopt-0.6.1.tar.gz 22:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:22 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:22 INFO - Running setup.py install for blobuploader 22:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:59:22 INFO - Running setup.py install for requests 22:59:23 INFO - Running setup.py install for docopt 22:59:23 INFO - Successfully installed blobuploader requests docopt 22:59:23 INFO - Cleaning up... 22:59:23 INFO - Return code: 0 22:59:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:23 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:23 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 22:59:23 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 22:59:23 INFO - Using env: {'DISPLAY': ':0', 22:59:23 INFO - 'HOME': '/home/cltbld', 22:59:23 INFO - 'LANG': 'en_US.UTF-8', 22:59:23 INFO - 'LANGUAGE': 'en_US:en', 22:59:23 INFO - 'LOGNAME': 'cltbld', 22:59:23 INFO - 'MAIL': '/var/mail/cltbld', 22:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:23 INFO - 'MOZ_NO_REMOTE': '1', 22:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:23 INFO - 'NO_EM_RESTART': '1', 22:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:23 INFO - 'PWD': '/builds/slave/test', 22:59:23 INFO - 'SHELL': '/bin/bash', 22:59:23 INFO - 'SHLVL': '1', 22:59:23 INFO - 'TERM': 'linux', 22:59:23 INFO - 'TMOUT': '86400', 22:59:23 INFO - 'USER': 'cltbld', 22:59:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:23 INFO - '_': '/tools/buildbot/bin/python'} 22:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:23 INFO - Running setup.py (path:/tmp/pip-R2AM4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:23 INFO - Running setup.py (path:/tmp/pip-9ZngIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:23 INFO - Running setup.py (path:/tmp/pip-7G8MQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:23 INFO - Running setup.py (path:/tmp/pip-8PsBIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:23 INFO - Running setup.py (path:/tmp/pip-qPvJ0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:23 INFO - Running setup.py (path:/tmp/pip-kKEFnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:24 INFO - Running setup.py (path:/tmp/pip-CRNwch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:24 INFO - Running setup.py (path:/tmp/pip-Sy7p1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:24 INFO - Running setup.py (path:/tmp/pip-_opLmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:24 INFO - Running setup.py (path:/tmp/pip-5LJov0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:24 INFO - Running setup.py (path:/tmp/pip-QOvSRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:24 INFO - Running setup.py (path:/tmp/pip-AzjjjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:24 INFO - Running setup.py (path:/tmp/pip-YYPS6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:24 INFO - Running setup.py (path:/tmp/pip-xj4uhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:24 INFO - Running setup.py (path:/tmp/pip-m7XRor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:24 INFO - Running setup.py (path:/tmp/pip-H9gsbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:24 INFO - Running setup.py (path:/tmp/pip-lYpoLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:24 INFO - Running setup.py install for manifestparser 22:59:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:59:24 INFO - Running setup.py install for mozcrash 22:59:25 INFO - Running setup.py install for mozdebug 22:59:25 INFO - Running setup.py install for mozdevice 22:59:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Running setup.py install for mozfile 22:59:25 INFO - Running setup.py install for mozhttpd 22:59:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Running setup.py install for mozinfo 22:59:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Running setup.py install for mozInstall 22:59:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Running setup.py install for mozleak 22:59:25 INFO - Running setup.py install for mozlog 22:59:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Running setup.py install for moznetwork 22:59:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:59:25 INFO - Running setup.py install for mozprocess 22:59:26 INFO - Running setup.py install for mozprofile 22:59:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:59:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:59:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:59:26 INFO - Running setup.py install for mozrunner 22:59:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:59:26 INFO - Running setup.py install for mozscreenshot 22:59:26 INFO - Running setup.py install for moztest 22:59:26 INFO - Running setup.py install for mozversion 22:59:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:59:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:26 INFO - Cleaning up... 22:59:26 INFO - Return code: 0 22:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:26 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:26 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 22:59:26 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 22:59:26 INFO - Using env: {'DISPLAY': ':0', 22:59:26 INFO - 'HOME': '/home/cltbld', 22:59:26 INFO - 'LANG': 'en_US.UTF-8', 22:59:26 INFO - 'LANGUAGE': 'en_US:en', 22:59:26 INFO - 'LOGNAME': 'cltbld', 22:59:26 INFO - 'MAIL': '/var/mail/cltbld', 22:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:26 INFO - 'MOZ_NO_REMOTE': '1', 22:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:26 INFO - 'NO_EM_RESTART': '1', 22:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:26 INFO - 'PWD': '/builds/slave/test', 22:59:26 INFO - 'SHELL': '/bin/bash', 22:59:26 INFO - 'SHLVL': '1', 22:59:26 INFO - 'TERM': 'linux', 22:59:26 INFO - 'TMOUT': '86400', 22:59:26 INFO - 'USER': 'cltbld', 22:59:26 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:26 INFO - '_': '/tools/buildbot/bin/python'} 22:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:26 INFO - Running setup.py (path:/tmp/pip-A9gBAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:26 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)) 22:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:26 INFO - Running setup.py (path:/tmp/pip-stpUvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:26 INFO - Running setup.py (path:/tmp/pip-t5eURN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:27 INFO - Running setup.py (path:/tmp/pip-NdO7ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:27 INFO - Running setup.py (path:/tmp/pip-IGSg8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:27 INFO - Running setup.py (path:/tmp/pip-WRKG9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:27 INFO - Running setup.py (path:/tmp/pip-ZOaB6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:27 INFO - Running setup.py (path:/tmp/pip-0kpMbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:27 INFO - Running setup.py (path:/tmp/pip-qBgsGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:27 INFO - Running setup.py (path:/tmp/pip-YNieYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:27 INFO - Running setup.py (path:/tmp/pip-iWz6Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:27 INFO - Running setup.py (path:/tmp/pip-4KUNan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:27 INFO - Running setup.py (path:/tmp/pip-fDIZMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:27 INFO - Running setup.py (path:/tmp/pip-VkMaCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:27 INFO - Running setup.py (path:/tmp/pip-92gutb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:27 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)) 22:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:27 INFO - Running setup.py (path:/tmp/pip-POlu6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:28 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)) 22:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:28 INFO - Running setup.py (path:/tmp/pip-L_ZIDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:28 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)) 22:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:28 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)) 22:59:28 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)) 22:59:28 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)) 22:59:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:28 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 22:59:28 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 22:59:28 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 22:59:28 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 22:59:28 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 22:59:28 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 22:59:29 INFO - Downloading blessings-1.6.tar.gz 22:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:30 INFO - Installing collected packages: blessings 22:59:30 INFO - Running setup.py install for blessings 22:59:30 INFO - Successfully installed blessings 22:59:30 INFO - Cleaning up... 22:59:30 INFO - Return code: 0 22:59:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:30 INFO - Reading from file tmpfile_stdout 22:59:30 INFO - Current package versions: 22:59:30 INFO - argparse == 1.2.1 22:59:30 INFO - blessings == 1.6 22:59:30 INFO - blobuploader == 1.2.4 22:59:30 INFO - docopt == 0.6.1 22:59:30 INFO - functools32 == 3.2.3-2 22:59:30 INFO - jsonschema == 2.5.1 22:59:30 INFO - manifestparser == 1.1 22:59:30 INFO - mozInstall == 1.12 22:59:30 INFO - mozcrash == 0.17 22:59:30 INFO - mozdebug == 0.1 22:59:30 INFO - mozdevice == 0.48 22:59:30 INFO - mozfile == 1.2 22:59:30 INFO - mozhttpd == 0.7 22:59:30 INFO - mozinfo == 0.9 22:59:30 INFO - mozleak == 0.1 22:59:30 INFO - mozlog == 3.3 22:59:30 INFO - moznetwork == 0.27 22:59:30 INFO - mozprocess == 0.23 22:59:30 INFO - mozprofile == 0.28 22:59:30 INFO - mozrunner == 6.12 22:59:30 INFO - mozscreenshot == 0.1 22:59:30 INFO - mozsystemmonitor == 0.3 22:59:30 INFO - moztest == 0.7 22:59:30 INFO - mozversion == 1.4 22:59:30 INFO - psutil == 3.1.1 22:59:30 INFO - requests == 1.2.3 22:59:30 INFO - wsgiref == 0.1.2 22:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:30 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 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:30 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 22:59:30 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 22:59:30 INFO - Using env: {'DISPLAY': ':0', 22:59:30 INFO - 'HOME': '/home/cltbld', 22:59:30 INFO - 'LANG': 'en_US.UTF-8', 22:59:30 INFO - 'LANGUAGE': 'en_US:en', 22:59:30 INFO - 'LOGNAME': 'cltbld', 22:59:30 INFO - 'MAIL': '/var/mail/cltbld', 22:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:30 INFO - 'MOZ_NO_REMOTE': '1', 22:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:30 INFO - 'NO_EM_RESTART': '1', 22:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:30 INFO - 'PWD': '/builds/slave/test', 22:59:30 INFO - 'SHELL': '/bin/bash', 22:59:30 INFO - 'SHLVL': '1', 22:59:30 INFO - 'TERM': 'linux', 22:59:30 INFO - 'TMOUT': '86400', 22:59:30 INFO - 'USER': 'cltbld', 22:59:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:30 INFO - '_': '/tools/buildbot/bin/python'} 22:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 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)) 22:59:30 INFO - Cleaning up... 22:59:30 INFO - Return code: 0 22:59:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:59:30 INFO - Using env: {'DISPLAY': ':0', 22:59:30 INFO - 'HOME': '/home/cltbld', 22:59:30 INFO - 'LANG': 'en_US.UTF-8', 22:59:30 INFO - 'LANGUAGE': 'en_US:en', 22:59:30 INFO - 'LOGNAME': 'cltbld', 22:59:30 INFO - 'MAIL': '/var/mail/cltbld', 22:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:30 INFO - 'MOZ_NO_REMOTE': '1', 22:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:30 INFO - 'NO_EM_RESTART': '1', 22:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:30 INFO - 'PWD': '/builds/slave/test', 22:59:30 INFO - 'SHELL': '/bin/bash', 22:59:30 INFO - 'SHLVL': '1', 22:59:30 INFO - 'TERM': 'linux', 22:59:30 INFO - 'TMOUT': '86400', 22:59:30 INFO - 'USER': 'cltbld', 22:59:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:30 INFO - '_': '/tools/buildbot/bin/python'} 22:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:59:31 INFO - Cleaning up... 22:59:31 INFO - Return code: 0 22:59:31 INFO - Running post-action listener: _resource_record_post_action 22:59:31 INFO - Running post-action listener: _start_resource_monitoring 22:59:31 INFO - Starting resource monitoring. 22:59:31 INFO - [mozharness: 2016-07-27 05:59:31.143915Z] Finished create-virtualenv step (success) 22:59:31 INFO - [mozharness: 2016-07-27 05:59:31.144400Z] Running install step. 22:59:31 INFO - Running pre-action listener: _resource_record_pre_action 22:59:31 INFO - Running main action method: install 22:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:31 INFO - Reading from file tmpfile_stdout 22:59:31 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:59:31 INFO - Reading from file tmpfile_stdout 22:59:31 INFO - Output received: 22:59:31 INFO - Usage: mozinstall [options] installer 22:59:31 INFO - Options: 22:59:31 INFO - -h, --help show this help message and exit 22:59:31 INFO - -d DEST, --destination=DEST 22:59:31 INFO - Directory to install application into. [default: 22:59:31 INFO - "/builds/slave/test"] 22:59:31 INFO - --app=APP Application being installed. [default: firefox] 22:59:31 INFO - mkdir: /builds/slave/test/build/application 22:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:59:47 INFO - Reading from file tmpfile_stdout 22:59:47 INFO - Output received: 22:59:47 INFO - /builds/slave/test/build/application/firefox/firefox 22:59:47 INFO - Running post-action listener: _resource_record_post_action 22:59:47 INFO - [mozharness: 2016-07-27 05:59:47.852210Z] Finished install step (success) 22:59:47 INFO - [mozharness: 2016-07-27 05:59:47.852491Z] Running run-tests step. 22:59:47 INFO - Running pre-action listener: _resource_record_pre_action 22:59:47 INFO - Running main action method: run_tests 22:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:59:47 INFO - Python 2.7.3 22:59:47 INFO - Return code: 0 22:59:47 INFO - grabbing minidump binary from tooltool 22:59:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:47 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/linux64/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 0x2a353b0>, '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 0x2a362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:59:47 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:59:47 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/linux64/releng.manifest -o -c /builds/tooltool_cache 22:59:47 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:59:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:47 INFO - Return code: 0 22:59:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:59:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:59:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:59:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:59:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 22:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 22:59:47 INFO - Using env: {'DISPLAY': ':0', 22:59:47 INFO - 'HOME': '/home/cltbld', 22:59:47 INFO - 'LANG': 'en_US.UTF-8', 22:59:47 INFO - 'LANGUAGE': 'en_US:en', 22:59:47 INFO - 'LOGNAME': 'cltbld', 22:59:47 INFO - 'MAIL': '/var/mail/cltbld', 22:59:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:59:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:47 INFO - 'MOZ_NO_REMOTE': '1', 22:59:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:47 INFO - 'NO_EM_RESTART': '1', 22:59:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:47 INFO - 'PWD': '/builds/slave/test', 22:59:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:59:47 INFO - 'SHELL': '/bin/bash', 22:59:47 INFO - 'SHLVL': '1', 22:59:47 INFO - 'TERM': 'linux', 22:59:47 INFO - 'TMOUT': '86400', 22:59:47 INFO - 'USER': 'cltbld', 22:59:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172', 22:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:47 INFO - '_': '/tools/buildbot/bin/python'} 22:59:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 22:59:48 INFO - mozversion application_buildid: 20160726203413 22:59:48 INFO - mozversion application_changeset: 820cfffb1fe2b87a09d1c57d06d02107be8ac778 22:59:48 INFO - mozversion application_display_name: Nightly 22:59:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:48 INFO - mozversion application_name: Firefox 22:59:48 INFO - mozversion application_remotingname: firefox 22:59:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:48 INFO - mozversion application_vendor: Mozilla 22:59:48 INFO - mozversion application_version: 50.0a1 22:59:48 INFO - mozversion platform_buildid: 20160726203413 22:59:48 INFO - mozversion platform_changeset: 820cfffb1fe2b87a09d1c57d06d02107be8ac778 22:59:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:48 INFO - mozversion platform_version: 50.0a1 22:59:48 INFO - using testdate: 1469599188 22:59:48 INFO - actual date: 1469599188 22:59:48 INFO - starting webserver on 'localhost:47967' 22:59:48 INFO - SUITE-START | Running 2 tests 22:59:48 INFO - TEST-START | dromaeo_css 22:59:48 INFO - operating with platform_type : linux_ 22:59:48 INFO - Initialising browser for dromaeo_css test... 22:59:48 INFO - TEST-INFO | started process 24107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2BBJtB/profile http://localhost:47967/getInfo.html) 22:59:51 INFO - PROCESS | 24107 | JavaScript error: , line 0: uncaught exception: undefined 22:59:52 INFO - PROCESS | 24107 | __metrics Screen width/height:1600/1200 22:59:52 INFO - PROCESS | 24107 | colorDepth:24 22:59:52 INFO - PROCESS | 24107 | Browser inner width/height: 1024/697 22:59:52 INFO - PROCESS | 24107 | __metrics 22:59:53 INFO - PROCESS | 24107 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:59:53 INFO - PROCESS | 24107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:59:54 INFO - TEST-INFO | 24107: exit 0 22:59:54 INFO - Browser initialized. 22:59:54 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:54 INFO - TEST-INFO | started process 24188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2BBJtB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:06 INFO - PROCESS | 24188 | RSS: Main: 159358976 23:00:06 INFO - PROCESS | 24188 | 23:00:58 INFO - PROCESS | 24188 | 1469599258250 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] 23:03:10 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:47967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47967/tests/dromaeo/cssquery-ext.html) 23:03:11 INFO - PROCESS | 24188 | RSS: Main: 275795968 23:03:11 INFO - PROCESS | 24188 | 23:06:14 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:47967/tests/dromaeo/cssquery-ext.html (next: http://localhost:47967/tests/dromaeo/cssquery-jquery.html) 23:06:14 INFO - PROCESS | 24188 | RSS: Main: 238592000 23:06:14 INFO - PROCESS | 24188 | 23:09:17 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:47967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47967/tests/dromaeo/cssquery-mootools.html) 23:09:17 INFO - PROCESS | 24188 | RSS: Main: 183844864 23:09:17 INFO - PROCESS | 24188 | 23:12:19 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:47967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47967/tests/dromaeo/cssquery-prototype.html) 23:12:20 INFO - PROCESS | 24188 | RSS: Main: 191291392 23:12:20 INFO - PROCESS | 24188 | 23:15:23 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:47967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47967/tests/dromaeo/cssquery-yui.html) 23:15:24 INFO - PROCESS | 24188 | RSS: Main: 186347520 23:15:24 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:47967/tests/dromaeo/cssquery-yui.html (next: http://localhost:47967/tests/dromaeo/cssquery-dojo.html) 23:18:27 INFO - PROCESS | 24188 | RSS: Main: 278581248 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | __start_tp_report 23:18:27 INFO - PROCESS | 24188 | _x_x_mozilla_page_load 23:18:27 INFO - PROCESS | 24188 | _x_x_mozilla_page_load_details 23:18:27 INFO - PROCESS | 24188 | |i|pagename|runs| 23:18:27 INFO - PROCESS | 24188 | |0;dojo.html;2608.8434693918366;2618.384679600295;2651.045623575513;2663.8268512546683;2665.533531631964;4557.908841823161;4600.263957766758;4695.6947798393085;4730.0776348612035;4731.71609703418;4643.210654188788;4659.603933665642;4679;4720.929186062212;4739.5023522530155;4225.746455212682;4240.23675738367;4246.044639956016;4286.357046443028;4343.543927887574;4299.355096735483;4330.56694330566;4400.713953593022;4422.6240769534625;4440.844570440036;4301.440812694361;4348.652107831366;4348.695591308609;4365.607095361417;4366.410534577839;4192.45498085247;4231.069164783773;4262.12626411588;4305.547917468652;4328.264195086811;4286.207051695446;4301.2902871026245;4303.31147016479;4306.35404689296;4331.501877284121;4718.764061796931;4755;4759.4764575896625;4763.285507173917;4768.856934291976;4731.195696731564;4912;4981.252812078181;4998.550130488237;5040;5030.773615187289;5067.062593420229;5070.670406423607;5080.974595127038;5085.186370180791;4704.176769065434;4711;4715.7877895494785;4753.881152971134;4762.404699412574;4929.309896614477;4953.8266160684925;4984.800607975713;5015.247712843103;5026.673266237756;4843.297721830385;4844.442889067803;4882.389701287339;4904;4904.5340692634145;4947.505249475023;4947.82682606107;4986.8753281168265;4991.101601711654;4995.050940321327;4798.4001999750035;4866.46468888422;4882.2432522959;4884.438289596742;4920.065187614342;4963.5780958618925;4964.032013757283;4969.503049695001;5011.724355160428;5020.548150666385;4250.681198910094;4253.149370125987;4254.234237837157;4281.571842815756;4289.549597292239;3659.2681463707363;3665.4135338345736;3719.5350581177354;3730.5336832895887;3786.659200671953;4271.786410679453;4331.198728235287;4332.176886391576;4379.58393952574;4385.188740083095;5022.221555658879;5031.52200540948;5032.245163225472;5033.094043072282;5074.517920797518;4305.07440900208;4340.023494713664;4350.477942646902;4370.825166993348;4384.69307148503;4333.523312435629;4398.076403955205;4437.64498840092;4444.088961762831;4466.151431228056;4658.883527911694;4666.883327916694;4670.392848929753;4697.694649847749;4711.905761884812;4962.230854217602;4963.528464795839;4969.031038947371;4972.154733695208;5000.374953130859;4532.0256144929;4673.696209746356;4680.7191568506;4718.268668356411;4723.31511930775;4956.207006878882;4957.380327459067;4957.603391728581;4995.225740010159;5013.498650134958;5013.24801279811;5016.247562865599;5020.623453240948;5024.698518088926;5073.771680274471;4677.579017888406;4844.878878028077;4885.438174609823;4906.337644417958;4947.480514546065;4845.103655823684;4867.58625516835;4870.2938073979785;4889.951100488949;4916.877078072934;4793.9280910785665;4832.20268655682;4838.637102217418;4842.903141937212;4848.054629347384;4739.146953548395;4785.377900872864;4836.274558816206;4878.536539028786;4888.095702294944;4788.018456216398;4816.373871396696;4819.349387832738;4840.322354870251;4863.8540843774745 23:18:27 INFO - PROCESS | 24188 | |1;ext.html;547.6557830504705;575.8675504633936;578.7279978410146;578.9739461724222;600.9549283803715;27306.317342066457;39642;40778;40789.184216315654;40816.59183408172;41049.38425923606;41710;41733.16533669325;41748;41798.37302440458;7656.770296891103;7734.7679569613;7773.183815699355;7778.805529861742;7783.76648700537;7804.60976951153;7862.371010319161;7865.567393793339;7888.092869320016;7897.960510197441;7837.0987336456465;7917.604119794016;7917.7624671259955;7923.168067352932;7958.084820245659;7867.370610351159;7903.288704016609;7922.7227047053075;7929.484583502054;7929.603519823986;7595.354394876442;7638.083429988437;7682.8079298018;7687.2697093776005;7691.2693294137525;39061.21877562461;39216;39264.60735392638;39337.803310983545;39434.408483872765;2920.6933272006345;3076.26169719268;3241.7082462578246;3664.387669425471;3736.252749450121;28865.711342886512;29263.41473170525;29263.853680731674;29282.853585732148;29392.70607293921;2894.7394734473787;3014.4121896230245;3083.8766449342;3091.938161236785;3186.9203269918207;268099;269736;269800;270576;271045;31784.68215317817;32904.3419131616;52167.73916130471;52554.63504142323;52605.473945260055;34053.31893362119;34337.65662343395;34410.48384274238;34477.82761086229;34493;12937.417816198295;13077.673058173621;13081.41133648988;13114.409851556702;13143.802842957364;10853.131749460024;10916.890831091747;10933.234673572773;10944;10950.123990080774;7911.564863932424;7934.166912474223;7958.323542498837;8006.039275287003;8023.719169829028;3096.3188098618266;3114.7352475039875;3133.9686603134132;3140.8586613602442;3141.9057428277188;805.6616221187115;885.0750965241339;959.836827739286;986.2061040862175;1015.7714514234239;25996.480070398487;26203;26613.334666633487;26788;26808.865955670488;758.859610971972;895.2658819767859;940.7648087978006;947.8672985781996;1003.5634498992962;13123.212607243597;13586.714945686103;13699.657508562366;13928.233947133005;14044.157350558999;421233;424729;424893;426645;428266;49019.509804902205;49116.263256051185;49205;49441;49585.50414495881;1078.1859695929522;1133.0652211925194;1169.8771628979175;1187.3054263255747;1204.5543149034913;27506.449871002867;28420.85789571039;28873.85563072171;28892;29201.41597168087;42256.36615450709;42613.36079958741;42642.5735742651;42690.35964460474;42759;256653;256835;257486;257772;626147;37304.25391492209;37815.810920945216;39149.2170156601;39618.60381396149;39752;41650.58349416467;42107.789461052496;42204.57795422129;42327.57672423236;43111.784441078846;36263.81868090643;36387.090322742144;36523.634763653085;36955.81522092372;37518.06204844901;35876.103097422776;36721.81639091788;37011.62988370082;37662.435063473524;38101;34626.82686586551;35113.122171945906;35326.47010294796;35588.822055889555;35666.64333356737;30734.385312294075;32931.176720582174;32959.340813184084;33348.83325583357;33371.33257334888;24316.878415607807;24955.251342459756;25586.872065639553;25686.357841054123;25727.356816079748 23:18:27 INFO - PROCESS | 24188 | |2;jquery.html;349.4496168534559;365.1619533171372;367.97976111313886;377.7091639437634;388.87555982085746;12695.492180312787;16199.75700364494;16654.666906661874;17992.370267040656;18176.272949082053;16630.750538741897;17418.912905435456;17455.91272043638;17488.21303041363;17621.823781762178;5072.391313042431;5236.79052837888;5447.455254474541;5479.04116779564;5580.274564306635;3800.524934383202;3991.2815693175216;5511.311086114236;5543.279373681436;5548.223248745158;3974.523057233136;5890.941090589104;6130.1111338855835;6154.815355539341;6266.37336266372;5570.220169176318;5597.496225339698;5639.407862174454;6238.189035425411;6255.405736455053;5495.120780675113;5495.697736624484;5496.120620700709;5496.4503549645115;5498.5876059295715;11191.552337906474;11395.829062564067;11535.59625413115;11541.538338466451;11684.824727629093;1700.948971530856;1735.8611311095083;1773.733939909011;1975.8518111141723;2106.631339515594;8532.402731808776;9357.53212339387;10321.845172322346;10528.789424211549;13904.304784760721;1719.9828001719948;1746.1967494952337;1782.08222765276;1844.6218525202435;1865.4963159946738;45497;55139.44860551383;62445.06332405018;68625;71108.28891711068;9630.4703241321;9789.608415663437;9954.751131221778;10060.496975151213;10206.846897296546;13690.65773355674;13704.725905481835;13707.451701931812;13718.862811371759;13725.245111518763;7123.358897699232;7157.7136914522835;7301.452391070691;7361.668724907392;7379.077615298088;6906.758263460855;6950.79147625572;6951.652417379212;7081.89377159343;7121.394681452031;4275.722078064916;4310.827566897289;4331.913361732748;4352.552805976792;4356.499002614676;1726.5510967148632;1790.3823181002533;1808.1592059692043;1856.8062931757356;1882.9152688129068;376.60644626365513;380.33631313358364;406.68481926507195;677.6819086875979;685.8559702462439;10404.323718958243;10483.633072842415;10713.946430267955;10720.142388608892;10788.190885683449;402.36828179758083;778.8598052350518;824.1099612418574;846.6613354658186;852.424613385962;8439.704610338731;9120.491864737118;9153.954230228806;9234.261259099256;9322.20761235289;368719;369048;372454;373642;390559;74344.88482672765;74546.62726686332;75417.62291188509;76768.61615691886;77192.61403692946;878.9340799440067;929.7675581104724;936.9437833729997;941.2893265584577;970.2335155227291;15170.772438413213;15372;15848.1283529407;16009;16327.265273062978;36045.0988725284;41106.794466028674;41234.38148427716;41705.37441938313;41739;45623.77188114038;52907.20639190338;52947.47052529425;53805.192922105416;54932.17601735897;7584.876234654305;7800.336971357498;7922.0889597697005;8058.476199047043;8140.226678465537;11894.643160705193;11998.520059197534;12308.692282693004;12348.320842353756;12513.499460021498;9475.289353298393;9779.60881564758;9873.753156171153;9994.500824876326;10428.217883658908;10259.487025648838;10519.89480105189;10574.471276435994;10584.100351470212;10658.680239592824;9721.368111072758;9983.850242246517;10298.691039268833;10339.121174700234;10444.955504449494;7222;7373.410127189919;7453;7580.090389153337;7773.41699372538;8197;9598.904010960081;9747.317687762072;9892.258080644124;10117.848232276374 23:18:27 INFO - PROCESS | 24188 | |3;mootools.html;1334.31282889312;1369.1579678497724;1402.7615305398087;1592.1959410497698;1619.7894273744419;7453.105627324722;8004.879926801088;8012.399070069746;8018.91981080189;8022.398320125984;6617.172853393326;6798.45612351012;6799.388055075042;7013.403860671849;7898.5260884346835;1903.9048047597598;2107.7470703515523;2173.9347819565437;2189.277538412328;2209.8895055247253;2254.537819746948;2274.5678321118935;2276.692646492727;2281.292799232235;2282.201229569654;2166.0685905060895;2242.159190303636;2252.9211477598287;2258.2660635293596;2260.050778672953;2157.5361297321074;2163.9134434622597;2173.3154056472163;2203.966940495894;2206.8896555172178;2148.269588339972;2157.6547752359547;2165.263810304504;2167.5556510915226;2195.056125865877;7909.1299957004685;8014.038315402131;8055.718049868226;8063.798405039863;8095.150009249061;4539.500654927955;4664.440267167927;4675.345451636774;4678.555537223959;4681.274402467623;2736.7536921677147;2837.4466978939117;2881.9855900720363;2887.133859842039;2908;909.9272058235325;913.8766266554063;914.437620863171;924.990750092504;932.6455946740263;10519.579216831318;10525.894741052569;10530.894691053145;10577.894221057768;10581.15350771944;4227.239096962515;4259.084296876186;4376.934345984812;4400.889977750582;4403.53762854902;8208.958955205186;8341.24928756415;8345.791355216168;8350.123237060143;8420.8315833683;4401.18578063053;4419.911601767946;4424.7123936944;4424.84513042042;4430.5126436092005;3977.7812220327583;4013.5986401359633;4033.334499807499;4038.273110840077;4237.194932962727;3302.7688061835443;3354.228527438654;3432.1419645088727;3442.0706409269355;3455.7926524408617;977.9608815647294;1008.1984822066474;1013.6553571785628;1016.6035246253966;1018.3228153277987;644.2944975252092;730.3426915775844;752.161340105789;794.9801254968672;816.46929495827;4977.601791856643;5036.11867923112;5181.792728290826;5219.19102539107;5432.2123292123215;395.05581659833024;399.99000024999606;414.1344589807317;416.0410254363721;418.71736577809855;3499.5275637788573;3641.289948460078;3654.1230104774663;3695.427208782643;3818;9257.120573545502;9746.561404736804;9785.853212201822;9787.853182202272;9803.754906127404;9743.074407931235;9751.853722194173;9777.511124443748;9786.951065244628;9794.853077203848;7293.307135822089;7360.374368178765;7391.593462359622;7422.814429639194;7485.7754267372065;5194.610404219623;5201.011807756514;5262.9210561842365;5285.920711189412;5381.2197231402015;9028.503432311287;9105.317101217302;9123.498207598646;9163.312751543528;9224.215941644767;8709;9120.179183873483;9310.72067837966;9313.674021409219;9324.067593240621;5976.372480889444;6674.632895190811;7053.0830991970715;7267.454940879349;7359.337659610446;7186.353228209487;7420.591867447126;7438.9628051861555;7444.330010299099;7449.851002980018;6690.364415380531;6707.932920670926;6723.9327606725265;6750.5274630775375;6792.72829086831;6535.085088087767;6596.142501474969;6618.900716489353;6653.733850646114;6717.899231511434;6008.699565021644;6310.211223597051;6356.078368636614;6363.90454143179;6374.4900407966325;4296.742195468282;4456.5766252205985;4457.219986502284;4643.605293549951;4732.148213321498;4500.392447019611;4595.126925884071;4595.954040459686;4605.286180642006;4978.576820970258 23:18:27 INFO - PROCESS | 24188 | |4;prototype.html;306.39792807133983;307.7445720052358;313.57197425514175;315.2198309184768;315.23398142513713;4613.446386433624;4766.571008609225;4782.0871651339485;4799.7120172789655;4835.806567737291;4548.181327361073;4687.437507499105;4705.788279508625;4714.151452738506;4726.172919739049;3801.6388443097862;3802.5817160112365;3805.238952209569;3806.7906265155407;3832.8152952816904;3584.354816133095;3653.762505437138;3825.8469661213658;3832.405977073558;3847.6729477994404;3772.188979369435;3778.4332350147424;3781.243751249747;3783.9432408513894;3795.829187686547;3769.283836071151;3777.1690228149764;3781.6218378162102;3794.2356804085957;3800.4869342638667;3390.3727810355163;3400.4559270516597;3402.387570237356;3410.300888317889;3413.8151582986907;4509.571590698878;4658.254679251338;4669.042846216517;4669.229577119771;4705.082508910764;4275.123599662062;4277.743335399886;4297.527272000078;4311.37485064667;4315.4821421429315;4926.655134140611;4933.481984391623;4934.014920972796;4936.629752768521;4937.432195297551;3581.4806853006166;3662.212624285765;3662.377395842713;3665.5601327840563;3668.137987572918;5172.508611681884;5174.3790745110455;5177.922331165036;5185.507376799235;5189.455107213764;3748.3627783276906;3756.492873462102;3768.9434658480145;3773.9621604058552;3791.7156213284115;3827.3110840048503;3829.8659546915724;3840.5391353037257;3840.5583357914197;3840.9039774005873;4122.175564887035;4221.767802770815;4240.5123410808155;4244.915101697949;4245.936310955338;4916.926246106311;4931.827386041543;4938.925916111261;4960.280759289883;4967.05625931072;1255.3785875991443;1289.8710128987213;1290.7289469211382;1305.6474751816957;1321.6101250131235;897.2373482539789;902.251131560803;908.7731562390719;932.3799673217235;941.5715849288557;4365.781710914442;4381.342798580238;4382.729008587474;4385.9955930187925;4400.471943366816;5083.135866902636;5088.262201980692;5110.28456016158;5117.769700363493;5126.102931986888;4321.308590625485;4456.732596044183;4462.464504259445;4481.5294394088805;4482.843100491467;2723.7276272372605;2726.8956072790156;2740.671119465637;2742.890284388642;2743.327884668229;4711.882202944886;4840.346553215341;4852.636052296092;4868;4889;5123.897522049539;5224.320838290998;5227.686338819683;5233.215017747369;5248.868778280497;4835.661503694778;4847.466778654345;4852.344933433941;4854.126257273725;4863.173260545645;4920.335754673073;5119.769610367617;5145.485451454824;5155.43290238081;5172.172452407597;5069.214271787879;5079.568236699922;5083.161278389172;5086.338775959101;5103.5661968733075;4778.5699287064335;4822.7829747660735;4828.589569886599;4860.92708609364;4872.561469467623;3646.6717995380545;3676.816159192083;3687.9815600921825;3711.3876210426056;3738.5606541481184;4977.9751101244265;5187.299714538489;5194;5197.0125676121415;5218.191180367049;4976.975115124401;4985.551300382838;5008.574271186844;5038.949610503848;5041.932807549034;4818.590419814355;4969.950300496948;5003.524665156804;5017.523335283142;5021.146405111067;4682.4381074271305;4814.15752243363;4927.679700819435;4938.604911607134;4951.2078067510465;5015.1474249378425;5019.247112932943;5027.74861256943;5028.446870844131;5029;4924.7537623119415;4927.802887884444;4935.75321233944;4938.234573641092;4940 23:18:27 INFO - PROCESS | 24188 | |5;yui.html;596.7612954818073;660.1945626335869;666.2604508995017;720.4596552585559;733.6295170938679;13167.736645267089;14172.220527870963;14357.641058973517;14375.137491750502;14430.134191948491;13058.542950996716;13159.27623980683;13174.802377964314;13182.73634527309;13193.076484646079;628.472083449902;739.7373932254026;768.0476209500235;770.0874463760462;770.9113451953014;777.013193244579;777.5295945952673;780.7657702689199;781.4256521456725;781.9765407037798;829.1128492513013;830.9667613295461;831.9001719793633;832.7085520067989;833.6123702478346;661.8874791285469;684.2199892122984;684.6645143879513;687.2680595166132;830.5265998380895;580.3760956971231;593.4540222994855;594.7650677982216;596.1147695671924;596.1742985964427;13228.933855330759;13231.470741170342;13260;13263.867361326456;13286;12124;12370.62888113349;12587.811182832265;12713.682157946032;13190.4064317105;11498;11680;11853.288802671781;11936.403179840972;12403;3974.7615143091507;4004.8798536043964;4052.5542190359038;4089.9795501022304;4091.89770255743;59921.40078599245;60683.69658151725;60948;61014.38985610131;61440.38559614391;9153.267738580898;9513;9946.026244119832;10037.096661300518;10176.440295783656;18620.44138675842;18633.90683046576;18656.440306790817;18681.43955681332;18739.250429982647;6469.644169570719;6604.900926486107;6640.8671826563195;6667.366600172976;6816.386525212754;3442.913927151841;3520.307168932974;3538.716902647782;3558.6868535451645;3607.74745767799;2649.602559616073;2717.891284348604;2722.1153125234378;2726.8636568171514;2732.3715545424666;451.6770509086019;460.2681736039713;461.32416010544046;468.2017160740929;472.8486884197024;444.508817756381;561.7780976514335;566.7138095261948;576.2451188942499;595.5741644724043;7001.859962800817;7299.963500182571;7467.887981680279;7545.358644515168;7610.8097297568;427.6877879148239;469.94125734283216;470.02938931107155;510.75228514170595;526.3736153976755;3250.723688486505;3478.3043391321835;3481.4603736420895;3593.137646964762;3646.927061458756;94875;98323;98910;100966;102089;65302.34697653058;66087;67040;78481.21518784853;79917.60041199873;43589;43902.12195756067;55666.721666392215;64696.676516618056;67192;8438.493690378597;8747.562621869009;8991.41555798871;9040.231580315747;9171.495567743837;32738.181545461553;36534.269314613026;43514.34728479012;44303.77848110739;45487;63028;63972.68013660088;64838.67580662067;65793.67103164454;66792.33207668056;11415.143864210384;11450;11614.883851161718;11738.060955123741;12258.325792081521;12667.556635517712;12913.548025819051;12991.610251692464;13295.401706923018;13495.797563036758;12273.570425035081;12286.815697764361;12524.060695447695;12999.220046797222;13024.47902083906;12382.318972456602;12784.6803829905;12786.808197876853;13045.804312935503;13275.386010905102;11610.24533405326;11681.007114395372;11740;11746.823797643214;11967.042636589225;9777.6193234995;10046.849297260693;10315.948420257851;10324.43215623118;10807;9937.751556211153;10197.541110650187;10203.795924081625;10249.231307651808;10260.897391026292 23:18:27 INFO - PROCESS | 24188 | __end_tp_report 23:18:27 INFO - PROCESS | 24188 | __start_cc_report 23:18:27 INFO - PROCESS | 24188 | _x_x_mozilla_cycle_collect,1153 23:18:27 INFO - PROCESS | 24188 | __end_cc_report 23:18:27 INFO - PROCESS | 24188 | __startTimestamp1469600307515__endTimestamp 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | ------- Summary: start ------- 23:18:27 INFO - PROCESS | 24188 | Number of tests: 6 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | [#0] dojo.html Cycles:165 Average:4617.79 Median:4753.88 stddev:471.80 (9.9%) stddev-sans-first:446.15 23:18:27 INFO - PROCESS | 24188 | Values: 2608.8 2618.4 2651.0 2663.8 2665.5 4557.9 4600.3 4695.7 4730.1 4731.7 4643.2 4659.6 4679.0 4720.9 4739.5 4225.7 4240.2 4246.0 4286.4 4343.5 4299.4 4330.6 4400.7 4422.6 4440.8 4301.4 4348.7 4348.7 4365.6 4366.4 4192.5 4231.1 4262.1 4305.5 4328.3 4286.2 4301.3 4303.3 4306.4 4331.5 4718.8 4755.0 4759.5 4763.3 4768.9 4731.2 4912.0 4981.3 4998.6 5040.0 5030.8 5067.1 5070.7 5081.0 5085.2 4704.2 4711.0 4715.8 4753.9 4762.4 4929.3 4953.8 4984.8 5015.2 5026.7 4843.3 4844.4 4882.4 4904.0 4904.5 4947.5 4947.8 4986.9 4991.1 4995.1 4798.4 4866.5 4882.2 4884.4 4920.1 4963.6 4964.0 4969.5 5011.7 5020.5 4250.7 4253.1 4254.2 4281.6 4289.5 3659.3 3665.4 3719.5 3730.5 3786.7 4271.8 4331.2 4332.2 4379.6 4385.2 5022.2 5031.5 5032.2 5033.1 5074.5 4305.1 4340.0 4350.5 4370.8 4384.7 4333.5 4398.1 4437.6 4444.1 4466.2 4658.9 4666.9 4670.4 4697.7 4711.9 4962.2 4963.5 4969.0 4972.2 5000.4 4532.0 4673.7 4680.7 4718.3 4723.3 4956.2 4957.4 4957.6 4995.2 5013.5 5013.2 5016.2 5020.6 5024.7 5073.8 4677.6 4844.9 4885.4 4906.3 4947.5 4845.1 4867.6 4870.3 4890.0 4916.9 4793.9 4832.2 4838.6 4842.9 4848.1 4739.1 4785.4 4836.3 4878.5 4888.1 4788.0 4816.4 4819.3 4840.3 4863.9 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | [#1] ext.html Cycles:180 Average:48483.90 Median:20520.25 stddev:95239.44 (464.1%) stddev-sans-first:95438.61 23:18:27 INFO - PROCESS | 24188 | Values: 547.7 575.9 578.7 579.0 601.0 27306.3 39642.0 40778.0 40789.2 40816.6 41049.4 41710.0 41733.2 41748.0 41798.4 7656.8 7734.8 7773.2 7778.8 7783.8 7804.6 7862.4 7865.6 7888.1 7898.0 7837.1 7917.6 7917.8 7923.2 7958.1 7867.4 7903.3 7922.7 7929.5 7929.6 7595.4 7638.1 7682.8 7687.3 7691.3 39061.2 39216.0 39264.6 39337.8 39434.4 2920.7 3076.3 3241.7 3664.4 3736.3 28865.7 29263.4 29263.9 29282.9 29392.7 2894.7 3014.4 3083.9 3091.9 3186.9 268099.0 269736.0 269800.0 270576.0 271045.0 31784.7 32904.3 52167.7 52554.6 52605.5 34053.3 34337.7 34410.5 34477.8 34493.0 12937.4 13077.7 13081.4 13114.4 13143.8 10853.1 10916.9 10933.2 10944.0 10950.1 7911.6 7934.2 7958.3 8006.0 8023.7 3096.3 3114.7 3134.0 3140.9 3141.9 805.7 885.1 959.8 986.2 1015.8 25996.5 26203.0 26613.3 26788.0 26808.9 758.9 895.3 940.8 947.9 1003.6 13123.2 13586.7 13699.7 13928.2 14044.2 421233.0 424729.0 424893.0 426645.0 428266.0 49019.5 49116.3 49205.0 49441.0 49585.5 1078.2 1133.1 1169.9 1187.3 1204.6 27506.4 28420.9 28873.9 28892.0 29201.4 42256.4 42613.4 42642.6 42690.4 42759.0 256653.0 256835.0 257486.0 257772.0 626147.0 37304.3 37815.8 39149.2 39618.6 39752.0 41650.6 42107.8 42204.6 42327.6 43111.8 36263.8 36387.1 36523.6 36955.8 37518.1 35876.1 36721.8 37011.6 37662.4 38101.0 34626.8 35113.1 35326.5 35588.8 35666.6 30734.4 32931.2 32959.3 33348.8 33371.3 24316.9 24955.3 25586.9 25686.4 25727.4 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | [#2] jquery.html Cycles:180 Average:23328.15 Median:4354.53 stddev:61939.39 (1422.4%) stddev-sans-first:62089.12 23:18:27 INFO - PROCESS | 24188 | Values: 349.4 365.2 368.0 377.7 388.9 12695.5 16199.8 16654.7 17992.4 18176.3 16630.8 17418.9 17455.9 17488.2 17621.8 5072.4 5236.8 5447.5 5479.0 5580.3 3800.5 3991.3 5511.3 5543.3 5548.2 3974.5 5890.9 6130.1 6154.8 6266.4 5570.2 5597.5 5639.4 6238.2 6255.4 5495.1 5495.7 5496.1 5496.5 5498.6 11191.6 11395.8 11535.6 11541.5 11684.8 1700.9 1735.9 1773.7 1975.9 2106.6 8532.4 9357.5 10321.8 10528.8 13904.3 1720.0 1746.2 1782.1 1844.6 1865.5 45497.0 55139.4 62445.1 68625.0 71108.3 9630.5 9789.6 9954.8 10060.5 10206.8 13690.7 13704.7 13707.5 13718.9 13725.2 7123.4 7157.7 7301.5 7361.7 7379.1 6906.8 6950.8 6951.7 7081.9 7121.4 4275.7 4310.8 4331.9 4352.6 4356.5 1726.6 1790.4 1808.2 1856.8 1882.9 376.6 380.3 406.7 677.7 685.9 10404.3 10483.6 10713.9 10720.1 10788.2 402.4 778.9 824.1 846.7 852.4 8439.7 9120.5 9154.0 9234.3 9322.2 368719.0 369048.0 372454.0 373642.0 390559.0 74344.9 74546.6 75417.6 76768.6 77192.6 878.9 929.8 936.9 941.3 970.2 15170.8 15372.0 15848.1 16009.0 16327.3 36045.1 41106.8 41234.4 41705.4 41739.0 45623.8 52907.2 52947.5 53805.2 54932.2 7584.9 7800.3 7922.1 8058.5 8140.2 11894.6 11998.5 12308.7 12348.3 12513.5 9475.3 9779.6 9873.8 9994.5 10428.2 10259.5 10519.9 10574.5 10584.1 10658.7 9721.4 9983.9 10298.7 10339.1 10445.0 7222.0 7373.4 7453.0 7580.1 7773.4 8197.0 9598.9 9747.3 9892.3 10117.8 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | [#3] mootools.html Cycles:180 Average:5093.08 Median:5108.96 stddev:2895.04 (56.7%) stddev-sans-first:2889.38 23:18:27 INFO - PROCESS | 24188 | Values: 1334.3 1369.2 1402.8 1592.2 1619.8 7453.1 8004.9 8012.4 8018.9 8022.4 6617.2 6798.5 6799.4 7013.4 7898.5 1903.9 2107.7 2173.9 2189.3 2209.9 2254.5 2274.6 2276.7 2281.3 2282.2 2166.1 2242.2 2252.9 2258.3 2260.1 2157.5 2163.9 2173.3 2204.0 2206.9 2148.3 2157.7 2165.3 2167.6 2195.1 7909.1 8014.0 8055.7 8063.8 8095.2 4539.5 4664.4 4675.3 4678.6 4681.3 2736.8 2837.4 2882.0 2887.1 2908.0 909.9 913.9 914.4 925.0 932.6 10519.6 10525.9 10530.9 10577.9 10581.2 4227.2 4259.1 4376.9 4400.9 4403.5 8209.0 8341.2 8345.8 8350.1 8420.8 4401.2 4419.9 4424.7 4424.8 4430.5 3977.8 4013.6 4033.3 4038.3 4237.2 3302.8 3354.2 3432.1 3442.1 3455.8 978.0 1008.2 1013.7 1016.6 1018.3 644.3 730.3 752.2 795.0 816.5 4977.6 5036.1 5181.8 5219.2 5432.2 395.1 400.0 414.1 416.0 418.7 3499.5 3641.3 3654.1 3695.4 3818.0 9257.1 9746.6 9785.9 9787.9 9803.8 9743.1 9751.9 9777.5 9787.0 9794.9 7293.3 7360.4 7391.6 7422.8 7485.8 5194.6 5201.0 5262.9 5285.9 5381.2 9028.5 9105.3 9123.5 9163.3 9224.2 8709.0 9120.2 9310.7 9313.7 9324.1 5976.4 6674.6 7053.1 7267.5 7359.3 7186.4 7420.6 7439.0 7444.3 7449.9 6690.4 6707.9 6723.9 6750.5 6792.7 6535.1 6596.1 6618.9 6653.7 6717.9 6008.7 6310.2 6356.1 6363.9 6374.5 4296.7 4456.6 4457.2 4643.6 4732.1 4500.4 4595.1 4596.0 4605.3 4978.6 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | [#4] prototype.html Cycles:180 Average:4171.37 Median:4713.02 stddev:1183.31 (25.1%) stddev-sans-first:1150.52 23:18:27 INFO - PROCESS | 24188 | Values: 306.4 307.7 313.6 315.2 315.2 4613.4 4766.6 4782.1 4799.7 4835.8 4548.2 4687.4 4705.8 4714.2 4726.2 3801.6 3802.6 3805.2 3806.8 3832.8 3584.4 3653.8 3825.8 3832.4 3847.7 3772.2 3778.4 3781.2 3783.9 3795.8 3769.3 3777.2 3781.6 3794.2 3800.5 3390.4 3400.5 3402.4 3410.3 3413.8 4509.6 4658.3 4669.0 4669.2 4705.1 4275.1 4277.7 4297.5 4311.4 4315.5 4926.7 4933.5 4934.0 4936.6 4937.4 3581.5 3662.2 3662.4 3665.6 3668.1 5172.5 5174.4 5177.9 5185.5 5189.5 3748.4 3756.5 3768.9 3774.0 3791.7 3827.3 3829.9 3840.5 3840.6 3840.9 4122.2 4221.8 4240.5 4244.9 4245.9 4916.9 4931.8 4938.9 4960.3 4967.1 1255.4 1289.9 1290.7 1305.6 1321.6 897.2 902.3 908.8 932.4 941.6 4365.8 4381.3 4382.7 4386.0 4400.5 5083.1 5088.3 5110.3 5117.8 5126.1 4321.3 4456.7 4462.5 4481.5 4482.8 2723.7 2726.9 2740.7 2742.9 2743.3 4711.9 4840.3 4852.6 4868.0 4889.0 5123.9 5224.3 5227.7 5233.2 5248.9 4835.7 4847.5 4852.3 4854.1 4863.2 4920.3 5119.8 5145.5 5155.4 5172.2 5069.2 5079.6 5083.2 5086.3 5103.6 4778.6 4822.8 4828.6 4860.9 4872.6 3646.7 3676.8 3688.0 3711.4 3738.6 4978.0 5187.3 5194.0 5197.0 5218.2 4977.0 4985.6 5008.6 5038.9 5041.9 4818.6 4970.0 5003.5 5017.5 5021.1 4682.4 4814.2 4927.7 4938.6 4951.2 5015.1 5019.2 5027.7 5028.4 5029.0 4924.8 4927.8 4935.8 4938.2 4940.0 23:18:27 INFO - PROCESS | 24188 | 23:18:27 INFO - PROCESS | 24188 | [#5] yui.html Cycles:180 Average:16942.64 Median:43551.67 stddev:23526.78 (54.0%) stddev-sans-first:23560.76 23:18:27 INFO - PROCESS | 24188 | Values: 596.8 660.2 666.3 720.5 733.6 13167.7 14172.2 14357.6 14375.1 14430.1 13058.5 13159.3 13174.8 13182.7 13193.1 628.5 739.7 768.0 770.1 770.9 777.0 777.5 780.8 781.4 782.0 829.1 831.0 831.9 832.7 833.6 661.9 684.2 684.7 687.3 830.5 580.4 593.5 594.8 596.1 596.2 13228.9 13231.5 13260.0 13263.9 13286.0 12124.0 12370.6 12587.8 12713.7 13190.4 11498.0 11680.0 11853.3 11936.4 12403.0 3974.8 4004.9 4052.6 4090.0 4091.9 59921.4 60683.7 60948.0 61014.4 61440.4 9153.3 9513.0 9946.0 10037.1 10176.4 18620.4 18633.9 18656.4 18681.4 18739.3 6469.6 6604.9 6640.9 6667.4 6816.4 3442.9 3520.3 3538.7 3558.7 3607.7 2649.6 2717.9 2722.1 2726.9 2732.4 451.7 460.3 461.3 468.2 472.8 444.5 561.8 566.7 576.2 595.6 7001.9 7300.0 7467.9 7545.4 7610.8 427.7 469.9 470.0 510.8 526.4 3250.7 3478.3 3481.5 3593.1 3646.9 94875.0 98323.0 98910.0 100966.0 102089.0 65302.3 66087.0 67040.0 78481.2 79917.6 43589.0 43902.1 55666.7 64696.7 67192.0 8438.5 8747.6 8991.4 9040.2 9171.5 32738.2 36534.3 43514.3 44303.8 45487.0 63028.0 63972.7 64838.7 65793.7 66792.3 11415.1 11450.0 11614.9 11738.1 12258.3 12667.6 12913.5 12991.6 13295.4 13495.8 12273.6 12286.8 12524.1 12999.2 13024.5 12382.3 12784.7 12786.8 13045.8 13275.4 11610.2 11681.0 11740.0 11746.8 11967.0 9777.6 10046.8 10315.9 10324.4 10807.0 9937.8 10197.5 10203.8 10249.2 10260.9 23:18:27 INFO - PROCESS | 24188 | -------- Summary: end -------- 23:18:27 INFO - PROCESS | 24188 | 23:18:28 INFO - TEST-INFO | 24188: exit 0 23:18:28 INFO - TEST-OK | dromaeo_css | took 1120265ms 23:18:28 INFO - TEST-START | kraken 23:18:28 INFO - operating with platform_type : linux_ 23:18:28 INFO - Initialising browser for kraken test... 23:18:28 INFO - TEST-INFO | started process 24376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprscNxB/profile http://localhost:47967/getInfo.html) 23:18:32 INFO - PROCESS | 24376 | JavaScript error: , line 0: uncaught exception: undefined 23:18:32 INFO - PROCESS | 24376 | __metrics Screen width/height:1600/1200 23:18:32 INFO - PROCESS | 24376 | colorDepth:24 23:18:32 INFO - PROCESS | 24376 | Browser inner width/height: 1024/697 23:18:32 INFO - PROCESS | 24376 | __metrics 23:18:33 INFO - PROCESS | 24376 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:18:33 INFO - PROCESS | 24376 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:18:34 INFO - TEST-INFO | 24376: exit 0 23:18:34 INFO - Browser initialized. 23:18:34 INFO - Running cycle 1/1 for kraken test... 23:18:34 INFO - TEST-INFO | started process 24453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprscNxB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:46 INFO - PROCESS | 24453 | RSS: Main: 158896128 23:18:46 INFO - PROCESS | 24453 | 23:18:49 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47967/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:50 INFO - PROCESS | 24453 | RSS: Main: 215486464 23:18:50 INFO - PROCESS | 24453 | 23:18:53 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47967/tests/kraken/driver.html?testName=audio-dft) 23:18:53 INFO - PROCESS | 24453 | RSS: Main: 193597440 23:18:53 INFO - PROCESS | 24453 | 23:18:56 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47967/tests/kraken/driver.html?testName=audio-fft) 23:18:57 INFO - PROCESS | 24453 | RSS: Main: 272297984 23:18:57 INFO - PROCESS | 24453 | 23:18:59 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47967/tests/kraken/driver.html?testName=audio-oscillator) 23:19:00 INFO - PROCESS | 24453 | RSS: Main: 181436416 23:19:00 INFO - PROCESS | 24453 | 23:19:02 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:19:03 INFO - PROCESS | 24453 | RSS: Main: 186556416 23:19:03 INFO - PROCESS | 24453 | 23:19:06 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47967/tests/kraken/driver.html?testName=imaging-darkroom) 23:19:06 INFO - PROCESS | 24453 | RSS: Main: 222748672 23:19:06 INFO - PROCESS | 24453 | 23:19:10 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47967/tests/kraken/driver.html?testName=imaging-desaturate) 23:19:10 INFO - PROCESS | 24453 | RSS: Main: 221642752 23:19:10 INFO - PROCESS | 24453 | 23:19:13 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47967/tests/kraken/driver.html?testName=json-parse-financial) 23:19:14 INFO - PROCESS | 24453 | RSS: Main: 221593600 23:19:14 INFO - PROCESS | 24453 | 23:19:16 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:19:16 INFO - PROCESS | 24453 | RSS: Main: 186875904 23:19:16 INFO - PROCESS | 24453 | 23:19:18 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:19:19 INFO - PROCESS | 24453 | RSS: Main: 192495616 23:19:19 INFO - PROCESS | 24453 | 23:19:21 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:19:22 INFO - PROCESS | 24453 | RSS: Main: 196956160 23:19:22 INFO - PROCESS | 24453 | 23:19:24 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:19:25 INFO - PROCESS | 24453 | RSS: Main: 190930944 23:19:25 INFO - PROCESS | 24453 | 23:19:28 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:19:28 INFO - PROCESS | 24453 | RSS: Main: 194850816 23:19:28 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | Cycle 1(1): loaded http://localhost:47967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47967/tests/kraken/driver.html?testName=ai-astar) 23:19:30 INFO - PROCESS | 24453 | RSS: Main: 244457472 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | __start_tp_report 23:19:30 INFO - PROCESS | 24453 | _x_x_mozilla_page_load 23:19:30 INFO - PROCESS | 24453 | _x_x_mozilla_page_load_details 23:19:30 INFO - PROCESS | 24453 | |i|pagename|runs| 23:19:30 INFO - PROCESS | 24453 | |0;ai-astar;103;114;113;114;113;111;113;113;112;112 23:19:30 INFO - PROCESS | 24453 | |1;audio-beat-detection;148;124;126;199;123;153;146;122;182;124 23:19:30 INFO - PROCESS | 24453 | |2;audio-dft;161;162;162;162;162;162;162;162;161;160 23:19:30 INFO - PROCESS | 24453 | |3;audio-fft;81;75;76;132;76;77;76;77;105;78 23:19:30 INFO - PROCESS | 24453 | |4;audio-oscillator;85;86;108;85;85;87;119;86;87;125 23:19:30 INFO - PROCESS | 24453 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 23:19:30 INFO - PROCESS | 24453 | |6;imaging-darkroom;149;148;147;146;147;147;146;147;147;147 23:19:30 INFO - PROCESS | 24453 | |7;imaging-desaturate;95;95;94;94;94;95;94;94;95;94 23:19:30 INFO - PROCESS | 24453 | |8;json-parse-financial;62;62;62;63;63;63;63;62;62;62 23:19:30 INFO - PROCESS | 24453 | |9;json-stringify-tinderbox;66;66;65;66;67;66;65;66;66;68 23:19:30 INFO - PROCESS | 24453 | |10;stanford-crypto-aes;79;79;79;79;79;79;79;79;78;83 23:19:30 INFO - PROCESS | 24453 | |11;stanford-crypto-ccm;130;137;129;128;128;127;127;127;184;141 23:19:30 INFO - PROCESS | 24453 | |12;stanford-crypto-pbkdf2;168;165;161;165;164;165;163;163;163;162 23:19:30 INFO - PROCESS | 24453 | |13;stanford-crypto-sha256-iterative;65;70;66;67;66;70;66;65;64;65 23:19:30 INFO - PROCESS | 24453 | __end_tp_report 23:19:30 INFO - PROCESS | 24453 | __start_cc_report 23:19:30 INFO - PROCESS | 24453 | _x_x_mozilla_cycle_collect,1904 23:19:30 INFO - PROCESS | 24453 | __end_cc_report 23:19:30 INFO - PROCESS | 24453 | __startTimestamp1469600370865__endTimestamp 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | ------- Summary: start ------- 23:19:30 INFO - PROCESS | 24453 | Number of tests: 14 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.22 (2.9%) stddev-sans-first:0.97 23:19:30 INFO - PROCESS | 24453 | Values: 103.0 114.0 113.0 114.0 113.0 111.0 113.0 113.0 112.0 112.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:147.00 stddev:27.11 (18.4%) stddev-sans-first:28.73 23:19:30 INFO - PROCESS | 24453 | Values: 148.0 124.0 126.0 199.0 123.0 153.0 146.0 122.0 182.0 124.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 23:19:30 INFO - PROCESS | 24453 | Values: 161.0 162.0 162.0 162.0 162.0 162.0 162.0 162.0 161.0 160.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#3] audio-fft Cycles:10 Average:85.30 Median:76.50 stddev:18.69 (24.4%) stddev-sans-first:19.76 23:19:30 INFO - PROCESS | 24453 | Values: 81.0 75.0 76.0 132.0 76.0 77.0 76.0 77.0 105.0 78.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.50 stddev:15.76 (18.4%) stddev-sans-first:16.26 23:19:30 INFO - PROCESS | 24453 | Values: 85.0 86.0 108.0 85.0 85.0 87.0 119.0 86.0 87.0 125.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:19:30 INFO - PROCESS | 24453 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 23:19:30 INFO - PROCESS | 24453 | Values: 149.0 148.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:19:30 INFO - PROCESS | 24453 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 23:19:30 INFO - PROCESS | 24453 | Values: 62.0 62.0 62.0 63.0 63.0 63.0 63.0 62.0 62.0 62.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 23:19:30 INFO - PROCESS | 24453 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 65.0 66.0 66.0 68.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:1.34 (1.7%) stddev-sans-first:1.41 23:19:30 INFO - PROCESS | 24453 | Values: 79.0 79.0 79.0 79.0 79.0 79.0 79.0 79.0 78.0 83.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:129.50 stddev:17.59 (13.6%) stddev-sans-first:18.53 23:19:30 INFO - PROCESS | 24453 | Values: 130.0 137.0 129.0 128.0 128.0 127.0 127.0 127.0 184.0 141.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:1.97 (1.2%) stddev-sans-first:1.42 23:19:30 INFO - PROCESS | 24453 | Values: 168.0 165.0 161.0 165.0 164.0 165.0 163.0 163.0 163.0 162.0 23:19:30 INFO - PROCESS | 24453 | 23:19:30 INFO - PROCESS | 24453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.13 23:19:30 INFO - PROCESS | 24453 | Values: 65.0 70.0 66.0 67.0 66.0 70.0 66.0 65.0 64.0 65.0 23:19:30 INFO - PROCESS | 24453 | -------- Summary: end -------- 23:19:30 INFO - PROCESS | 24453 | 23:19:31 INFO - TEST-INFO | 24453: exit 0 23:19:31 INFO - TEST-OK | kraken | took 63586ms 23:19:31 INFO - SUITE-END | took 1183s 23:19:32 INFO - Completed test suite (00:19:43) 23:19:32 INFO - javascript benchmark 23:19:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.8434693918366, 2618.384679600295, 2651.045623575513, 2663.8268512546683, 2665.533531631964, 4557.908841823161, 4600.263957766758, 4695.6947798393085, 4730.0776348612035, 4731.71609703418, 4643.210654188788, 4659.603933665642, 4679.0, 4720.929186062212, 4739.5023522530155, 4225.746455212682, 4240.23675738367, 4246.044639956016, 4286.357046443028, 4343.543927887574, 4299.355096735483, 4330.56694330566, 4400.713953593022, 4422.6240769534625, 4440.844570440036, 4301.440812694361, 4348.652107831366, 4348.695591308609, 4365.607095361417, 4366.410534577839, 4192.45498085247, 4231.069164783773, 4262.12626411588, 4305.547917468652, 4328.264195086811, 4286.207051695446, 4301.2902871026245, 4303.31147016479, 4306.35404689296, 4331.501877284121, 4718.764061796931, 4755.0, 4759.4764575896625, 4763.285507173917, 4768.856934291976, 4731.195696731564, 4912.0, 4981.252812078181, 4998.550130488237, 5040.0, 5030.773615187289, 5067.062593420229, 5070.670406423607, 5080.974595127038, 5085.186370180791, 4704.176769065434, 4711.0, 4715.7877895494785, 4753.881152971134, 4762.404699412574, 4929.309896614477, 4953.8266160684925, 4984.800607975713, 5015.247712843103, 5026.673266237756, 4843.297721830385, 4844.442889067803, 4882.389701287339, 4904.0, 4904.5340692634145, 4947.505249475023, 4947.82682606107, 4986.8753281168265, 4991.101601711654, 4995.050940321327, 4798.4001999750035, 4866.46468888422, 4882.2432522959, 4884.438289596742, 4920.065187614342, 4963.5780958618925, 4964.032013757283, 4969.503049695001, 5011.724355160428, 5020.548150666385, 4250.681198910094, 4253.149370125987, 4254.234237837157, 4281.571842815756, 4289.549597292239, 3659.2681463707363, 3665.4135338345736, 3719.5350581177354, 3730.5336832895887, 3786.659200671953, 4271.786410679453, 4331.198728235287, 4332.176886391576, 4379.58393952574, 4385.188740083095, 5022.221555658879, 5031.52200540948, 5032.245163225472, 5033.094043072282, 5074.517920797518, 4305.07440900208, 4340.023494713664, 4350.477942646902, 4370.825166993348, 4384.69307148503, 4333.523312435629, 4398.076403955205, 4437.64498840092, 4444.088961762831, 4466.151431228056, 4658.883527911694, 4666.883327916694, 4670.392848929753, 4697.694649847749, 4711.905761884812, 4962.230854217602, 4963.528464795839, 4969.031038947371, 4972.154733695208, 5000.374953130859, 4532.0256144929, 4673.696209746356, 4680.7191568506, 4718.268668356411, 4723.31511930775, 4956.207006878882, 4957.380327459067, 4957.603391728581, 4995.225740010159, 5013.498650134958, 5013.24801279811, 5016.247562865599, 5020.623453240948, 5024.698518088926, 5073.771680274471, 4677.579017888406, 4844.878878028077, 4885.438174609823, 4906.337644417958, 4947.480514546065, 4845.103655823684, 4867.58625516835, 4870.2938073979785, 4889.951100488949, 4916.877078072934, 4793.9280910785665, 4832.20268655682, 4838.637102217418, 4842.903141937212, 4848.054629347384, 4739.146953548395, 4785.377900872864, 4836.274558816206, 4878.536539028786, 4888.095702294944, 4788.018456216398, 4816.373871396696, 4819.349387832738, 4840.322354870251, 4863.8540843774745], "value": 4588.408572786325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.6557830504705, 575.8675504633936, 578.7279978410146, 578.9739461724222, 600.9549283803715, 27306.317342066457, 39642.0, 40778.0, 40789.184216315654, 40816.59183408172, 41049.38425923606, 41710.0, 41733.16533669325, 41748.0, 41798.37302440458, 7656.770296891103, 7734.7679569613, 7773.183815699355, 7778.805529861742, 7783.76648700537, 7804.60976951153, 7862.371010319161, 7865.567393793339, 7888.092869320016, 7897.960510197441, 7837.0987336456465, 7917.604119794016, 7917.7624671259955, 7923.168067352932, 7958.084820245659, 7867.370610351159, 7903.288704016609, 7922.7227047053075, 7929.484583502054, 7929.603519823986, 7595.354394876442, 7638.083429988437, 7682.8079298018, 7687.2697093776005, 7691.2693294137525, 39061.21877562461, 39216.0, 39264.60735392638, 39337.803310983545, 39434.408483872765, 2920.6933272006345, 3076.26169719268, 3241.7082462578246, 3664.387669425471, 3736.252749450121, 28865.711342886512, 29263.41473170525, 29263.853680731674, 29282.853585732148, 29392.70607293921, 2894.7394734473787, 3014.4121896230245, 3083.8766449342, 3091.938161236785, 3186.9203269918207, 268099.0, 269736.0, 269800.0, 270576.0, 271045.0, 31784.68215317817, 32904.3419131616, 52167.73916130471, 52554.63504142323, 52605.473945260055, 34053.31893362119, 34337.65662343395, 34410.48384274238, 34477.82761086229, 34493.0, 12937.417816198295, 13077.673058173621, 13081.41133648988, 13114.409851556702, 13143.802842957364, 10853.131749460024, 10916.890831091747, 10933.234673572773, 10944.0, 10950.123990080774, 7911.564863932424, 7934.166912474223, 7958.323542498837, 8006.039275287003, 8023.719169829028, 3096.3188098618266, 3114.7352475039875, 3133.9686603134132, 3140.8586613602442, 3141.9057428277188, 805.6616221187115, 885.0750965241339, 959.836827739286, 986.2061040862175, 1015.7714514234239, 25996.480070398487, 26203.0, 26613.334666633487, 26788.0, 26808.865955670488, 758.859610971972, 895.2658819767859, 940.7648087978006, 947.8672985781996, 1003.5634498992962, 13123.212607243597, 13586.714945686103, 13699.657508562366, 13928.233947133005, 14044.157350558999, 421233.0, 424729.0, 424893.0, 426645.0, 428266.0, 49019.509804902205, 49116.263256051185, 49205.0, 49441.0, 49585.50414495881, 1078.1859695929522, 1133.0652211925194, 1169.8771628979175, 1187.3054263255747, 1204.5543149034913, 27506.449871002867, 28420.85789571039, 28873.85563072171, 28892.0, 29201.41597168087, 42256.36615450709, 42613.36079958741, 42642.5735742651, 42690.35964460474, 42759.0, 256653.0, 256835.0, 257486.0, 257772.0, 626147.0, 37304.25391492209, 37815.810920945216, 39149.2170156601, 39618.60381396149, 39752.0, 41650.58349416467, 42107.789461052496, 42204.57795422129, 42327.57672423236, 43111.784441078846, 36263.81868090643, 36387.090322742144, 36523.634763653085, 36955.81522092372, 37518.06204844901, 35876.103097422776, 36721.81639091788, 37011.62988370082, 37662.435063473524, 38101.0, 34626.82686586551, 35113.122171945906, 35326.47010294796, 35588.822055889555, 35666.64333356737, 30734.385312294075, 32931.176720582174, 32959.340813184084, 33348.83325583357, 33371.33257334888, 24316.878415607807, 24955.251342459756, 25586.872065639553, 25686.357841054123, 25727.356816079748], "value": 16622.11389634194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.4496168534559, 365.1619533171372, 367.97976111313886, 377.7091639437634, 388.87555982085746, 12695.492180312787, 16199.75700364494, 16654.666906661874, 17992.370267040656, 18176.272949082053, 16630.750538741897, 17418.912905435456, 17455.91272043638, 17488.21303041363, 17621.823781762178, 5072.391313042431, 5236.79052837888, 5447.455254474541, 5479.04116779564, 5580.274564306635, 3800.524934383202, 3991.2815693175216, 5511.311086114236, 5543.279373681436, 5548.223248745158, 3974.523057233136, 5890.941090589104, 6130.1111338855835, 6154.815355539341, 6266.37336266372, 5570.220169176318, 5597.496225339698, 5639.407862174454, 6238.189035425411, 6255.405736455053, 5495.120780675113, 5495.697736624484, 5496.120620700709, 5496.4503549645115, 5498.5876059295715, 11191.552337906474, 11395.829062564067, 11535.59625413115, 11541.538338466451, 11684.824727629093, 1700.948971530856, 1735.8611311095083, 1773.733939909011, 1975.8518111141723, 2106.631339515594, 8532.402731808776, 9357.53212339387, 10321.845172322346, 10528.789424211549, 13904.304784760721, 1719.9828001719948, 1746.1967494952337, 1782.08222765276, 1844.6218525202435, 1865.4963159946738, 45497.0, 55139.44860551383, 62445.06332405018, 68625.0, 71108.28891711068, 9630.4703241321, 9789.608415663437, 9954.751131221778, 10060.496975151213, 10206.846897296546, 13690.65773355674, 13704.725905481835, 13707.451701931812, 13718.862811371759, 13725.245111518763, 7123.358897699232, 7157.7136914522835, 7301.452391070691, 7361.668724907392, 7379.077615298088, 6906.758263460855, 6950.79147625572, 6951.652417379212, 7081.89377159343, 7121.394681452031, 4275.722078064916, 4310.827566897289, 4331.913361732748, 4352.552805976792, 4356.499002614676, 1726.5510967148632, 1790.3823181002533, 1808.1592059692043, 1856.8062931757356, 1882.9152688129068, 376.60644626365513, 380.33631313358364, 406.68481926507195, 677.6819086875979, 685.8559702462439, 10404.323718958243, 10483.633072842415, 10713.946430267955, 10720.142388608892, 10788.190885683449, 402.36828179758083, 778.8598052350518, 824.1099612418574, 846.6613354658186, 852.424613385962, 8439.704610338731, 9120.491864737118, 9153.954230228806, 9234.261259099256, 9322.20761235289, 368719.0, 369048.0, 372454.0, 373642.0, 390559.0, 74344.88482672765, 74546.62726686332, 75417.62291188509, 76768.61615691886, 77192.61403692946, 878.9340799440067, 929.7675581104724, 936.9437833729997, 941.2893265584577, 970.2335155227291, 15170.772438413213, 15372.0, 15848.1283529407, 16009.0, 16327.265273062978, 36045.0988725284, 41106.794466028674, 41234.38148427716, 41705.37441938313, 41739.0, 45623.77188114038, 52907.20639190338, 52947.47052529425, 53805.192922105416, 54932.17601735897, 7584.876234654305, 7800.336971357498, 7922.0889597697005, 8058.476199047043, 8140.226678465537, 11894.643160705193, 11998.520059197534, 12308.692282693004, 12348.320842353756, 12513.499460021498, 9475.289353298393, 9779.60881564758, 9873.753156171153, 9994.500824876326, 10428.217883658908, 10259.487025648838, 10519.89480105189, 10574.471276435994, 10584.100351470212, 10658.680239592824, 9721.368111072758, 9983.850242246517, 10298.691039268833, 10339.121174700234, 10444.955504449494, 7222.0, 7373.410127189919, 7453.0, 7580.090389153337, 7773.41699372538, 8197.0, 9598.904010960081, 9747.317687762072, 9892.258080644124, 10117.848232276374], "value": 7834.400520720061, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.31282889312, 1369.1579678497724, 1402.7615305398087, 1592.1959410497698, 1619.7894273744419, 7453.105627324722, 8004.879926801088, 8012.399070069746, 8018.91981080189, 8022.398320125984, 6617.172853393326, 6798.45612351012, 6799.388055075042, 7013.403860671849, 7898.5260884346835, 1903.9048047597598, 2107.7470703515523, 2173.9347819565437, 2189.277538412328, 2209.8895055247253, 2254.537819746948, 2274.5678321118935, 2276.692646492727, 2281.292799232235, 2282.201229569654, 2166.0685905060895, 2242.159190303636, 2252.9211477598287, 2258.2660635293596, 2260.050778672953, 2157.5361297321074, 2163.9134434622597, 2173.3154056472163, 2203.966940495894, 2206.8896555172178, 2148.269588339972, 2157.6547752359547, 2165.263810304504, 2167.5556510915226, 2195.056125865877, 7909.1299957004685, 8014.038315402131, 8055.718049868226, 8063.798405039863, 8095.150009249061, 4539.500654927955, 4664.440267167927, 4675.345451636774, 4678.555537223959, 4681.274402467623, 2736.7536921677147, 2837.4466978939117, 2881.9855900720363, 2887.133859842039, 2908.0, 909.9272058235325, 913.8766266554063, 914.437620863171, 924.990750092504, 932.6455946740263, 10519.579216831318, 10525.894741052569, 10530.894691053145, 10577.894221057768, 10581.15350771944, 4227.239096962515, 4259.084296876186, 4376.934345984812, 4400.889977750582, 4403.53762854902, 8208.958955205186, 8341.24928756415, 8345.791355216168, 8350.123237060143, 8420.8315833683, 4401.18578063053, 4419.911601767946, 4424.7123936944, 4424.84513042042, 4430.5126436092005, 3977.7812220327583, 4013.5986401359633, 4033.334499807499, 4038.273110840077, 4237.194932962727, 3302.7688061835443, 3354.228527438654, 3432.1419645088727, 3442.0706409269355, 3455.7926524408617, 977.9608815647294, 1008.1984822066474, 1013.6553571785628, 1016.6035246253966, 1018.3228153277987, 644.2944975252092, 730.3426915775844, 752.161340105789, 794.9801254968672, 816.46929495827, 4977.601791856643, 5036.11867923112, 5181.792728290826, 5219.19102539107, 5432.2123292123215, 395.05581659833024, 399.99000024999606, 414.1344589807317, 416.0410254363721, 418.71736577809855, 3499.5275637788573, 3641.289948460078, 3654.1230104774663, 3695.427208782643, 3818.0, 9257.120573545502, 9746.561404736804, 9785.853212201822, 9787.853182202272, 9803.754906127404, 9743.074407931235, 9751.853722194173, 9777.511124443748, 9786.951065244628, 9794.853077203848, 7293.307135822089, 7360.374368178765, 7391.593462359622, 7422.814429639194, 7485.7754267372065, 5194.610404219623, 5201.011807756514, 5262.9210561842365, 5285.920711189412, 5381.2197231402015, 9028.503432311287, 9105.317101217302, 9123.498207598646, 9163.312751543528, 9224.215941644767, 8709.0, 9120.179183873483, 9310.72067837966, 9313.674021409219, 9324.067593240621, 5976.372480889444, 6674.632895190811, 7053.0830991970715, 7267.454940879349, 7359.337659610446, 7186.353228209487, 7420.591867447126, 7438.9628051861555, 7444.330010299099, 7449.851002980018, 6690.364415380531, 6707.932920670926, 6723.9327606725265, 6750.5274630775375, 6792.72829086831, 6535.085088087767, 6596.142501474969, 6618.900716489353, 6653.733850646114, 6717.899231511434, 6008.699565021644, 6310.211223597051, 6356.078368636614, 6363.90454143179, 6374.4900407966325, 4296.742195468282, 4456.5766252205985, 4457.219986502284, 4643.605293549951, 4732.148213321498, 4500.392447019611, 4595.126925884071, 4595.954040459686, 4605.286180642006, 4978.576820970258], "value": 4007.3692603753375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.39792807133983, 307.7445720052358, 313.57197425514175, 315.2198309184768, 315.23398142513713, 4613.446386433624, 4766.571008609225, 4782.0871651339485, 4799.7120172789655, 4835.806567737291, 4548.181327361073, 4687.437507499105, 4705.788279508625, 4714.151452738506, 4726.172919739049, 3801.6388443097862, 3802.5817160112365, 3805.238952209569, 3806.7906265155407, 3832.8152952816904, 3584.354816133095, 3653.762505437138, 3825.8469661213658, 3832.405977073558, 3847.6729477994404, 3772.188979369435, 3778.4332350147424, 3781.243751249747, 3783.9432408513894, 3795.829187686547, 3769.283836071151, 3777.1690228149764, 3781.6218378162102, 3794.2356804085957, 3800.4869342638667, 3390.3727810355163, 3400.4559270516597, 3402.387570237356, 3410.300888317889, 3413.8151582986907, 4509.571590698878, 4658.254679251338, 4669.042846216517, 4669.229577119771, 4705.082508910764, 4275.123599662062, 4277.743335399886, 4297.527272000078, 4311.37485064667, 4315.4821421429315, 4926.655134140611, 4933.481984391623, 4934.014920972796, 4936.629752768521, 4937.432195297551, 3581.4806853006166, 3662.212624285765, 3662.377395842713, 3665.5601327840563, 3668.137987572918, 5172.508611681884, 5174.3790745110455, 5177.922331165036, 5185.507376799235, 5189.455107213764, 3748.3627783276906, 3756.492873462102, 3768.9434658480145, 3773.9621604058552, 3791.7156213284115, 3827.3110840048503, 3829.8659546915724, 3840.5391353037257, 3840.5583357914197, 3840.9039774005873, 4122.175564887035, 4221.767802770815, 4240.5123410808155, 4244.915101697949, 4245.936310955338, 4916.926246106311, 4931.827386041543, 4938.925916111261, 4960.280759289883, 4967.05625931072, 1255.3785875991443, 1289.8710128987213, 1290.7289469211382, 1305.6474751816957, 1321.6101250131235, 897.2373482539789, 902.251131560803, 908.7731562390719, 932.3799673217235, 941.5715849288557, 4365.781710914442, 4381.342798580238, 4382.729008587474, 4385.9955930187925, 4400.471943366816, 5083.135866902636, 5088.262201980692, 5110.28456016158, 5117.769700363493, 5126.102931986888, 4321.308590625485, 4456.732596044183, 4462.464504259445, 4481.5294394088805, 4482.843100491467, 2723.7276272372605, 2726.8956072790156, 2740.671119465637, 2742.890284388642, 2743.327884668229, 4711.882202944886, 4840.346553215341, 4852.636052296092, 4868.0, 4889.0, 5123.897522049539, 5224.320838290998, 5227.686338819683, 5233.215017747369, 5248.868778280497, 4835.661503694778, 4847.466778654345, 4852.344933433941, 4854.126257273725, 4863.173260545645, 4920.335754673073, 5119.769610367617, 5145.485451454824, 5155.43290238081, 5172.172452407597, 5069.214271787879, 5079.568236699922, 5083.161278389172, 5086.338775959101, 5103.5661968733075, 4778.5699287064335, 4822.7829747660735, 4828.589569886599, 4860.92708609364, 4872.561469467623, 3646.6717995380545, 3676.816159192083, 3687.9815600921825, 3711.3876210426056, 3738.5606541481184, 4977.9751101244265, 5187.299714538489, 5194.0, 5197.0125676121415, 5218.191180367049, 4976.975115124401, 4985.551300382838, 5008.574271186844, 5038.949610503848, 5041.932807549034, 4818.590419814355, 4969.950300496948, 5003.524665156804, 5017.523335283142, 5021.146405111067, 4682.4381074271305, 4814.15752243363, 4927.679700819435, 4938.604911607134, 4951.2078067510465, 5015.1474249378425, 5019.247112932943, 5027.74861256943, 5028.446870844131, 5029.0, 4924.7537623119415, 4927.802887884444, 4935.75321233944, 4938.234573641092, 4940.0], "value": 3802.5096097091714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7612954818073, 660.1945626335869, 666.2604508995017, 720.4596552585559, 733.6295170938679, 13167.736645267089, 14172.220527870963, 14357.641058973517, 14375.137491750502, 14430.134191948491, 13058.542950996716, 13159.27623980683, 13174.802377964314, 13182.73634527309, 13193.076484646079, 628.472083449902, 739.7373932254026, 768.0476209500235, 770.0874463760462, 770.9113451953014, 777.013193244579, 777.5295945952673, 780.7657702689199, 781.4256521456725, 781.9765407037798, 829.1128492513013, 830.9667613295461, 831.9001719793633, 832.7085520067989, 833.6123702478346, 661.8874791285469, 684.2199892122984, 684.6645143879513, 687.2680595166132, 830.5265998380895, 580.3760956971231, 593.4540222994855, 594.7650677982216, 596.1147695671924, 596.1742985964427, 13228.933855330759, 13231.470741170342, 13260.0, 13263.867361326456, 13286.0, 12124.0, 12370.62888113349, 12587.811182832265, 12713.682157946032, 13190.4064317105, 11498.0, 11680.0, 11853.288802671781, 11936.403179840972, 12403.0, 3974.7615143091507, 4004.8798536043964, 4052.5542190359038, 4089.9795501022304, 4091.89770255743, 59921.40078599245, 60683.69658151725, 60948.0, 61014.38985610131, 61440.38559614391, 9153.267738580898, 9513.0, 9946.026244119832, 10037.096661300518, 10176.440295783656, 18620.44138675842, 18633.90683046576, 18656.440306790817, 18681.43955681332, 18739.250429982647, 6469.644169570719, 6604.900926486107, 6640.8671826563195, 6667.366600172976, 6816.386525212754, 3442.913927151841, 3520.307168932974, 3538.716902647782, 3558.6868535451645, 3607.74745767799, 2649.602559616073, 2717.891284348604, 2722.1153125234378, 2726.8636568171514, 2732.3715545424666, 451.6770509086019, 460.2681736039713, 461.32416010544046, 468.2017160740929, 472.8486884197024, 444.508817756381, 561.7780976514335, 566.7138095261948, 576.2451188942499, 595.5741644724043, 7001.859962800817, 7299.963500182571, 7467.887981680279, 7545.358644515168, 7610.8097297568, 427.6877879148239, 469.94125734283216, 470.02938931107155, 510.75228514170595, 526.3736153976755, 3250.723688486505, 3478.3043391321835, 3481.4603736420895, 3593.137646964762, 3646.927061458756, 94875.0, 98323.0, 98910.0, 100966.0, 102089.0, 65302.34697653058, 66087.0, 67040.0, 78481.21518784853, 79917.60041199873, 43589.0, 43902.12195756067, 55666.721666392215, 64696.676516618056, 67192.0, 8438.493690378597, 8747.562621869009, 8991.41555798871, 9040.231580315747, 9171.495567743837, 32738.181545461553, 36534.269314613026, 43514.34728479012, 44303.77848110739, 45487.0, 63028.0, 63972.68013660088, 64838.67580662067, 65793.67103164454, 66792.33207668056, 11415.143864210384, 11450.0, 11614.883851161718, 11738.060955123741, 12258.325792081521, 12667.556635517712, 12913.548025819051, 12991.610251692464, 13295.401706923018, 13495.797563036758, 12273.570425035081, 12286.815697764361, 12524.060695447695, 12999.220046797222, 13024.47902083906, 12382.318972456602, 12784.6803829905, 12786.808197876853, 13045.804312935503, 13275.386010905102, 11610.24533405326, 11681.007114395372, 11740.0, 11746.823797643214, 11967.042636589225, 9777.6193234995, 10046.849297260693, 10315.948420257851, 10324.43215623118, 10807.0, 9937.751556211153, 10197.541110650187, 10203.795924081625, 10249.231307651808, 10260.897391026292], "value": 6430.044388084214, "unit": "score"}], "name": "dromaeo_css", "value": 6231.4768690799665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 114.0, 113.0, 111.0, 113.0, 113.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 126.0, 199.0, 123.0, 153.0, 146.0, 122.0, 182.0, 124.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 76.0, 132.0, 76.0, 77.0, 76.0, 77.0, 105.0, 78.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 108.0, 85.0, 85.0, 87.0, 119.0, 86.0, 87.0, 125.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 68.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 78.0, 83.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 129.0, 128.0, 128.0, 127.0, 127.0, 127.0, 184.0, 141.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 161.0, 165.0, 164.0, 165.0, 163.0, 163.0, 163.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 66.0, 67.0, 66.0, 70.0, 66.0, 65.0, 64.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1530.9, "alertThreshold": 2.0}]} 23:19:32 INFO - Return code: 0 23:19:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:19:32 INFO - # TBPL SUCCESS # 23:19:32 INFO - Running post-action listener: _resource_record_post_action 23:19:32 INFO - [mozharness: 2016-07-27 06:19:32.171343Z] Finished run-tests step (success) 23:19:32 INFO - Running post-run listener: _resource_record_post_run 23:19:32 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 540164096; Read time: 0; Write time: 509452 23:19:32 INFO - TinderboxPrint: CPU usage
13.0% 23:19:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:19:32 INFO - TinderboxPrint: I/O write bytes / time
540,164,096 / 509,452 23:19:32 INFO - TinderboxPrint: CPU idle
8,334.0 (87.0%) 23:19:32 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 23:19:32 INFO - TinderboxPrint: Swap in / out
0 / 0 23:19:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250994688; Read time: 0; Write time: 302748 23:19:32 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288931840; Read time: 0; Write time: 206672 23:19:32 INFO - Running post-run listener: _upload_blobber_files 23:19:32 INFO - Blob upload gear active. 23:19:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:19:32 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 23:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:19:33 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:19:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:34 INFO - (blobuploader) - INFO - Done attempting. 23:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:34 INFO - (blobuploader) - INFO - Done attempting. 23:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:40 INFO - (blobuploader) - INFO - Done attempting. 23:19:40 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:40 INFO - Return code: 0 23:19:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:19:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e40753ff19186f77c8484bf914c5934c891dcf3e9976f511be2f6f4fbcfa9f5c7e3c59174748fc8f2c2e844b733bbdda3bfb8a46a614aa119245b3d1535b7c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d909149540b34afeed0bf90188ea0bc73e58db2c3e99db6248815517926921c1b879eddd5908376f0921bee26dd94eb7be002fb3c79d06e6a439388382b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997b89347170121516c26faadaa5a7b5bebf17e3d2f3f1725a8dab94e403ca89db38ec0bee9485e34892e60d5c43951ac07a488134ec9084ae748d48965086d7"} 23:19:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:19:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:19:40 INFO - Contents: 23:19:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e40753ff19186f77c8484bf914c5934c891dcf3e9976f511be2f6f4fbcfa9f5c7e3c59174748fc8f2c2e844b733bbdda3bfb8a46a614aa119245b3d1535b7c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d909149540b34afeed0bf90188ea0bc73e58db2c3e99db6248815517926921c1b879eddd5908376f0921bee26dd94eb7be002fb3c79d06e6a439388382b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997b89347170121516c26faadaa5a7b5bebf17e3d2f3f1725a8dab94e403ca89db38ec0bee9485e34892e60d5c43951ac07a488134ec9084ae748d48965086d7"} 23:19:40 INFO - Running post-run listener: copy_logs_to_upload_dir 23:19:40 INFO - Copying logs to upload dir... 23:19:40 INFO - mkdir: /builds/slave/test/build/upload/logs 23:19:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.419759 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-26 23:19:40.365780) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 23:19:40.369635) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e40753ff19186f77c8484bf914c5934c891dcf3e9976f511be2f6f4fbcfa9f5c7e3c59174748fc8f2c2e844b733bbdda3bfb8a46a614aa119245b3d1535b7c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d909149540b34afeed0bf90188ea0bc73e58db2c3e99db6248815517926921c1b879eddd5908376f0921bee26dd94eb7be002fb3c79d06e6a439388382b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997b89347170121516c26faadaa5a7b5bebf17e3d2f3f1725a8dab94e403ca89db38ec0bee9485e34892e60d5c43951ac07a488134ec9084ae748d48965086d7"} build_url:https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/GczZNaHhRPm4PzT8tbzI-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e40753ff19186f77c8484bf914c5934c891dcf3e9976f511be2f6f4fbcfa9f5c7e3c59174748fc8f2c2e844b733bbdda3bfb8a46a614aa119245b3d1535b7c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d909149540b34afeed0bf90188ea0bc73e58db2c3e99db6248815517926921c1b879eddd5908376f0921bee26dd94eb7be002fb3c79d06e6a439388382b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997b89347170121516c26faadaa5a7b5bebf17e3d2f3f1725a8dab94e403ca89db38ec0bee9485e34892e60d5c43951ac07a488134ec9084ae748d48965086d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 23:19:40.395089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 23:19:40.395424) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1469599136.672752-1483060172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 23:19:40.483547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 23:19:40.484146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 23:19:40.484703) ========= ========= Total master_lag: 0.17 =========