builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1469747601.74 results: success (0) buildid: 20160728155146 builduid: 4b3aec176eec4934b83b43373d266e98 revision: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.741314) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.741871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.742220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.757658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.758090) ========= 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=8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 16:13:22-- 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% 23.3M=0s 2016-07-28 16:13:22 (23.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122931 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.895766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.896153) ========= 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=8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:21.946190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 16:13:21.946591) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06e51ce8f72f94112afcbb9a5a90364a8d811a4b --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 06e51ce8f72f94112afcbb9a5a90364a8d811a4b --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=8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 16:13:22,486 truncating revision to first 12 chars 2016-07-28 16:13:22,486 Setting DEBUG logging. 2016-07-28 16:13:22,486 attempt 1/10 2016-07-28 16:13:22,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06e51ce8f72f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 16:13:22,810 unpacking tar archive at: fx-team-06e51ce8f72f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758823 ========= master_lag: 0.59 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 16:13:23.297367) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:23.297793) ========= script_repo_revision: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:23.298376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:23.298723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 16:13:23.354004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-28 16:13:23.354362) ========= /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=8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:23 INFO - MultiFileLogger online at 20160728 16:13:23 in /builds/slave/test 16:13:23 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 16:13:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:23 INFO - {'append_to_log': False, 16:13:23 INFO - 'base_work_dir': '/builds/slave/test', 16:13:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:13:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:23 INFO - 'branch': 'Fx-Team-Non-PGO', 16:13:23 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:23 INFO - 'config_files': ('talos/linux_config.py',), 16:13:23 INFO - 'default_actions': ('clobber', 16:13:23 INFO - 'read-buildbot-config', 16:13:23 INFO - 'download-and-extract', 16:13:23 INFO - 'populate-webroot', 16:13:23 INFO - 'create-virtualenv', 16:13:23 INFO - 'install', 16:13:23 INFO - 'run-tests'), 16:13:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:23 INFO - 'download_minidump_stackwalk': True, 16:13:23 INFO - 'download_symbols': 'ondemand', 16:13:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:23 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:23 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:23 INFO - 'installer_path': 'installer.exe', 16:13:23 INFO - 'log_level': 'info', 16:13:23 INFO - 'log_name': 'talos', 16:13:23 INFO - 'log_to_console': True, 16:13:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:23 INFO - 'opt_config_files': (), 16:13:23 INFO - 'pip_index': False, 16:13:23 INFO - 'sps_profile': False, 16:13:23 INFO - 'sps_profile_interval': 0, 16:13:23 INFO - 'suite': 'dromaeojs', 16:13:23 INFO - 'system_bits': '32', 16:13:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:23 INFO - 'title': 'talos-linux64-ix-038', 16:13:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:23 INFO - 'use_talos_json': True, 16:13:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:23 INFO - 'work_dir': 'build'} 16:13:23 INFO - [mozharness: 2016-07-28 23:13:23.990085Z] Running clobber step. 16:13:23 INFO - Running pre-action listener: _resource_record_pre_action 16:13:23 INFO - Running main action method: clobber 16:13:23 INFO - rmtree: /builds/slave/test/build 16:13:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:25 INFO - Running post-action listener: _resource_record_post_action 16:13:25 INFO - [mozharness: 2016-07-28 23:13:25.006826Z] Finished clobber step (success) 16:13:25 INFO - [mozharness: 2016-07-28 23:13:25.006928Z] Running read-buildbot-config step. 16:13:25 INFO - Running pre-action listener: _resource_record_pre_action 16:13:25 INFO - Running main action method: read_buildbot_config 16:13:25 INFO - Using buildbot properties: 16:13:25 INFO - { 16:13:25 INFO - "project": "", 16:13:25 INFO - "product": "firefox", 16:13:25 INFO - "script_repo_revision": "production", 16:13:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:13:25 INFO - "repository": "", 16:13:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:13:25 INFO - "buildid": "20160728155146", 16:13:25 INFO - "pgo_build": "False", 16:13:25 INFO - "basedir": "/builds/slave/test", 16:13:25 INFO - "buildnumber": 1834, 16:13:25 INFO - "slavename": "talos-linux64-ix-038", 16:13:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:13:25 INFO - "platform": "ubuntu64_hw", 16:13:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:13:25 INFO - "branch": "fx-team", 16:13:25 INFO - "repo_path": "integration/fx-team", 16:13:25 INFO - "revision": "06e51ce8f72f94112afcbb9a5a90364a8d811a4b", 16:13:25 INFO - "stage_platform": "linux64", 16:13:25 INFO - "builduid": "4b3aec176eec4934b83b43373d266e98", 16:13:25 INFO - "slavebuilddir": "test" 16:13:25 INFO - } 16:13:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:13:25 INFO - Running post-action listener: _resource_record_post_action 16:13:25 INFO - [mozharness: 2016-07-28 23:13:25.009372Z] Finished read-buildbot-config step (success) 16:13:25 INFO - [mozharness: 2016-07-28 23:13:25.009465Z] Running download-and-extract step. 16:13:25 INFO - Running pre-action listener: _resource_record_pre_action 16:13:25 INFO - Running main action method: download_and_extract 16:13:25 INFO - mkdir: /builds/slave/test/build/tests 16:13:25 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')]} 16:13:25 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:25 INFO - Downloaded 1361 bytes. 16:13:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:13:25 INFO - Using the following test package requirements: 16:13:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:13:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:13:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'jsshell-linux-x86_64.zip'], 16:13:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:13:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:13:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:13:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:13:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:13:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:13:25 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')]} 16:13:25 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:26 INFO - Downloaded 22750234 bytes. 16:13:26 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'] 16:13:26 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 16:13:28 INFO - Return code: 0 16:13:28 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 16:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:28 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:29 INFO - Downloaded 22750234 bytes. 16:13:29 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'] 16:13:29 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 16:13:30 INFO - Return code: 0 16:13: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')]} 16:13:30 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:13:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:31 INFO - Downloaded 14413725 bytes. 16:13:31 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'] 16:13:31 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 16:13:31 INFO - Return code: 0 16:13:31 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')]} 16:13:31 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/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 16:13:32 INFO - Downloaded 57164909 bytes. 16:13:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:13:32 INFO - mkdir: /builds/slave/test/properties 16:13:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:32 INFO - Contents: 16:13:32 INFO - build_url:https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:13:33 INFO - Running post-action listener: _resource_record_post_action 16:13:33 INFO - Running post-action listener: set_extra_try_arguments 16:13:33 INFO - [mozharness: 2016-07-28 23:13:33.588494Z] Finished download-and-extract step (success) 16:13:33 INFO - [mozharness: 2016-07-28 23:13:33.588728Z] Running populate-webroot step. 16:13:33 INFO - Running pre-action listener: _resource_record_pre_action 16:13:33 INFO - Running main action method: populate_webroot 16:13:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:33 INFO - '--tppagecycles', 16:13:33 INFO - '7'], 16:13:33 INFO - 'tests': ['tsvgm']}}, 16:13:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['damp', 'tps']}, 16:13:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'tests': ['damp', 'tps']}, 16:13:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['dromaeo_dom']}, 16:13:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['basic_compositor_video']}, 16:13:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:13:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore', 16:13:33 INFO - 'tabpaint']}, 16:13:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore', 16:13:33 INFO - 'tabpaint']}, 16:13:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore', 16:13:33 INFO - 'tabpaint']}, 16:13:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore', 16:13:33 INFO - 'tabpaint']}, 16:13:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore', 16:13:33 INFO - 'tabpaint']}, 16:13:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore', 16:13:33 INFO - 'tabpaint']}, 16:13:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['tsvgx', 16:13:33 INFO - 'tsvgr_opacity', 16:13:33 INFO - 'tart', 16:13:33 INFO - 'tscrollx', 16:13:33 INFO - 'cart']}, 16:13:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:33 INFO - 'tsvgr_opacity', 16:13:33 INFO - 'tart', 16:13:33 INFO - 'tscrollx', 16:13:33 INFO - 'cart']}, 16:13:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--disable-e10s'], 16:13:33 INFO - 'tests': ['tp5o']}, 16:13:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'tests': ['tp5o']}, 16:13:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--disable-e10s', 16:13:33 INFO - '--xperf_path', 16:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:33 INFO - 'tests': ['tp5n']}, 16:13:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--xperf_path', 16:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:33 INFO - 'tests': ['tp5n']}}, 16:13:33 INFO - 'talos.zip': {'path': '', 16:13:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:33 INFO - Running post-action listener: _resource_record_post_action 16:13:33 INFO - [mozharness: 2016-07-28 23:13:33.607618Z] Finished populate-webroot step (success) 16:13:33 INFO - [mozharness: 2016-07-28 23:13:33.607707Z] Running create-virtualenv step. 16:13:33 INFO - Running pre-action listener: _resource_record_pre_action 16:13:33 INFO - Running main action method: create_virtualenv 16:13:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:33 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 16:13:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:33 INFO - Using real prefix '/usr' 16:13:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:36 INFO - Installing pip.................done. 16:13:36 INFO - Return code: 0 16:13:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13:36 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')]} 16:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 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')]} 16:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:36 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 16:13:36 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 16:13:36 INFO - Using env: {'DISPLAY': ':0', 16:13:36 INFO - 'HOME': '/home/cltbld', 16:13:36 INFO - 'LANG': 'en_US.UTF-8', 16:13:36 INFO - 'LANGUAGE': 'en_US:en', 16:13:36 INFO - 'LOGNAME': 'cltbld', 16:13:36 INFO - 'MAIL': '/var/mail/cltbld', 16:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:36 INFO - 'MOZ_NO_REMOTE': '1', 16:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:36 INFO - 'NO_EM_RESTART': '1', 16:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:36 INFO - 'PWD': '/builds/slave/test', 16:13:36 INFO - 'SHELL': '/bin/bash', 16:13:36 INFO - 'SHLVL': '1', 16:13:36 INFO - 'TERM': 'linux', 16:13:36 INFO - 'TMOUT': '86400', 16:13:36 INFO - 'USER': 'cltbld', 16:13:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:36 INFO - '_': '/tools/buildbot/bin/python'} 16:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:36 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 16:13:36 INFO - Cleaning up... 16:13:36 INFO - Return code: 0 16:13:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:13:36 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')]} 16:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 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')]} 16:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:36 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 16:13:36 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 16:13:36 INFO - Using env: {'DISPLAY': ':0', 16:13:36 INFO - 'HOME': '/home/cltbld', 16:13:36 INFO - 'LANG': 'en_US.UTF-8', 16:13:36 INFO - 'LANGUAGE': 'en_US:en', 16:13:36 INFO - 'LOGNAME': 'cltbld', 16:13:36 INFO - 'MAIL': '/var/mail/cltbld', 16:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:36 INFO - 'MOZ_NO_REMOTE': '1', 16:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:36 INFO - 'NO_EM_RESTART': '1', 16:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:36 INFO - 'PWD': '/builds/slave/test', 16:13:36 INFO - 'SHELL': '/bin/bash', 16:13:36 INFO - 'SHLVL': '1', 16:13:36 INFO - 'TERM': 'linux', 16:13:36 INFO - 'TMOUT': '86400', 16:13:36 INFO - 'USER': 'cltbld', 16:13:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:36 INFO - '_': '/tools/buildbot/bin/python'} 16:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:36 INFO - Downloading/unpacking psutil>=3.1.1 16:13:36 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 16:13:36 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 16:13:36 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 16:13:36 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 16:13:36 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 16:13:36 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 16:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:38 INFO - Installing collected packages: psutil 16:13:38 INFO - Running setup.py install for psutil 16:13:38 INFO - building 'psutil._psutil_linux' extension 16:13:38 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 16:13:38 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 16:13:38 INFO - building 'psutil._psutil_posix' extension 16:13:38 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 16:13:38 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 16:13:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:39 INFO - Successfully installed psutil 16:13:39 INFO - Cleaning up... 16:13:39 INFO - Return code: 0 16:13:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:39 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:39 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 16:13:39 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 16:13:39 INFO - Using env: {'DISPLAY': ':0', 16:13:39 INFO - 'HOME': '/home/cltbld', 16:13:39 INFO - 'LANG': 'en_US.UTF-8', 16:13:39 INFO - 'LANGUAGE': 'en_US:en', 16:13:39 INFO - 'LOGNAME': 'cltbld', 16:13:39 INFO - 'MAIL': '/var/mail/cltbld', 16:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:39 INFO - 'MOZ_NO_REMOTE': '1', 16:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:39 INFO - 'NO_EM_RESTART': '1', 16:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:39 INFO - 'PWD': '/builds/slave/test', 16:13:39 INFO - 'SHELL': '/bin/bash', 16:13:39 INFO - 'SHLVL': '1', 16:13:39 INFO - 'TERM': 'linux', 16:13:39 INFO - 'TMOUT': '86400', 16:13:39 INFO - 'USER': 'cltbld', 16:13:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:39 INFO - '_': '/tools/buildbot/bin/python'} 16:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:13:39 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 16:13:39 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 16:13:39 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 16:13:39 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 16:13:39 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 16:13:39 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 16:13:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:13:41 INFO - Installing collected packages: mozsystemmonitor 16:13:41 INFO - Running setup.py install for mozsystemmonitor 16:13:41 INFO - Successfully installed mozsystemmonitor 16:13:41 INFO - Cleaning up... 16:13:41 INFO - Return code: 0 16:13:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:13:41 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')]} 16:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:41 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')]} 16:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:41 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:41 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 16:13:41 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 16:13:41 INFO - Using env: {'DISPLAY': ':0', 16:13:41 INFO - 'HOME': '/home/cltbld', 16:13:41 INFO - 'LANG': 'en_US.UTF-8', 16:13:41 INFO - 'LANGUAGE': 'en_US:en', 16:13:41 INFO - 'LOGNAME': 'cltbld', 16:13:41 INFO - 'MAIL': '/var/mail/cltbld', 16:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:41 INFO - 'MOZ_NO_REMOTE': '1', 16:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:41 INFO - 'NO_EM_RESTART': '1', 16:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:41 INFO - 'PWD': '/builds/slave/test', 16:13:41 INFO - 'SHELL': '/bin/bash', 16:13:41 INFO - 'SHLVL': '1', 16:13:41 INFO - 'TERM': 'linux', 16:13:41 INFO - 'TMOUT': '86400', 16:13:41 INFO - 'USER': 'cltbld', 16:13:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:41 INFO - '_': '/tools/buildbot/bin/python'} 16:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:41 INFO - Downloading/unpacking jsonschema==2.5.1 16:13:41 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 16:13:41 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 16:13:41 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 16:13:41 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 16:13:41 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 16:13:41 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 16:13:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:43 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:43 INFO - warning: no files found matching '*.txt' 16:13:43 INFO - no previously-included directories found matching 'build' 16:13:43 INFO - no previously-included directories found matching 'dist' 16:13:43 INFO - no previously-included directories found matching '.git*' 16:13:43 INFO - Installing collected packages: jsonschema, functools32 16:13:43 INFO - Running setup.py install for functools32 16:13:43 INFO - warning: no files found matching '*.txt' 16:13:43 INFO - no previously-included directories found matching 'build' 16:13:43 INFO - no previously-included directories found matching 'dist' 16:13:43 INFO - no previously-included directories found matching '.git*' 16:13:43 INFO - Successfully installed jsonschema functools32 16:13:43 INFO - Cleaning up... 16:13:44 INFO - Return code: 0 16:13:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:44 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:44 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 16:13:44 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 16:13:44 INFO - Using env: {'DISPLAY': ':0', 16:13:44 INFO - 'HOME': '/home/cltbld', 16:13:44 INFO - 'LANG': 'en_US.UTF-8', 16:13:44 INFO - 'LANGUAGE': 'en_US:en', 16:13:44 INFO - 'LOGNAME': 'cltbld', 16:13:44 INFO - 'MAIL': '/var/mail/cltbld', 16:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:44 INFO - 'MOZ_NO_REMOTE': '1', 16:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:44 INFO - 'NO_EM_RESTART': '1', 16:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:44 INFO - 'PWD': '/builds/slave/test', 16:13:44 INFO - 'SHELL': '/bin/bash', 16:13:44 INFO - 'SHLVL': '1', 16:13:44 INFO - 'TERM': 'linux', 16:13:44 INFO - 'TMOUT': '86400', 16:13:44 INFO - 'USER': 'cltbld', 16:13:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:44 INFO - '_': '/tools/buildbot/bin/python'} 16:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:13:44 INFO - Cleaning up... 16:13:44 INFO - Return code: 0 16:13:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:44 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:44 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 16:13:44 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 16:13:44 INFO - Using env: {'DISPLAY': ':0', 16:13:44 INFO - 'HOME': '/home/cltbld', 16:13:44 INFO - 'LANG': 'en_US.UTF-8', 16:13:44 INFO - 'LANGUAGE': 'en_US:en', 16:13:44 INFO - 'LOGNAME': 'cltbld', 16:13:44 INFO - 'MAIL': '/var/mail/cltbld', 16:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:44 INFO - 'MOZ_NO_REMOTE': '1', 16:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:44 INFO - 'NO_EM_RESTART': '1', 16:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:44 INFO - 'PWD': '/builds/slave/test', 16:13:44 INFO - 'SHELL': '/bin/bash', 16:13:44 INFO - 'SHLVL': '1', 16:13:44 INFO - 'TERM': 'linux', 16:13:44 INFO - 'TMOUT': '86400', 16:13:44 INFO - 'USER': 'cltbld', 16:13:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:44 INFO - '_': '/tools/buildbot/bin/python'} 16:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:44 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:44 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 16:13:44 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 16:13:44 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 16:13:44 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 16:13:44 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 16:13:44 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 16:13:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:47 INFO - Downloading docopt-0.6.1.tar.gz 16:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:47 INFO - Running setup.py install for blobuploader 16:13:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:47 INFO - Running setup.py install for requests 16:13:47 INFO - Running setup.py install for docopt 16:13:47 INFO - Successfully installed blobuploader requests docopt 16:13:47 INFO - Cleaning up... 16:13:47 INFO - Return code: 0 16:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:47 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:47 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 16:13:47 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 16:13:47 INFO - Using env: {'DISPLAY': ':0', 16:13:47 INFO - 'HOME': '/home/cltbld', 16:13:47 INFO - 'LANG': 'en_US.UTF-8', 16:13:47 INFO - 'LANGUAGE': 'en_US:en', 16:13:47 INFO - 'LOGNAME': 'cltbld', 16:13:47 INFO - 'MAIL': '/var/mail/cltbld', 16:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:47 INFO - 'MOZ_NO_REMOTE': '1', 16:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:47 INFO - 'NO_EM_RESTART': '1', 16:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:47 INFO - 'PWD': '/builds/slave/test', 16:13:47 INFO - 'SHELL': '/bin/bash', 16:13:47 INFO - 'SHLVL': '1', 16:13:47 INFO - 'TERM': 'linux', 16:13:47 INFO - 'TMOUT': '86400', 16:13:47 INFO - 'USER': 'cltbld', 16:13:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:47 INFO - '_': '/tools/buildbot/bin/python'} 16:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:47 INFO - Running setup.py (path:/tmp/pip-5SR9OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:48 INFO - Running setup.py (path:/tmp/pip-LDW12o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:48 INFO - Running setup.py (path:/tmp/pip-oNkBfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:48 INFO - Running setup.py (path:/tmp/pip-d9RZrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:48 INFO - Running setup.py (path:/tmp/pip-4ZGAgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:48 INFO - Running setup.py (path:/tmp/pip-xE20A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:48 INFO - Running setup.py (path:/tmp/pip-C0Sl4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:48 INFO - Running setup.py (path:/tmp/pip-gHhoZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:48 INFO - Running setup.py (path:/tmp/pip-sBTW2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:48 INFO - Running setup.py (path:/tmp/pip-qUrNlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:48 INFO - Running setup.py (path:/tmp/pip-fYJlIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:48 INFO - Running setup.py (path:/tmp/pip-6LBfSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:48 INFO - Running setup.py (path:/tmp/pip-swgxJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:48 INFO - Running setup.py (path:/tmp/pip-ZB_WOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:48 INFO - Running setup.py (path:/tmp/pip-X_pDHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:49 INFO - Running setup.py (path:/tmp/pip-lVwUpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:49 INFO - Running setup.py (path:/tmp/pip-YZVRC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:49 INFO - Running setup.py install for manifestparser 16:13:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Running setup.py install for mozcrash 16:13:49 INFO - Running setup.py install for mozdebug 16:13:49 INFO - Running setup.py install for mozdevice 16:13:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Running setup.py install for mozfile 16:13:49 INFO - Running setup.py install for mozhttpd 16:13:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Running setup.py install for mozinfo 16:13:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Running setup.py install for mozInstall 16:13:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:49 INFO - Running setup.py install for mozleak 16:13:50 INFO - Running setup.py install for mozlog 16:13:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Running setup.py install for moznetwork 16:13:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Running setup.py install for mozprocess 16:13:50 INFO - Running setup.py install for mozprofile 16:13:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Running setup.py install for mozrunner 16:13:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Running setup.py install for mozscreenshot 16:13:50 INFO - Running setup.py install for moztest 16:13:50 INFO - Running setup.py install for mozversion 16:13:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:50 INFO - Cleaning up... 16:13:51 INFO - Return code: 0 16:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:51 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')]} 16:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:51 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')]} 16:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:51 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:51 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 16:13:51 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 16:13:51 INFO - Using env: {'DISPLAY': ':0', 16:13:51 INFO - 'HOME': '/home/cltbld', 16:13:51 INFO - 'LANG': 'en_US.UTF-8', 16:13:51 INFO - 'LANGUAGE': 'en_US:en', 16:13:51 INFO - 'LOGNAME': 'cltbld', 16:13:51 INFO - 'MAIL': '/var/mail/cltbld', 16:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:51 INFO - 'MOZ_NO_REMOTE': '1', 16:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:51 INFO - 'NO_EM_RESTART': '1', 16:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:51 INFO - 'PWD': '/builds/slave/test', 16:13:51 INFO - 'SHELL': '/bin/bash', 16:13:51 INFO - 'SHLVL': '1', 16:13:51 INFO - 'TERM': 'linux', 16:13:51 INFO - 'TMOUT': '86400', 16:13:51 INFO - 'USER': 'cltbld', 16:13:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:51 INFO - '_': '/tools/buildbot/bin/python'} 16:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:51 INFO - Running setup.py (path:/tmp/pip-ugTQKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:51 INFO - Running setup.py (path:/tmp/pip-pcHowm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:51 INFO - Running setup.py (path:/tmp/pip-1FYHma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:51 INFO - Running setup.py (path:/tmp/pip-stBCOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:51 INFO - Running setup.py (path:/tmp/pip-l_ipzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:51 INFO - Running setup.py (path:/tmp/pip-5WYdFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:51 INFO - Running setup.py (path:/tmp/pip-xeMz_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:51 INFO - Running setup.py (path:/tmp/pip-nAsyoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:51 INFO - Running setup.py (path:/tmp/pip-34oZmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:51 INFO - Running setup.py (path:/tmp/pip-Zxacs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:51 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)) 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:51 INFO - Running setup.py (path:/tmp/pip-dGkutm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:52 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)) 16:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:52 INFO - Running setup.py (path:/tmp/pip-oOIywE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:52 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)) 16:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:52 INFO - Running setup.py (path:/tmp/pip-BiC8iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:52 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)) 16:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:52 INFO - Running setup.py (path:/tmp/pip-Cs5MtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:52 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)) 16:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:52 INFO - Running setup.py (path:/tmp/pip-GsKSKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:52 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)) 16:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:52 INFO - Running setup.py (path:/tmp/pip-vgOgDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:52 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)) 16:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:52 INFO - Running setup.py (path:/tmp/pip-nN5Cdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:52 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)) 16:13:52 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)) 16:13:52 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)) 16:13:52 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)) 16:13:52 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)) 16:13:52 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)) 16:13:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:52 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 16:13:52 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 16:13:52 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 16:13:52 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 16:13:52 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 16:13:52 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 16:13:54 INFO - Downloading blessings-1.6.tar.gz 16:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:54 INFO - Installing collected packages: blessings 16:13:54 INFO - Running setup.py install for blessings 16:13:54 INFO - Successfully installed blessings 16:13:54 INFO - Cleaning up... 16:13:54 INFO - Return code: 0 16:13:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:54 INFO - Reading from file tmpfile_stdout 16:13:54 INFO - Current package versions: 16:13:54 INFO - argparse == 1.2.1 16:13:54 INFO - blessings == 1.6 16:13:54 INFO - blobuploader == 1.2.4 16:13:54 INFO - docopt == 0.6.1 16:13:54 INFO - functools32 == 3.2.3-2 16:13:54 INFO - jsonschema == 2.5.1 16:13:54 INFO - manifestparser == 1.1 16:13:54 INFO - mozInstall == 1.12 16:13:54 INFO - mozcrash == 0.17 16:13:54 INFO - mozdebug == 0.1 16:13:54 INFO - mozdevice == 0.48 16:13:54 INFO - mozfile == 1.2 16:13:54 INFO - mozhttpd == 0.7 16:13:54 INFO - mozinfo == 0.9 16:13:54 INFO - mozleak == 0.1 16:13:54 INFO - mozlog == 3.3 16:13:54 INFO - moznetwork == 0.27 16:13:54 INFO - mozprocess == 0.23 16:13:54 INFO - mozprofile == 0.28 16:13:54 INFO - mozrunner == 6.12 16:13:54 INFO - mozscreenshot == 0.1 16:13:54 INFO - mozsystemmonitor == 0.3 16:13:54 INFO - moztest == 0.7 16:13:54 INFO - mozversion == 1.4 16:13:54 INFO - psutil == 3.1.1 16:13:54 INFO - requests == 1.2.3 16:13:54 INFO - wsgiref == 0.1.2 16:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:54 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:54 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 16:13:54 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 16:13:54 INFO - Using env: {'DISPLAY': ':0', 16:13:54 INFO - 'HOME': '/home/cltbld', 16:13:54 INFO - 'LANG': 'en_US.UTF-8', 16:13:54 INFO - 'LANGUAGE': 'en_US:en', 16:13:54 INFO - 'LOGNAME': 'cltbld', 16:13:54 INFO - 'MAIL': '/var/mail/cltbld', 16:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:54 INFO - 'MOZ_NO_REMOTE': '1', 16:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:54 INFO - 'NO_EM_RESTART': '1', 16:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:54 INFO - 'PWD': '/builds/slave/test', 16:13:54 INFO - 'SHELL': '/bin/bash', 16:13:54 INFO - 'SHLVL': '1', 16:13:54 INFO - 'TERM': 'linux', 16:13:54 INFO - 'TMOUT': '86400', 16:13:54 INFO - 'USER': 'cltbld', 16:13:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:54 INFO - '_': '/tools/buildbot/bin/python'} 16:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 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)) 16:13:55 INFO - Cleaning up... 16:13:55 INFO - Return code: 0 16:13:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:55 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', '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 16:13:55 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 16:13:55 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 16:13:55 INFO - Using env: {'DISPLAY': ':0', 16:13:55 INFO - 'HOME': '/home/cltbld', 16:13:55 INFO - 'LANG': 'en_US.UTF-8', 16:13:55 INFO - 'LANGUAGE': 'en_US:en', 16:13:55 INFO - 'LOGNAME': 'cltbld', 16:13:55 INFO - 'MAIL': '/var/mail/cltbld', 16:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:55 INFO - 'MOZ_NO_REMOTE': '1', 16:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:55 INFO - 'NO_EM_RESTART': '1', 16:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:55 INFO - 'PWD': '/builds/slave/test', 16:13:55 INFO - 'SHELL': '/bin/bash', 16:13:55 INFO - 'SHLVL': '1', 16:13:55 INFO - 'TERM': 'linux', 16:13:55 INFO - 'TMOUT': '86400', 16:13:55 INFO - 'USER': 'cltbld', 16:13:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:55 INFO - '_': '/tools/buildbot/bin/python'} 16:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:55 INFO - Cleaning up... 16:13:55 INFO - Return code: 0 16:13:55 INFO - Running post-action listener: _resource_record_post_action 16:13:55 INFO - Running post-action listener: _start_resource_monitoring 16:13:55 INFO - Starting resource monitoring. 16:13:55 INFO - [mozharness: 2016-07-28 23:13:55.294450Z] Finished create-virtualenv step (success) 16:13:55 INFO - [mozharness: 2016-07-28 23:13:55.294894Z] Running install step. 16:13:55 INFO - Running pre-action listener: _resource_record_pre_action 16:13:55 INFO - Running main action method: install 16:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:55 INFO - Reading from file tmpfile_stdout 16:13:55 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:55 INFO - Reading from file tmpfile_stdout 16:13:55 INFO - Output received: 16:13:55 INFO - Usage: mozinstall [options] installer 16:13:55 INFO - Options: 16:13:55 INFO - -h, --help show this help message and exit 16:13:55 INFO - -d DEST, --destination=DEST 16:13:55 INFO - Directory to install application into. [default: 16:13:55 INFO - "/builds/slave/test"] 16:13:55 INFO - --app=APP Application being installed. [default: firefox] 16:13:55 INFO - mkdir: /builds/slave/test/build/application 16:13:55 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'] 16:13:55 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 16:14:14 INFO - Reading from file tmpfile_stdout 16:14:14 INFO - Output received: 16:14:14 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:14 INFO - Running post-action listener: _resource_record_post_action 16:14:14 INFO - [mozharness: 2016-07-28 23:14:14.685803Z] Finished install step (success) 16:14:14 INFO - [mozharness: 2016-07-28 23:14:14.686084Z] Running run-tests step. 16:14:14 INFO - Running pre-action listener: _resource_record_pre_action 16:14:14 INFO - Running main action method: run_tests 16:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:14 INFO - Python 2.7.3 16:14:14 INFO - Return code: 0 16:14:14 INFO - grabbing minidump binary from tooltool 16:14: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')]} 16:14:14 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 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:14 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 16:14:14 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 16:14:14 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 16:14:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:14 INFO - Return code: 0 16:14:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:14 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/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 16:14:14 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/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 16:14:14 INFO - Using env: {'DISPLAY': ':0', 16:14:14 INFO - 'HOME': '/home/cltbld', 16:14:14 INFO - 'LANG': 'en_US.UTF-8', 16:14:14 INFO - 'LANGUAGE': 'en_US:en', 16:14:14 INFO - 'LOGNAME': 'cltbld', 16:14:14 INFO - 'MAIL': '/var/mail/cltbld', 16:14:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:14 INFO - 'MOZ_NO_REMOTE': '1', 16:14:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:14 INFO - 'NO_EM_RESTART': '1', 16:14:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:14 INFO - 'PWD': '/builds/slave/test', 16:14:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:14 INFO - 'SHELL': '/bin/bash', 16:14:14 INFO - 'SHLVL': '1', 16:14:14 INFO - 'TERM': 'linux', 16:14:14 INFO - 'TMOUT': '86400', 16:14:14 INFO - 'USER': 'cltbld', 16:14:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856', 16:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:14 INFO - '_': '/tools/buildbot/bin/python'} 16:14:14 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/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 16:14:14 INFO - mozversion application_buildid: 20160728155146 16:14:14 INFO - mozversion application_changeset: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b 16:14:14 INFO - mozversion application_display_name: Nightly 16:14:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:14 INFO - mozversion application_name: Firefox 16:14:14 INFO - mozversion application_remotingname: firefox 16:14:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:14:14 INFO - mozversion application_vendor: Mozilla 16:14:14 INFO - mozversion application_version: 50.0a1 16:14:14 INFO - mozversion platform_buildid: 20160728155146 16:14:14 INFO - mozversion platform_changeset: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b 16:14:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:14:14 INFO - mozversion platform_version: 50.0a1 16:14:14 INFO - using testdate: 1469747654 16:14:14 INFO - actual date: 1469747654 16:14:14 INFO - starting webserver on 'localhost:42436' 16:14:14 INFO - SUITE-START | Running 2 tests 16:14:14 INFO - TEST-START | dromaeo_css 16:14:14 INFO - operating with platform_type : linux_ 16:14:14 INFO - Initialising browser for dromaeo_css test... 16:14:14 INFO - TEST-INFO | started process 3753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUqOXy/profile http://localhost:42436/getInfo.html) 16:14:19 INFO - PROCESS | 3753 | JavaScript error: , line 0: uncaught exception: undefined 16:14:20 INFO - PROCESS | 3753 | __metrics Screen width/height:1600/1200 16:14:20 INFO - PROCESS | 3753 | colorDepth:24 16:14:20 INFO - PROCESS | 3753 | Browser inner width/height: 1024/697 16:14:20 INFO - PROCESS | 3753 | __metrics 16:14:21 INFO - PROCESS | 3753 | 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" 16:14:21 INFO - PROCESS | 3753 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:21 INFO - PROCESS | 3753 | console.error: PushService: 16:14:21 INFO - PROCESS | 3753 | stateChangeProcessEnqueue: Error transitioning state 16:14:21 INFO - PROCESS | 3753 | UnknownError 16:14:22 INFO - TEST-INFO | 3753: exit 0 16:14:22 INFO - Browser initialized. 16:14:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:22 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUqOXy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:34 INFO - PROCESS | 3829 | RSS: Main: 159612928 16:14:34 INFO - PROCESS | 3829 | 16:15:26 INFO - PROCESS | 3829 | 1469747726045 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] 16:17:37 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:42436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42436/tests/dromaeo/cssquery-ext.html) 16:17:38 INFO - PROCESS | 3829 | RSS: Main: 253501440 16:17:38 INFO - PROCESS | 3829 | 16:20:41 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:42436/tests/dromaeo/cssquery-ext.html (next: http://localhost:42436/tests/dromaeo/cssquery-jquery.html) 16:20:42 INFO - PROCESS | 3829 | RSS: Main: 247631872 16:20:42 INFO - PROCESS | 3829 | 16:23:44 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:42436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42436/tests/dromaeo/cssquery-mootools.html) 16:23:44 INFO - PROCESS | 3829 | RSS: Main: 186576896 16:23:44 INFO - PROCESS | 3829 | 16:26:47 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:42436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42436/tests/dromaeo/cssquery-prototype.html) 16:26:47 INFO - PROCESS | 3829 | RSS: Main: 186998784 16:26:47 INFO - PROCESS | 3829 | 16:29:50 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:42436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42436/tests/dromaeo/cssquery-yui.html) 16:29:51 INFO - PROCESS | 3829 | RSS: Main: 187080704 16:29:51 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:42436/tests/dromaeo/cssquery-yui.html (next: http://localhost:42436/tests/dromaeo/cssquery-dojo.html) 16:32:54 INFO - PROCESS | 3829 | RSS: Main: 259633152 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | __start_tp_report 16:32:54 INFO - PROCESS | 3829 | _x_x_mozilla_page_load 16:32:54 INFO - PROCESS | 3829 | _x_x_mozilla_page_load_details 16:32:54 INFO - PROCESS | 3829 | |i|pagename|runs| 16:32:54 INFO - PROCESS | 3829 | |0;dojo.html;2559.7952163826894;2576.3559110222445;2603.1149409200866;2621.93445163871;2622.1871219921827;4513.119941611387;4571.611413029888;4670.439547254326;4688.437387513499;4704.858854234374;4639.6288296936245;4641.883952901179;4674.392328997225;4684.13343531446;4725.976370118145;4232.238197124517;4253.298205796048;4332.220200363933;4375.846845360413;4386.210482113218;4312.849050283241;4339.2406328892475;4353.564643535653;4368.410264614268;4380.386745855582;4150.501939767248;4181.895452613679;4183.91632167358;4196.853110141161;4267.253230684633;4224.091820258659;4228.069824638575;4229.154169166149;4300.677449191323;4373.431453911003;4248.575142485726;4250.659947204216;4258.765767882765;4289.764062976535;4291.206126866539;4531.818727250906;4541.613962813165;4657.091867085919;4677;4705.435347758256;4887.3890763654545;4911.336969509106;4979.950200497985;4983.800647974077;5014.623903207274;5031.622628302855;5033.169527028036;5042.1176294148745;5049.2426136079885;5058.924116138261;4515.0969806038265;4647.117047760915;4651.930221046687;4669.95330046702;4697.8355757548325;5150.227465880148;5157.793688252503;5194.766235519411;5201.479852014768;5219.19102539107;4940.258961155855;4987.950120498821;4993.450720420751;4994.600431965434;4994.750262486861;4833.564979151823;4947.480514545993;4974.751262436864;5082.695038297714;5083.669561478566;4976.576990955737;4980.302757613937;4987.301777751118;5018.146915024455;5023.6985780853265;4949.059678661043;4950.480199578992;4954.727489988085;4956.529129732669;4999.475055119233;4082.9795851020554;4114.0948991221885;4206.747595144301;4251.511076226274;4289.142171565637;3692.0769807548113;3708.796016219134;3745.4943582616543;3775.716821238418;3809.6190380961684;4281.678874084456;4288.48538175421;4290.034742182984;4302.505211900671;4341.913161736811;4885.389326334208;4919.827806026772;5044.899102017939;5057.165567681365;5088.160453525127;4211.705180637326;4215.388768628532;4257.063446041866;4266.232078225949;4272.230998420314;4457.286834106592;4461.687681862303;4467.597916187558;4468.865934021985;4512.638988880882;4587.655925805511;4664.580187783115;4665.020345727436;4671.953280467152;4694.483606803249;4922.261660750916;4952.826651067196;4964.578010868972;4975.701457912537;5059.6458247923765;4677.345171676036;4693.389859318267;4705.811767529261;4707.905841883075;4765.046990601824;4766.428028636586;4903.509649035068;4908.214685650279;4923.212286034217;4958.528939750718;4944.728039957837;4976.477469865612;4985.900281994413;4992.700437973734;5066.949330506795;4876.926846097383;4883.072216278895;4889.511048895082;4894.167991441393;4932.704037757602;4698.553637404441;4874.2444921037295;4897.730624815526;4904.6321525886415;4947.406311242674;4761.666683332133;4787.712737235777;4792.472827988849;4808.3989501312335;4869.853904382874;4926.137925863031;4929.1866841972105;4931.408231012301;4933.062718083553;4968.27959945813;4650.511696271843;4819.662623616454;4820.108279968217;4821.710697358169;4860.3681521403405 16:32:54 INFO - PROCESS | 3829 | |1;ext.html;554.816753178042;577.4341145677237;585.5374254339073;586.454597224581;599.580293794344;27453;30195.24511887204;30217.546736798966;30228.546571801442;30244.546331805013;30522.84738576304;40784.18431631366;41791;41884.371734423934;45792.54207457933;7726.497777644463;7844.607769611525;7847.960760196191;7849.489783164105;7850.803729906769;7783.961080194619;7863.37093032556;7865.528068315891;7871.685132594689;7875.921240787605;7589.468737188399;7811.257930496622;7814.257645523695;7997.560134192617;8016.919830801676;9547;9769.462679552622;9776.951115244377;10058.698239052841;10066.647667331608;9900.108990190918;9979.30144889858;9980.750481237954;9985.151262142726;9998.80002399948;39037.80481097605;39327.21345573072;39355.40966885499;39403;39434.60565394338;3088.6454183266933;3139.4505961456653;3172.6351469581064;3218.1471909943884;3457.878974235915;29541.556876646868;30026.39947201044;30106.24734381636;30161.849190753906;30170.09489715312;3284.0640417480904;3303.7687361884678;3328.933421331584;3455.2053027803495;3458.0836078439233;255159;255711;255861;256939;257620;32221.838890805866;55208.72395638077;55379.72310138423;55497.72251138718;55587.72206138943;32185;34000.31999359999;34001.14997125092;34057.31885362279;34085.65914340825;13584.864151358557;13614.387352569158;13659.726805463835;13691.452341906412;13701.657458563615;11339.829902551468;11376.431178441046;11400.657980260605;11403.258788178742;11404.714882127848;7868.44920855546;7904.762857114296;7937.166597507294;7980.600969951479;7995.440319177602;2890.089621769136;2990.8654110565076;3122.328699329655;3153.4008538378093;3170.25499007733;878.6573236437795;916.5371487398821;934.4159900062461;939.272064150289;1017.4454922067491;28438.289042773682;28603.713962860103;28858.422831543252;29477.85261073681;29566.260843479085;935.3265648732902;992.7021893431942;997.3068717241448;1011.3022014809904;1047.512906498482;14556;15361.615959600877;15363;15520.92239538795;15607.765883511756;411402;414236;415168;416331;418039;49408.27071052496;49773.50226497761;49883;49941;49951;1090.8145615245428;1177.205386364218;1179.5340840368006;1198.3409124981051;1207.1489599832273;28073.298167545974;29419;29486;29933.700662993964;30649.233769155948;43235;43794.34308485439;43820.56179438165;43840.561594384926;43901;256744;259297;259453;260510;430717.00339477835;37073;37113.44329835001;37120;37360.81319593385;37804.24391512099;41972.79013604912;42321.576784231765;42651.14697705967;43078.569214307456;43162.78418607887;36592.45111323385;36599.45100823436;36603.633963660024;37036.25927481489;37249.255014899005;34358;36112.09719756922;36638.267234655694;37674.246515069;38319.42520862245;35397.82301088478;36385.818070910536;36401.817990909876;36801.447978280885;37022;31851.68148318487;33441.74440554077;33851.83074084614;33946.83026584851;34044;25912.611310829976;25934.481310374063;26093.869530652224;26134.86932565325;26223.344416389744 16:32:54 INFO - PROCESS | 3829 | |2;jquery.html;338.7747148146483;340.2327750921671;348.71231234231766;348.7332190873982;364.32417864860685;12724.172928759635;15697.136657483834;16250.268737906777;16642.417515386966;17796.110194490255;16300.184990750444;16726.58183545409;16855.157242137873;16974;17008.82991170088;4939.654224204316;5013.147764879961;5048.192289233723;5065.670731402447;5095.923561146586;3705.7035437165096;5050;5129.512696293846;5646.237757902672;5941.88116237675;5939.198208241897;5996.580239383245;6008.549358798085;6008.909866352008;6010.188624535697;5177.689338639675;5404.540614047811;5429.592780541475;5506.063969125218;5999.6700181490005;5327.360716714019;5330.893382132374;5332.440093790135;5336.786528538853;5336.866578335573;17754.91122544392;18671.53321166968;19165.80834191668;19311.420657380302;20154.899225503927;1755.4031629246117;1860.7860096088853;1884.9340273090513;1958.6768183249746;2017.2032047341365;8748;9221.216196623294;9387.62449502026;11721.355325457096;13464.057515973886;1623.6833817405611;1691.560194349478;1724.3792234795465;1728.485054246069;1755.3768412213608;66064.33935660678;67554.32445675529;67899;69387.65306173488;71873;9693.418394896187;9765.707028789147;9801.264905132144;9979.45113018791;10184.796304073878;13227.2725000124;13228.470861165446;13242.53651122206;13249.867501324863;13250.204987700768;7061.329173728487;7119.288071192943;7258.237885021997;7265.782026539212;7271.563706177541;6641.568298060611;6660.167479065117;6849.075374824335;6851.417629501449;6851.931480685229;4122.793860307032;4212;4219.725717828332;4304.289792184317;4310;1744.145368769294;1806.6838303297134;1813.5103522049237;1833.4774589242268;1836.2471386731377;814.4828034198208;849.5837039850552;899.3299991506369;900.7297810656908;944.5088553952044;16558.254878530253;16813.495595132164;17343.39298124585;17463.388781392845;17886.731699024524;851.4252879306567;854.5129276312566;860.6944534690094;874.4971641306274;875.4878396138203;9263.768405789775;9730.12428881404;9819.803603927881;9871.457069861226;9957.10386065243;407127;410096;410736.785264299;429748;431451;78770;79713.20286797173;80250.59874700589;80935.19064809394;82119;880.9779755506036;892.2950868813695;913.3332667153015;913.6436789652041;915.9771005724776;15175.317110730264;15313.051168414637;15676;15998.360065597246;16031.839681603034;37818.24363512769;38514.614853851104;39078.80460597792;39308.213835722556;39708;52456.737716311174;53178;54313.45686543242;54728.452715473926;55540.166897495765;7322.524035937647;7383.372413344926;7517.6992920284765;7618.504797188165;7921.32668723165;9386.95306523463;10680;11595.05532848164;11614.419279036183;12020.158588898694;9125.17873391398;9610.471424071744;9702.563384647849;9950.651727189514;10873.782524349626;9400.717978460658;10083.294169408364;10201.438920859424;10411.303987084477;10489.842652360374;10012.19902407791;10028.849567256642;10104.747381315527;10150;10335.121514671036;6506.674666266762;6889.138857642794;6963.1644202696;7241.565506069653;7284.417246620364;8781.956090219508;9906.801863962824;9967.651132210338;10142.681451411268;10536.631217907336 16:32:54 INFO - PROCESS | 3829 | |3;mootools.html;1243.8009918413056;1319.6436962020252;1377.0085538412343;1424.4943045218947;1690.3238704518192;6350.936490635092;7350.558966462009;7576.6969321227225;7582.810429739259;7850.960745196266;7632.96183519083;7658.808529786744;7678.462507624468;7692.499987500809;7692.846143077135;2192.9671054934147;2207.2605677098113;2216.180013395046;2220.9888950555305;2221.555688862226;2160.546285280093;2209.4476380904775;2226.7105276314137;2227.142550118208;2227.3318004598636;2136.5620047890225;2181.5964046651343;2189.5730332585154;2191.605511008026;2194.078487035441;2080.282302605606;2093.6336141175234;2095.8113769760794;2098.1187901081585;2103.1797598936428;2044.0699481735774;2082.500199952016;2085.4577809769416;2091.3725882235267;2093.3196711068813;7556.395488360973;7691.50005249657;7707;7714.61426928657;7786.844263114763;4440.933385999213;4557.860534866283;4563.247064234397;4566.817327306904;4579.67942244043;2785.220138361262;2900.1154647832404;2956.3496030873175;2962.9407411851857;2964.140399284205;903.7876099116702;909.6764208077298;921.6405601815297;921.7188757428981;925.5973651461568;10029.498525073717;10070.244731645156;10084.798304033951;10114.544845481898;10116.291859569834;3815.1606646537716;3912.4522566840665;4049.8380064797666;4073;4148.170365926766;8260.091389947102;8268.37987150966;8270.172982701682;8270.421070525006;8270.751877443687;4581.65637577183;4596.839110631112;4607.262837945913;4610.400647915817;4618.261078227468;3618.6924111450294;4130.256553820281;4286.978565107154;4294.119705460374;4307.353896915488;3323.401787678241;3340.4321265384942;3441.0709108541055;3447.7414193935556;3470.5661792275964;1009.5911155981839;1029.4235228272041;1036.8081904847477;1038.813013657549;1045.968620941373;701.5650296816007;864.6800683747053;886.9911300886909;890.9599068041824;892.1524551675934;5281.524662780368;5328.946710532845;5476.972615136899;5568.526675232651;5634.23937768396;420.93685947107565;422.8224145858747;426.4988638349926;427.76472939883564;435.1232266982034;3861.2084522672785;3919.333713268751;3920.2943470175073;3936.6063393660406;3949.881503554898;9217.202645484067;9686.176674982706;9712;9738.561764720605;9740.269479788902;9629.229661627052;9652.855207171899;9658.75853103678;9665.951670241604;9705.223582113555;7197.424206063502;7349.191588925214;7437.330640242512;7440.255974402517;7461.440391970624;5259.63182577216;5300.416954134965;5327.174287985368;5485.424030476743;5538.6399884007415;8740.825183496421;8781.692640757543;8826.02913679482;8873.334499912404;8925.687600933936;8722.433041852259;9078.500682462529;9086.954565227132;9179.954100229723;9185.494797786187;5717.799877004285;6505.121808555785;6656.068150459037;6732.057511948429;6744.426723728538;6491.545591808528;6720.462363011045;6737;6737.25890152073;7164.319389657974;6231.781887633911;6505.9265221237965;6686.5653732507235;6723.125993620798;6792;6696.7656132035145;6729.057931889637;6758.695858686273;6789.049533065276;6811.421029212573;6151.907721384094;6230.096635987666;6231.688415579293;6231.906521402273;6252.155958945484;4487.730736155841;4517.051419202005;4602.171609110393;4652.255639097728;4661.230896901973;4610.861674149781;4665.8328890393595;4698.741569213589;4738.265568836836;4905.043516514388 16:32:54 INFO - PROCESS | 3829 | |4;prototype.html;288.06379267381;292.2518353016278;295.80772497876393;301.90640901320586;302.0530636454715;4815.54252346027;4879.463259041511;4881.316615673809;4890.581731297923;4918.655694101414;4538.54614538546;4668.743219122947;4673.859784206479;4674.953250467494;4815.32585438038;3668.669819716225;3725.6833169180654;3730.347189241885;3785.7539259948153;3794.5256842894637;3784.6186142058086;3795.1650636859845;3795.5065841440573;3807.181455986962;3824.6366595173413;3679.5584529856455;3761.8307176177136;3770.868019619314;3795.4496597993275;3797.9810100949594;3757.9812100939594;3759.2857357102334;3760.191558814854;3775.1505911169766;3782.546094468654;3318.3529211803707;3337.5327454156436;3339.482380231068;3347.2468694543777;3357.6978071973394;4701.708803837328;4716.740579268139;4720.480747117815;4720.622350211975;4739.881502962454;4222.809973551198;4281.7002809803325;4320.395144679747;4330.372096046087;4346.913061738747;5033.823816166417;5040.6471546991725;5042.697438153723;5046.637407899883;5055.368078990126;3662.1943172502006;3664.9450258246147;3665.4135338345736;3665.541807274091;3675.2649470106085;5189.610779191538;5281.947180528184;5282.128448805943;5283.313169288006;5302.787888484456;3721.9441708374397;3731.7498637956587;3740.8129593520216;3750.249950010009;3765.811709414518;3774.6036666150208;3782.394816829294;3791.526059242595;3799.2021675448464;3829.5213098362706;4330.956690433119;4340.587644173798;4350.1734670412525;4355.237833379146;4359.106383191438;4942.57988071018;5015.21959704307;5020.322256495399;5031.597472202215;5102.413222479388;1320.795276732108;1328.2760895312078;1333.4332908513843;1334.0528224960387;1335.118821577754;853.3343991686495;864.5979619476973;905.1762895764954;915.199200699388;928.8992543835576;4329.242382583036;4356.978215108904;4358.782060896942;4378.8029538670835;4388.626966707866;5108.595136337537;5112.718800465936;5118.309028281209;5172.379314482287;5172.663776854568;4185.309423945076;4370.8033138508845;4402.537733537996;4415.271480205794;4432.113577284556;2738.2059202831356;2743.7119102493953;2745.7391547802927;2746.6978632350424;2761.751442370156;4798.2082956311815;4838.612910967114;4844.781984810692;4847.636427267969;4860.854174374775;5016.398032236155;5160.251763494272;5192.948070519322;5217.2434996925995;5231.659942103751;4806.308467258346;4839.596517010098;4875;4877.244027175793;4883.731394773251;5135.435102138837;5151.665141765923;5151.793928242828;5158.638895277295;5159.484051594811;4892.412910450768;5010.7387243395015;5022.221555658879;5029.346184995927;5042.420121686053;4838.903221935471;4844.214576618529;4845.781939812788;4851.126797176542;4860.930595269035;3749.4750734896593;3766.6798322142927;3767.3030489359558;3767.547894252707;3773.603771604052;4902.534259245366;5105.693658380509;5134.589232861287;5153.433122356463;5164.225366195101;4967.25491176312;4970.502949705001;4972.905960688643;4984.22744474607;4993.226049962262;4939.110960027229;4942.950570494393;4954.727489987941;4958.528939750718;4969.925451118163;4754.263089221176;4881.731504767272;4883.316335712932;4988.301637770643;5038.14351560243;4913;4958.479359667183;5083.652831999597;5121.564667003347;5131.717755523333;5011.897382575828;5014.373203349582;5026.271190677258;5034.119029169808;5046.596272298134 16:32:54 INFO - PROCESS | 3829 | |5;yui.html;594.4887396838719;605.3855336833113;681.4684546054079;715.4497396557891;720.6036679826094;12509.311987840665;13374.130681505696;13487.59537213884;13491.797623035662;13500;12755;13195.604131876034;13285.26931018796;13339.53311634093;13344.466221351135;780.3756994404482;796.9402294827883;797.2744802229972;797.2824457987799;797.3740613618311;644.6776611694153;763.4693887748017;788.207851109634;792.8929594504725;794.9324307433875;826.3719573124439;828.6726742936537;828.693383448125;829.1501211258447;829.4815740162398;813.9511629302261;814.7270664327398;814.8859159717645;815.4414226255034;815.4577206157898;493.07302271729276;498.1481666350545;503.3456506541518;503.4638110412399;583.5623282538096;12666.36668166588;13143.14569552976;13151.079424440293;13151.276679782608;13204.6698832529;11915.702107447296;12076;12513.687157821036;12523.185992910523;13559.45762169512;11791.528338866436;12012.339321337324;12064.517419303218;12069.818952715716;12105.09211809109;4141.875743727663;4163.292240319122;4239.59723826236;4373.825046998117;4378.408914796525;62403;63545.36454635487;63832.36167638311;64202.678986605235;64569.3543064568;10736.838947415796;10782.4069676167;10826.079783218358;10977.12183025356;10980.286281391684;19775.901120494305;20300.898495507427;20445.2844150454;20474.590508189754;20487.69268460974;6751.662416879137;6773.288804675537;7075.115610548682;7076.150861896605;7467.327940485382;3658.122050707811;3787.6023017583307;3796.430535419709;3867.4446812652286;3893.980530097331;2822.6612806463354;2898.666653334851;2910.57796619489;2910.752586030211;2914.941701165965;517.8239398604493;534.8047962493739;542.0459990416895;548.3693752185019;555.5389027107491;524.2660275614095;534.9037173308842;551.4402881075712;594.6224147666263;601.8675891303906;8130.552819594979;8180.713675021346;8299.211574900375;8371.995360556772;8519.105493923173;551.0576913477997;563.2368141168657;590.3417689276512;597.9910301345483;610.3743662745633;3875.8643447479203;3984.6812255019527;4021.557628660845;4090.4682391288943;4111.5477297497255;102556.48721756492;110963;113187;115324.42337788257;115675;93968.53015734878;94204;95171;95766.52116739372;96692.51653741686;80431.19568804355;83545;83620.58189709013;84592.57703711442;85547.57226213954;7388.445866559922;7486.326230639051;7546.811329716581;7804.2585954334245;8000.839983200187;48233.51766482431;50427.49572504228;50873.74563127161;51000.74499627478;51404.22893656523;63032;63881;68372.3162768366;73174.26825731888;75454.62272688601;10089.798204036026;10536.894631053592;10615.840762388416;10670.35977841332;11176.497057632263;10976.506057227603;11281.21031527785;11376.54493820238;11520.88479115198;11580.305181689126;11019.118470522499;11128.499217535069;11174.88825111771;11875.524979000744;11996.64010079699;10935.507902144263;11788.882111178778;12292.754144916873;12297.631071067883;12381.566645167737;11633.243839150766;12201.511939522676;12249.448774804978;12315.69210769738;12716.109872308849;10235.23235757336;10304.587816487556;10377.844332335171;10524.421156836448;10600.522976466233;9675.758106047406;10254.53854576531;10366.170706343626;10387;10423.42671153094 16:32:54 INFO - PROCESS | 3829 | __end_tp_report 16:32:54 INFO - PROCESS | 3829 | __start_cc_report 16:32:54 INFO - PROCESS | 3829 | _x_x_mozilla_cycle_collect,1023 16:32:54 INFO - PROCESS | 3829 | __end_cc_report 16:32:54 INFO - PROCESS | 3829 | __startTimestamp1469748774415__endTimestamp 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | ------- Summary: start ------- 16:32:54 INFO - PROCESS | 3829 | Number of tests: 6 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | [#0] dojo.html Cycles:165 Average:4610.47 Median:4705.44 stddev:490.92 (10.4%) stddev-sans-first:465.32 16:32:54 INFO - PROCESS | 3829 | Values: 2559.8 2576.4 2603.1 2621.9 2622.2 4513.1 4571.6 4670.4 4688.4 4704.9 4639.6 4641.9 4674.4 4684.1 4726.0 4232.2 4253.3 4332.2 4375.8 4386.2 4312.8 4339.2 4353.6 4368.4 4380.4 4150.5 4181.9 4183.9 4196.9 4267.3 4224.1 4228.1 4229.2 4300.7 4373.4 4248.6 4250.7 4258.8 4289.8 4291.2 4531.8 4541.6 4657.1 4677.0 4705.4 4887.4 4911.3 4980.0 4983.8 5014.6 5031.6 5033.2 5042.1 5049.2 5058.9 4515.1 4647.1 4651.9 4670.0 4697.8 5150.2 5157.8 5194.8 5201.5 5219.2 4940.3 4988.0 4993.5 4994.6 4994.8 4833.6 4947.5 4974.8 5082.7 5083.7 4976.6 4980.3 4987.3 5018.1 5023.7 4949.1 4950.5 4954.7 4956.5 4999.5 4083.0 4114.1 4206.7 4251.5 4289.1 3692.1 3708.8 3745.5 3775.7 3809.6 4281.7 4288.5 4290.0 4302.5 4341.9 4885.4 4919.8 5044.9 5057.2 5088.2 4211.7 4215.4 4257.1 4266.2 4272.2 4457.3 4461.7 4467.6 4468.9 4512.6 4587.7 4664.6 4665.0 4672.0 4694.5 4922.3 4952.8 4964.6 4975.7 5059.6 4677.3 4693.4 4705.8 4707.9 4765.0 4766.4 4903.5 4908.2 4923.2 4958.5 4944.7 4976.5 4985.9 4992.7 5066.9 4876.9 4883.1 4889.5 4894.2 4932.7 4698.6 4874.2 4897.7 4904.6 4947.4 4761.7 4787.7 4792.5 4808.4 4869.9 4926.1 4929.2 4931.4 4933.1 4968.3 4650.5 4819.7 4820.1 4821.7 4860.4 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | [#1] ext.html Cycles:180 Average:47066.87 Median:36497.13 stddev:87464.74 (239.6%) stddev-sans-first:87640.39 16:32:54 INFO - PROCESS | 3829 | Values: 554.8 577.4 585.5 586.5 599.6 27453.0 30195.2 30217.5 30228.5 30244.5 30522.8 40784.2 41791.0 41884.4 45792.5 7726.5 7844.6 7848.0 7849.5 7850.8 7784.0 7863.4 7865.5 7871.7 7875.9 7589.5 7811.3 7814.3 7997.6 8016.9 9547.0 9769.5 9777.0 10058.7 10066.6 9900.1 9979.3 9980.8 9985.2 9998.8 39037.8 39327.2 39355.4 39403.0 39434.6 3088.6 3139.5 3172.6 3218.1 3457.9 29541.6 30026.4 30106.2 30161.8 30170.1 3284.1 3303.8 3328.9 3455.2 3458.1 255159.0 255711.0 255861.0 256939.0 257620.0 32221.8 55208.7 55379.7 55497.7 55587.7 32185.0 34000.3 34001.1 34057.3 34085.7 13584.9 13614.4 13659.7 13691.5 13701.7 11339.8 11376.4 11400.7 11403.3 11404.7 7868.4 7904.8 7937.2 7980.6 7995.4 2890.1 2990.9 3122.3 3153.4 3170.3 878.7 916.5 934.4 939.3 1017.4 28438.3 28603.7 28858.4 29477.9 29566.3 935.3 992.7 997.3 1011.3 1047.5 14556.0 15361.6 15363.0 15520.9 15607.8 411402.0 414236.0 415168.0 416331.0 418039.0 49408.3 49773.5 49883.0 49941.0 49951.0 1090.8 1177.2 1179.5 1198.3 1207.1 28073.3 29419.0 29486.0 29933.7 30649.2 43235.0 43794.3 43820.6 43840.6 43901.0 256744.0 259297.0 259453.0 260510.0 430717.0 37073.0 37113.4 37120.0 37360.8 37804.2 41972.8 42321.6 42651.1 43078.6 43162.8 36592.5 36599.5 36603.6 37036.3 37249.3 34358.0 36112.1 36638.3 37674.2 38319.4 35397.8 36385.8 36401.8 36801.4 37022.0 31851.7 33441.7 33851.8 33946.8 34044.0 25912.6 25934.5 26093.9 26134.9 26223.3 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | [#2] jquery.html Cycles:180 Average:25183.49 Median:5112.72 stddev:68967.24 (1348.9%) stddev-sans-first:69135.49 16:32:54 INFO - PROCESS | 3829 | Values: 338.8 340.2 348.7 348.7 364.3 12724.2 15697.1 16250.3 16642.4 17796.1 16300.2 16726.6 16855.2 16974.0 17008.8 4939.7 5013.1 5048.2 5065.7 5095.9 3705.7 5050.0 5129.5 5646.2 5941.9 5939.2 5996.6 6008.5 6008.9 6010.2 5177.7 5404.5 5429.6 5506.1 5999.7 5327.4 5330.9 5332.4 5336.8 5336.9 17754.9 18671.5 19165.8 19311.4 20154.9 1755.4 1860.8 1884.9 1958.7 2017.2 8748.0 9221.2 9387.6 11721.4 13464.1 1623.7 1691.6 1724.4 1728.5 1755.4 66064.3 67554.3 67899.0 69387.7 71873.0 9693.4 9765.7 9801.3 9979.5 10184.8 13227.3 13228.5 13242.5 13249.9 13250.2 7061.3 7119.3 7258.2 7265.8 7271.6 6641.6 6660.2 6849.1 6851.4 6851.9 4122.8 4212.0 4219.7 4304.3 4310.0 1744.1 1806.7 1813.5 1833.5 1836.2 814.5 849.6 899.3 900.7 944.5 16558.3 16813.5 17343.4 17463.4 17886.7 851.4 854.5 860.7 874.5 875.5 9263.8 9730.1 9819.8 9871.5 9957.1 407127.0 410096.0 410736.8 429748.0 431451.0 78770.0 79713.2 80250.6 80935.2 82119.0 881.0 892.3 913.3 913.6 916.0 15175.3 15313.1 15676.0 15998.4 16031.8 37818.2 38514.6 39078.8 39308.2 39708.0 52456.7 53178.0 54313.5 54728.5 55540.2 7322.5 7383.4 7517.7 7618.5 7921.3 9387.0 10680.0 11595.1 11614.4 12020.2 9125.2 9610.5 9702.6 9950.7 10873.8 9400.7 10083.3 10201.4 10411.3 10489.8 10012.2 10028.8 10104.7 10150.0 10335.1 6506.7 6889.1 6963.2 7241.6 7284.4 8782.0 9906.8 9967.7 10142.7 10536.6 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | [#3] mootools.html Cycles:180 Average:5040.66 Median:5270.58 stddev:2816.75 (53.4%) stddev-sans-first:2810.20 16:32:54 INFO - PROCESS | 3829 | Values: 1243.8 1319.6 1377.0 1424.5 1690.3 6350.9 7350.6 7576.7 7582.8 7851.0 7633.0 7658.8 7678.5 7692.5 7692.8 2193.0 2207.3 2216.2 2221.0 2221.6 2160.5 2209.4 2226.7 2227.1 2227.3 2136.6 2181.6 2189.6 2191.6 2194.1 2080.3 2093.6 2095.8 2098.1 2103.2 2044.1 2082.5 2085.5 2091.4 2093.3 7556.4 7691.5 7707.0 7714.6 7786.8 4440.9 4557.9 4563.2 4566.8 4579.7 2785.2 2900.1 2956.3 2962.9 2964.1 903.8 909.7 921.6 921.7 925.6 10029.5 10070.2 10084.8 10114.5 10116.3 3815.2 3912.5 4049.8 4073.0 4148.2 8260.1 8268.4 8270.2 8270.4 8270.8 4581.7 4596.8 4607.3 4610.4 4618.3 3618.7 4130.3 4287.0 4294.1 4307.4 3323.4 3340.4 3441.1 3447.7 3470.6 1009.6 1029.4 1036.8 1038.8 1046.0 701.6 864.7 887.0 891.0 892.2 5281.5 5328.9 5477.0 5568.5 5634.2 420.9 422.8 426.5 427.8 435.1 3861.2 3919.3 3920.3 3936.6 3949.9 9217.2 9686.2 9712.0 9738.6 9740.3 9629.2 9652.9 9658.8 9666.0 9705.2 7197.4 7349.2 7437.3 7440.3 7461.4 5259.6 5300.4 5327.2 5485.4 5538.6 8740.8 8781.7 8826.0 8873.3 8925.7 8722.4 9078.5 9087.0 9180.0 9185.5 5717.8 6505.1 6656.1 6732.1 6744.4 6491.5 6720.5 6737.0 6737.3 7164.3 6231.8 6505.9 6686.6 6723.1 6792.0 6696.8 6729.1 6758.7 6789.0 6811.4 6151.9 6230.1 6231.7 6231.9 6252.2 4487.7 4517.1 4602.2 4652.3 4661.2 4610.9 4665.8 4698.7 4738.3 4905.0 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | [#4] prototype.html Cycles:180 Average:4183.83 Median:4802.26 stddev:1193.01 (24.8%) stddev-sans-first:1159.97 16:32:54 INFO - PROCESS | 3829 | Values: 288.1 292.3 295.8 301.9 302.1 4815.5 4879.5 4881.3 4890.6 4918.7 4538.5 4668.7 4673.9 4675.0 4815.3 3668.7 3725.7 3730.3 3785.8 3794.5 3784.6 3795.2 3795.5 3807.2 3824.6 3679.6 3761.8 3770.9 3795.4 3798.0 3758.0 3759.3 3760.2 3775.2 3782.5 3318.4 3337.5 3339.5 3347.2 3357.7 4701.7 4716.7 4720.5 4720.6 4739.9 4222.8 4281.7 4320.4 4330.4 4346.9 5033.8 5040.6 5042.7 5046.6 5055.4 3662.2 3664.9 3665.4 3665.5 3675.3 5189.6 5281.9 5282.1 5283.3 5302.8 3721.9 3731.7 3740.8 3750.2 3765.8 3774.6 3782.4 3791.5 3799.2 3829.5 4331.0 4340.6 4350.2 4355.2 4359.1 4942.6 5015.2 5020.3 5031.6 5102.4 1320.8 1328.3 1333.4 1334.1 1335.1 853.3 864.6 905.2 915.2 928.9 4329.2 4357.0 4358.8 4378.8 4388.6 5108.6 5112.7 5118.3 5172.4 5172.7 4185.3 4370.8 4402.5 4415.3 4432.1 2738.2 2743.7 2745.7 2746.7 2761.8 4798.2 4838.6 4844.8 4847.6 4860.9 5016.4 5160.3 5192.9 5217.2 5231.7 4806.3 4839.6 4875.0 4877.2 4883.7 5135.4 5151.7 5151.8 5158.6 5159.5 4892.4 5010.7 5022.2 5029.3 5042.4 4838.9 4844.2 4845.8 4851.1 4860.9 3749.5 3766.7 3767.3 3767.5 3773.6 4902.5 5105.7 5134.6 5153.4 5164.2 4967.3 4970.5 4972.9 4984.2 4993.2 4939.1 4943.0 4954.7 4958.5 4969.9 4754.3 4881.7 4883.3 4988.3 5038.1 4913.0 4958.5 5083.7 5121.6 5131.7 5011.9 5014.4 5026.3 5034.1 5046.6 16:32:54 INFO - PROCESS | 3829 | 16:32:54 INFO - PROCESS | 3829 | [#5] yui.html Cycles:180 Average:19181.41 Median:4201.44 stddev:28501.75 (678.4%) stddev-sans-first:28547.54 16:32:54 INFO - PROCESS | 3829 | Values: 594.5 605.4 681.5 715.4 720.6 12509.3 13374.1 13487.6 13491.8 13500.0 12755.0 13195.6 13285.3 13339.5 13344.5 780.4 796.9 797.3 797.3 797.4 644.7 763.5 788.2 792.9 794.9 826.4 828.7 828.7 829.2 829.5 814.0 814.7 814.9 815.4 815.5 493.1 498.1 503.3 503.5 583.6 12666.4 13143.1 13151.1 13151.3 13204.7 11915.7 12076.0 12513.7 12523.2 13559.5 11791.5 12012.3 12064.5 12069.8 12105.1 4141.9 4163.3 4239.6 4373.8 4378.4 62403.0 63545.4 63832.4 64202.7 64569.4 10736.8 10782.4 10826.1 10977.1 10980.3 19775.9 20300.9 20445.3 20474.6 20487.7 6751.7 6773.3 7075.1 7076.2 7467.3 3658.1 3787.6 3796.4 3867.4 3894.0 2822.7 2898.7 2910.6 2910.8 2914.9 517.8 534.8 542.0 548.4 555.5 524.3 534.9 551.4 594.6 601.9 8130.6 8180.7 8299.2 8372.0 8519.1 551.1 563.2 590.3 598.0 610.4 3875.9 3984.7 4021.6 4090.5 4111.5 102556.5 110963.0 113187.0 115324.4 115675.0 93968.5 94204.0 95171.0 95766.5 96692.5 80431.2 83545.0 83620.6 84592.6 85547.6 7388.4 7486.3 7546.8 7804.3 8000.8 48233.5 50427.5 50873.7 51000.7 51404.2 63032.0 63881.0 68372.3 73174.3 75454.6 10089.8 10536.9 10615.8 10670.4 11176.5 10976.5 11281.2 11376.5 11520.9 11580.3 11019.1 11128.5 11174.9 11875.5 11996.6 10935.5 11788.9 12292.8 12297.6 12381.6 11633.2 12201.5 12249.4 12315.7 12716.1 10235.2 10304.6 10377.8 10524.4 10600.5 9675.8 10254.5 10366.2 10387.0 10423.4 16:32:54 INFO - PROCESS | 3829 | -------- Summary: end -------- 16:32:54 INFO - PROCESS | 3829 | 16:32:55 INFO - TEST-INFO | 3829: exit 0 16:32:55 INFO - TEST-OK | dromaeo_css | took 1120361ms 16:32:55 INFO - TEST-START | kraken 16:32:55 INFO - operating with platform_type : linux_ 16:32:55 INFO - Initialising browser for kraken test... 16:32:55 INFO - TEST-INFO | started process 4022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhCq3I/profile http://localhost:42436/getInfo.html) 16:32:59 INFO - PROCESS | 4022 | JavaScript error: , line 0: uncaught exception: undefined 16:33:00 INFO - PROCESS | 4022 | __metrics Screen width/height:1600/1200 16:33:00 INFO - PROCESS | 4022 | colorDepth:24 16:33:00 INFO - PROCESS | 4022 | Browser inner width/height: 1024/697 16:33:00 INFO - PROCESS | 4022 | __metrics 16:33:01 INFO - PROCESS | 4022 | 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" 16:33:01 INFO - PROCESS | 4022 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:02 INFO - TEST-INFO | 4022: exit 0 16:33:02 INFO - Browser initialized. 16:33:02 INFO - Running cycle 1/1 for kraken test... 16:33:02 INFO - TEST-INFO | started process 4099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhCq3I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:14 INFO - PROCESS | 4099 | RSS: Main: 159223808 16:33:14 INFO - PROCESS | 4099 | 16:33:17 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42436/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:18 INFO - PROCESS | 4099 | RSS: Main: 215162880 16:33:18 INFO - PROCESS | 4099 | 16:33:20 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42436/tests/kraken/driver.html?testName=audio-dft) 16:33:21 INFO - PROCESS | 4099 | RSS: Main: 189247488 16:33:21 INFO - PROCESS | 4099 | 16:33:24 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42436/tests/kraken/driver.html?testName=audio-fft) 16:33:25 INFO - PROCESS | 4099 | RSS: Main: 273207296 16:33:25 INFO - PROCESS | 4099 | 16:33:27 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42436/tests/kraken/driver.html?testName=audio-oscillator) 16:33:28 INFO - PROCESS | 4099 | RSS: Main: 182251520 16:33:28 INFO - PROCESS | 4099 | 16:33:30 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:31 INFO - PROCESS | 4099 | RSS: Main: 186093568 16:33:31 INFO - PROCESS | 4099 | 16:33:34 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42436/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:34 INFO - PROCESS | 4099 | RSS: Main: 222748672 16:33:34 INFO - PROCESS | 4099 | 16:33:38 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42436/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:38 INFO - PROCESS | 4099 | RSS: Main: 216989696 16:33:38 INFO - PROCESS | 4099 | 16:33:41 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42436/tests/kraken/driver.html?testName=json-parse-financial) 16:33:42 INFO - PROCESS | 4099 | RSS: Main: 220450816 16:33:42 INFO - PROCESS | 4099 | 16:33:44 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:44 INFO - PROCESS | 4099 | RSS: Main: 186232832 16:33:44 INFO - PROCESS | 4099 | 16:33:46 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:47 INFO - PROCESS | 4099 | RSS: Main: 191041536 16:33:47 INFO - PROCESS | 4099 | 16:33:49 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:50 INFO - PROCESS | 4099 | RSS: Main: 196370432 16:33:50 INFO - PROCESS | 4099 | 16:33:52 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:53 INFO - PROCESS | 4099 | RSS: Main: 190025728 16:33:53 INFO - PROCESS | 4099 | 16:33:56 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:56 INFO - PROCESS | 4099 | RSS: Main: 193658880 16:33:56 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | Cycle 1(1): loaded http://localhost:42436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42436/tests/kraken/driver.html?testName=ai-astar) 16:33:58 INFO - PROCESS | 4099 | RSS: Main: 243974144 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | __start_tp_report 16:33:58 INFO - PROCESS | 4099 | _x_x_mozilla_page_load 16:33:58 INFO - PROCESS | 4099 | _x_x_mozilla_page_load_details 16:33:58 INFO - PROCESS | 4099 | |i|pagename|runs| 16:33:58 INFO - PROCESS | 4099 | |0;ai-astar;105;116;115;113;113;117;112;115;117;113 16:33:58 INFO - PROCESS | 4099 | |1;audio-beat-detection;144;123;121;174;122;123;146;126;164;123 16:33:58 INFO - PROCESS | 4099 | |2;audio-dft;160;160;161;161;161;161;160;160;161;161 16:33:58 INFO - PROCESS | 4099 | |3;audio-fft;76;76;76;124;77;77;75;75;102;77 16:33:58 INFO - PROCESS | 4099 | |4;audio-oscillator;85;85;126;85;85;87;131;86;85;134 16:33:58 INFO - PROCESS | 4099 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 16:33:58 INFO - PROCESS | 4099 | |6;imaging-darkroom;147;147;147;147;147;147;146;147;148;147 16:33:58 INFO - PROCESS | 4099 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 16:33:58 INFO - PROCESS | 4099 | |8;json-parse-financial;64;63;63;64;62;65;63;63;63;63 16:33:58 INFO - PROCESS | 4099 | |9;json-stringify-tinderbox;66;65;66;66;67;66;66;66;66;66 16:33:58 INFO - PROCESS | 4099 | |10;stanford-crypto-aes;78;79;80;78;81;79;78;78;79;79 16:33:58 INFO - PROCESS | 4099 | |11;stanford-crypto-ccm;130;130;129;139;128;129;136;129;220;130 16:33:58 INFO - PROCESS | 4099 | |12;stanford-crypto-pbkdf2;168;163;167;167;164;172;170;165;164;168 16:33:58 INFO - PROCESS | 4099 | |13;stanford-crypto-sha256-iterative;66;67;67;65;66;66;65;65;65;68 16:33:58 INFO - PROCESS | 4099 | __end_tp_report 16:33:58 INFO - PROCESS | 4099 | __start_cc_report 16:33:58 INFO - PROCESS | 4099 | _x_x_mozilla_cycle_collect,1954 16:33:58 INFO - PROCESS | 4099 | __end_cc_report 16:33:58 INFO - PROCESS | 4099 | __startTimestamp1469748838952__endTimestamp 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | ------- Summary: start ------- 16:33:58 INFO - PROCESS | 4099 | Number of tests: 14 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.50 (3.0%) stddev-sans-first:1.88 16:33:58 INFO - PROCESS | 4099 | Values: 105.0 116.0 115.0 113.0 113.0 117.0 112.0 115.0 117.0 113.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:135.00 stddev:19.48 (14.4%) stddev-sans-first:20.48 16:33:58 INFO - PROCESS | 4099 | Values: 144.0 123.0 121.0 174.0 122.0 123.0 146.0 126.0 164.0 123.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 16:33:58 INFO - PROCESS | 4099 | Values: 160.0 160.0 161.0 161.0 161.0 161.0 160.0 160.0 161.0 161.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.41 (21.6%) stddev-sans-first:17.18 16:33:58 INFO - PROCESS | 4099 | Values: 76.0 76.0 76.0 124.0 77.0 77.0 75.0 75.0 102.0 77.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:85.00 stddev:21.78 (25.6%) stddev-sans-first:22.52 16:33:58 INFO - PROCESS | 4099 | Values: 85.0 85.0 126.0 85.0 85.0 87.0 131.0 86.0 85.0 134.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:33:58 INFO - PROCESS | 4099 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 16:33:58 INFO - PROCESS | 4099 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:33:58 INFO - PROCESS | 4099 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 16:33:58 INFO - PROCESS | 4099 | Values: 64.0 63.0 63.0 64.0 62.0 65.0 63.0 63.0 63.0 63.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 16:33:58 INFO - PROCESS | 4099 | Values: 66.0 65.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 16:33:58 INFO - PROCESS | 4099 | Values: 78.0 79.0 80.0 78.0 81.0 79.0 78.0 78.0 79.0 79.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:130.00 stddev:28.33 (21.8%) stddev-sans-first:29.82 16:33:58 INFO - PROCESS | 4099 | Values: 130.0 130.0 129.0 139.0 128.0 129.0 136.0 129.0 220.0 130.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.50 stddev:2.86 (1.7%) stddev-sans-first:3.00 16:33:58 INFO - PROCESS | 4099 | Values: 168.0 163.0 167.0 167.0 164.0 172.0 170.0 165.0 164.0 168.0 16:33:58 INFO - PROCESS | 4099 | 16:33:58 INFO - PROCESS | 4099 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 16:33:58 INFO - PROCESS | 4099 | Values: 66.0 67.0 67.0 65.0 66.0 66.0 65.0 65.0 65.0 68.0 16:33:58 INFO - PROCESS | 4099 | -------- Summary: end -------- 16:33:58 INFO - PROCESS | 4099 | 16:34:00 INFO - TEST-INFO | 4099: exit 0 16:34:00 INFO - TEST-OK | kraken | took 65224ms 16:34:00 INFO - SUITE-END | took 1185s 16:34:00 INFO - Completed test suite (00:19:45) 16:34:00 INFO - javascript benchmark 16:34:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2559.7952163826894, 2576.3559110222445, 2603.1149409200866, 2621.93445163871, 2622.1871219921827, 4513.119941611387, 4571.611413029888, 4670.439547254326, 4688.437387513499, 4704.858854234374, 4639.6288296936245, 4641.883952901179, 4674.392328997225, 4684.13343531446, 4725.976370118145, 4232.238197124517, 4253.298205796048, 4332.220200363933, 4375.846845360413, 4386.210482113218, 4312.849050283241, 4339.2406328892475, 4353.564643535653, 4368.410264614268, 4380.386745855582, 4150.501939767248, 4181.895452613679, 4183.91632167358, 4196.853110141161, 4267.253230684633, 4224.091820258659, 4228.069824638575, 4229.154169166149, 4300.677449191323, 4373.431453911003, 4248.575142485726, 4250.659947204216, 4258.765767882765, 4289.764062976535, 4291.206126866539, 4531.818727250906, 4541.613962813165, 4657.091867085919, 4677.0, 4705.435347758256, 4887.3890763654545, 4911.336969509106, 4979.950200497985, 4983.800647974077, 5014.623903207274, 5031.622628302855, 5033.169527028036, 5042.1176294148745, 5049.2426136079885, 5058.924116138261, 4515.0969806038265, 4647.117047760915, 4651.930221046687, 4669.95330046702, 4697.8355757548325, 5150.227465880148, 5157.793688252503, 5194.766235519411, 5201.479852014768, 5219.19102539107, 4940.258961155855, 4987.950120498821, 4993.450720420751, 4994.600431965434, 4994.750262486861, 4833.564979151823, 4947.480514545993, 4974.751262436864, 5082.695038297714, 5083.669561478566, 4976.576990955737, 4980.302757613937, 4987.301777751118, 5018.146915024455, 5023.6985780853265, 4949.059678661043, 4950.480199578992, 4954.727489988085, 4956.529129732669, 4999.475055119233, 4082.9795851020554, 4114.0948991221885, 4206.747595144301, 4251.511076226274, 4289.142171565637, 3692.0769807548113, 3708.796016219134, 3745.4943582616543, 3775.716821238418, 3809.6190380961684, 4281.678874084456, 4288.48538175421, 4290.034742182984, 4302.505211900671, 4341.913161736811, 4885.389326334208, 4919.827806026772, 5044.899102017939, 5057.165567681365, 5088.160453525127, 4211.705180637326, 4215.388768628532, 4257.063446041866, 4266.232078225949, 4272.230998420314, 4457.286834106592, 4461.687681862303, 4467.597916187558, 4468.865934021985, 4512.638988880882, 4587.655925805511, 4664.580187783115, 4665.020345727436, 4671.953280467152, 4694.483606803249, 4922.261660750916, 4952.826651067196, 4964.578010868972, 4975.701457912537, 5059.6458247923765, 4677.345171676036, 4693.389859318267, 4705.811767529261, 4707.905841883075, 4765.046990601824, 4766.428028636586, 4903.509649035068, 4908.214685650279, 4923.212286034217, 4958.528939750718, 4944.728039957837, 4976.477469865612, 4985.900281994413, 4992.700437973734, 5066.949330506795, 4876.926846097383, 4883.072216278895, 4889.511048895082, 4894.167991441393, 4932.704037757602, 4698.553637404441, 4874.2444921037295, 4897.730624815526, 4904.6321525886415, 4947.406311242674, 4761.666683332133, 4787.712737235777, 4792.472827988849, 4808.3989501312335, 4869.853904382874, 4926.137925863031, 4929.1866841972105, 4931.408231012301, 4933.062718083553, 4968.27959945813, 4650.511696271843, 4819.662623616454, 4820.108279968217, 4821.710697358169, 4860.3681521403405], "value": 4578.839481180591, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.816753178042, 577.4341145677237, 585.5374254339073, 586.454597224581, 599.580293794344, 27453.0, 30195.24511887204, 30217.546736798966, 30228.546571801442, 30244.546331805013, 30522.84738576304, 40784.18431631366, 41791.0, 41884.371734423934, 45792.54207457933, 7726.497777644463, 7844.607769611525, 7847.960760196191, 7849.489783164105, 7850.803729906769, 7783.961080194619, 7863.37093032556, 7865.528068315891, 7871.685132594689, 7875.921240787605, 7589.468737188399, 7811.257930496622, 7814.257645523695, 7997.560134192617, 8016.919830801676, 9547.0, 9769.462679552622, 9776.951115244377, 10058.698239052841, 10066.647667331608, 9900.108990190918, 9979.30144889858, 9980.750481237954, 9985.151262142726, 9998.80002399948, 39037.80481097605, 39327.21345573072, 39355.40966885499, 39403.0, 39434.60565394338, 3088.6454183266933, 3139.4505961456653, 3172.6351469581064, 3218.1471909943884, 3457.878974235915, 29541.556876646868, 30026.39947201044, 30106.24734381636, 30161.849190753906, 30170.09489715312, 3284.0640417480904, 3303.7687361884678, 3328.933421331584, 3455.2053027803495, 3458.0836078439233, 255159.0, 255711.0, 255861.0, 256939.0, 257620.0, 32221.838890805866, 55208.72395638077, 55379.72310138423, 55497.72251138718, 55587.72206138943, 32185.0, 34000.31999359999, 34001.14997125092, 34057.31885362279, 34085.65914340825, 13584.864151358557, 13614.387352569158, 13659.726805463835, 13691.452341906412, 13701.657458563615, 11339.829902551468, 11376.431178441046, 11400.657980260605, 11403.258788178742, 11404.714882127848, 7868.44920855546, 7904.762857114296, 7937.166597507294, 7980.600969951479, 7995.440319177602, 2890.089621769136, 2990.8654110565076, 3122.328699329655, 3153.4008538378093, 3170.25499007733, 878.6573236437795, 916.5371487398821, 934.4159900062461, 939.272064150289, 1017.4454922067491, 28438.289042773682, 28603.713962860103, 28858.422831543252, 29477.85261073681, 29566.260843479085, 935.3265648732902, 992.7021893431942, 997.3068717241448, 1011.3022014809904, 1047.512906498482, 14556.0, 15361.615959600877, 15363.0, 15520.92239538795, 15607.765883511756, 411402.0, 414236.0, 415168.0, 416331.0, 418039.0, 49408.27071052496, 49773.50226497761, 49883.0, 49941.0, 49951.0, 1090.8145615245428, 1177.205386364218, 1179.5340840368006, 1198.3409124981051, 1207.1489599832273, 28073.298167545974, 29419.0, 29486.0, 29933.700662993964, 30649.233769155948, 43235.0, 43794.34308485439, 43820.56179438165, 43840.561594384926, 43901.0, 256744.0, 259297.0, 259453.0, 260510.0, 430717.00339477835, 37073.0, 37113.44329835001, 37120.0, 37360.81319593385, 37804.24391512099, 41972.79013604912, 42321.576784231765, 42651.14697705967, 43078.569214307456, 43162.78418607887, 36592.45111323385, 36599.45100823436, 36603.633963660024, 37036.25927481489, 37249.255014899005, 34358.0, 36112.09719756922, 36638.267234655694, 37674.246515069, 38319.42520862245, 35397.82301088478, 36385.818070910536, 36401.817990909876, 36801.447978280885, 37022.0, 31851.68148318487, 33441.74440554077, 33851.83074084614, 33946.83026584851, 34044.0, 25912.611310829976, 25934.481310374063, 26093.869530652224, 26134.86932565325, 26223.344416389744], "value": 16953.31352277639, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.7747148146483, 340.2327750921671, 348.71231234231766, 348.7332190873982, 364.32417864860685, 12724.172928759635, 15697.136657483834, 16250.268737906777, 16642.417515386966, 17796.110194490255, 16300.184990750444, 16726.58183545409, 16855.157242137873, 16974.0, 17008.82991170088, 4939.654224204316, 5013.147764879961, 5048.192289233723, 5065.670731402447, 5095.923561146586, 3705.7035437165096, 5050.0, 5129.512696293846, 5646.237757902672, 5941.88116237675, 5939.198208241897, 5996.580239383245, 6008.549358798085, 6008.909866352008, 6010.188624535697, 5177.689338639675, 5404.540614047811, 5429.592780541475, 5506.063969125218, 5999.6700181490005, 5327.360716714019, 5330.893382132374, 5332.440093790135, 5336.786528538853, 5336.866578335573, 17754.91122544392, 18671.53321166968, 19165.80834191668, 19311.420657380302, 20154.899225503927, 1755.4031629246117, 1860.7860096088853, 1884.9340273090513, 1958.6768183249746, 2017.2032047341365, 8748.0, 9221.216196623294, 9387.62449502026, 11721.355325457096, 13464.057515973886, 1623.6833817405611, 1691.560194349478, 1724.3792234795465, 1728.485054246069, 1755.3768412213608, 66064.33935660678, 67554.32445675529, 67899.0, 69387.65306173488, 71873.0, 9693.418394896187, 9765.707028789147, 9801.264905132144, 9979.45113018791, 10184.796304073878, 13227.2725000124, 13228.470861165446, 13242.53651122206, 13249.867501324863, 13250.204987700768, 7061.329173728487, 7119.288071192943, 7258.237885021997, 7265.782026539212, 7271.563706177541, 6641.568298060611, 6660.167479065117, 6849.075374824335, 6851.417629501449, 6851.931480685229, 4122.793860307032, 4212.0, 4219.725717828332, 4304.289792184317, 4310.0, 1744.145368769294, 1806.6838303297134, 1813.5103522049237, 1833.4774589242268, 1836.2471386731377, 814.4828034198208, 849.5837039850552, 899.3299991506369, 900.7297810656908, 944.5088553952044, 16558.254878530253, 16813.495595132164, 17343.39298124585, 17463.388781392845, 17886.731699024524, 851.4252879306567, 854.5129276312566, 860.6944534690094, 874.4971641306274, 875.4878396138203, 9263.768405789775, 9730.12428881404, 9819.803603927881, 9871.457069861226, 9957.10386065243, 407127.0, 410096.0, 410736.785264299, 429748.0, 431451.0, 78770.0, 79713.20286797173, 80250.59874700589, 80935.19064809394, 82119.0, 880.9779755506036, 892.2950868813695, 913.3332667153015, 913.6436789652041, 915.9771005724776, 15175.317110730264, 15313.051168414637, 15676.0, 15998.360065597246, 16031.839681603034, 37818.24363512769, 38514.614853851104, 39078.80460597792, 39308.213835722556, 39708.0, 52456.737716311174, 53178.0, 54313.45686543242, 54728.452715473926, 55540.166897495765, 7322.524035937647, 7383.372413344926, 7517.6992920284765, 7618.504797188165, 7921.32668723165, 9386.95306523463, 10680.0, 11595.05532848164, 11614.419279036183, 12020.158588898694, 9125.17873391398, 9610.471424071744, 9702.563384647849, 9950.651727189514, 10873.782524349626, 9400.717978460658, 10083.294169408364, 10201.438920859424, 10411.303987084477, 10489.842652360374, 10012.19902407791, 10028.849567256642, 10104.747381315527, 10150.0, 10335.121514671036, 6506.674666266762, 6889.138857642794, 6963.1644202696, 7241.565506069653, 7284.417246620364, 8781.956090219508, 9906.801863962824, 9967.651132210338, 10142.681451411268, 10536.631217907336], "value": 8161.878511271423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.8009918413056, 1319.6436962020252, 1377.0085538412343, 1424.4943045218947, 1690.3238704518192, 6350.936490635092, 7350.558966462009, 7576.6969321227225, 7582.810429739259, 7850.960745196266, 7632.96183519083, 7658.808529786744, 7678.462507624468, 7692.499987500809, 7692.846143077135, 2192.9671054934147, 2207.2605677098113, 2216.180013395046, 2220.9888950555305, 2221.555688862226, 2160.546285280093, 2209.4476380904775, 2226.7105276314137, 2227.142550118208, 2227.3318004598636, 2136.5620047890225, 2181.5964046651343, 2189.5730332585154, 2191.605511008026, 2194.078487035441, 2080.282302605606, 2093.6336141175234, 2095.8113769760794, 2098.1187901081585, 2103.1797598936428, 2044.0699481735774, 2082.500199952016, 2085.4577809769416, 2091.3725882235267, 2093.3196711068813, 7556.395488360973, 7691.50005249657, 7707.0, 7714.61426928657, 7786.844263114763, 4440.933385999213, 4557.860534866283, 4563.247064234397, 4566.817327306904, 4579.67942244043, 2785.220138361262, 2900.1154647832404, 2956.3496030873175, 2962.9407411851857, 2964.140399284205, 903.7876099116702, 909.6764208077298, 921.6405601815297, 921.7188757428981, 925.5973651461568, 10029.498525073717, 10070.244731645156, 10084.798304033951, 10114.544845481898, 10116.291859569834, 3815.1606646537716, 3912.4522566840665, 4049.8380064797666, 4073.0, 4148.170365926766, 8260.091389947102, 8268.37987150966, 8270.172982701682, 8270.421070525006, 8270.751877443687, 4581.65637577183, 4596.839110631112, 4607.262837945913, 4610.400647915817, 4618.261078227468, 3618.6924111450294, 4130.256553820281, 4286.978565107154, 4294.119705460374, 4307.353896915488, 3323.401787678241, 3340.4321265384942, 3441.0709108541055, 3447.7414193935556, 3470.5661792275964, 1009.5911155981839, 1029.4235228272041, 1036.8081904847477, 1038.813013657549, 1045.968620941373, 701.5650296816007, 864.6800683747053, 886.9911300886909, 890.9599068041824, 892.1524551675934, 5281.524662780368, 5328.946710532845, 5476.972615136899, 5568.526675232651, 5634.23937768396, 420.93685947107565, 422.8224145858747, 426.4988638349926, 427.76472939883564, 435.1232266982034, 3861.2084522672785, 3919.333713268751, 3920.2943470175073, 3936.6063393660406, 3949.881503554898, 9217.202645484067, 9686.176674982706, 9712.0, 9738.561764720605, 9740.269479788902, 9629.229661627052, 9652.855207171899, 9658.75853103678, 9665.951670241604, 9705.223582113555, 7197.424206063502, 7349.191588925214, 7437.330640242512, 7440.255974402517, 7461.440391970624, 5259.63182577216, 5300.416954134965, 5327.174287985368, 5485.424030476743, 5538.6399884007415, 8740.825183496421, 8781.692640757543, 8826.02913679482, 8873.334499912404, 8925.687600933936, 8722.433041852259, 9078.500682462529, 9086.954565227132, 9179.954100229723, 9185.494797786187, 5717.799877004285, 6505.121808555785, 6656.068150459037, 6732.057511948429, 6744.426723728538, 6491.545591808528, 6720.462363011045, 6737.0, 6737.25890152073, 7164.319389657974, 6231.781887633911, 6505.9265221237965, 6686.5653732507235, 6723.125993620798, 6792.0, 6696.7656132035145, 6729.057931889637, 6758.695858686273, 6789.049533065276, 6811.421029212573, 6151.907721384094, 6230.096635987666, 6231.688415579293, 6231.906521402273, 6252.155958945484, 4487.730736155841, 4517.051419202005, 4602.171609110393, 4652.255639097728, 4661.230896901973, 4610.861674149781, 4665.8328890393595, 4698.741569213589, 4738.265568836836, 4905.043516514388], "value": 3997.1128833545213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.06379267381, 292.2518353016278, 295.80772497876393, 301.90640901320586, 302.0530636454715, 4815.54252346027, 4879.463259041511, 4881.316615673809, 4890.581731297923, 4918.655694101414, 4538.54614538546, 4668.743219122947, 4673.859784206479, 4674.953250467494, 4815.32585438038, 3668.669819716225, 3725.6833169180654, 3730.347189241885, 3785.7539259948153, 3794.5256842894637, 3784.6186142058086, 3795.1650636859845, 3795.5065841440573, 3807.181455986962, 3824.6366595173413, 3679.5584529856455, 3761.8307176177136, 3770.868019619314, 3795.4496597993275, 3797.9810100949594, 3757.9812100939594, 3759.2857357102334, 3760.191558814854, 3775.1505911169766, 3782.546094468654, 3318.3529211803707, 3337.5327454156436, 3339.482380231068, 3347.2468694543777, 3357.6978071973394, 4701.708803837328, 4716.740579268139, 4720.480747117815, 4720.622350211975, 4739.881502962454, 4222.809973551198, 4281.7002809803325, 4320.395144679747, 4330.372096046087, 4346.913061738747, 5033.823816166417, 5040.6471546991725, 5042.697438153723, 5046.637407899883, 5055.368078990126, 3662.1943172502006, 3664.9450258246147, 3665.4135338345736, 3665.541807274091, 3675.2649470106085, 5189.610779191538, 5281.947180528184, 5282.128448805943, 5283.313169288006, 5302.787888484456, 3721.9441708374397, 3731.7498637956587, 3740.8129593520216, 3750.249950010009, 3765.811709414518, 3774.6036666150208, 3782.394816829294, 3791.526059242595, 3799.2021675448464, 3829.5213098362706, 4330.956690433119, 4340.587644173798, 4350.1734670412525, 4355.237833379146, 4359.106383191438, 4942.57988071018, 5015.21959704307, 5020.322256495399, 5031.597472202215, 5102.413222479388, 1320.795276732108, 1328.2760895312078, 1333.4332908513843, 1334.0528224960387, 1335.118821577754, 853.3343991686495, 864.5979619476973, 905.1762895764954, 915.199200699388, 928.8992543835576, 4329.242382583036, 4356.978215108904, 4358.782060896942, 4378.8029538670835, 4388.626966707866, 5108.595136337537, 5112.718800465936, 5118.309028281209, 5172.379314482287, 5172.663776854568, 4185.309423945076, 4370.8033138508845, 4402.537733537996, 4415.271480205794, 4432.113577284556, 2738.2059202831356, 2743.7119102493953, 2745.7391547802927, 2746.6978632350424, 2761.751442370156, 4798.2082956311815, 4838.612910967114, 4844.781984810692, 4847.636427267969, 4860.854174374775, 5016.398032236155, 5160.251763494272, 5192.948070519322, 5217.2434996925995, 5231.659942103751, 4806.308467258346, 4839.596517010098, 4875.0, 4877.244027175793, 4883.731394773251, 5135.435102138837, 5151.665141765923, 5151.793928242828, 5158.638895277295, 5159.484051594811, 4892.412910450768, 5010.7387243395015, 5022.221555658879, 5029.346184995927, 5042.420121686053, 4838.903221935471, 4844.214576618529, 4845.781939812788, 4851.126797176542, 4860.930595269035, 3749.4750734896593, 3766.6798322142927, 3767.3030489359558, 3767.547894252707, 3773.603771604052, 4902.534259245366, 5105.693658380509, 5134.589232861287, 5153.433122356463, 5164.225366195101, 4967.25491176312, 4970.502949705001, 4972.905960688643, 4984.22744474607, 4993.226049962262, 4939.110960027229, 4942.950570494393, 4954.727489987941, 4958.528939750718, 4969.925451118163, 4754.263089221176, 4881.731504767272, 4883.316335712932, 4988.301637770643, 5038.14351560243, 4913.0, 4958.479359667183, 5083.652831999597, 5121.564667003347, 5131.717755523333, 5011.897382575828, 5014.373203349582, 5026.271190677258, 5034.119029169808, 5046.596272298134], "value": 3806.7620989464326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4887396838719, 605.3855336833113, 681.4684546054079, 715.4497396557891, 720.6036679826094, 12509.311987840665, 13374.130681505696, 13487.59537213884, 13491.797623035662, 13500.0, 12755.0, 13195.604131876034, 13285.26931018796, 13339.53311634093, 13344.466221351135, 780.3756994404482, 796.9402294827883, 797.2744802229972, 797.2824457987799, 797.3740613618311, 644.6776611694153, 763.4693887748017, 788.207851109634, 792.8929594504725, 794.9324307433875, 826.3719573124439, 828.6726742936537, 828.693383448125, 829.1501211258447, 829.4815740162398, 813.9511629302261, 814.7270664327398, 814.8859159717645, 815.4414226255034, 815.4577206157898, 493.07302271729276, 498.1481666350545, 503.3456506541518, 503.4638110412399, 583.5623282538096, 12666.36668166588, 13143.14569552976, 13151.079424440293, 13151.276679782608, 13204.6698832529, 11915.702107447296, 12076.0, 12513.687157821036, 12523.185992910523, 13559.45762169512, 11791.528338866436, 12012.339321337324, 12064.517419303218, 12069.818952715716, 12105.09211809109, 4141.875743727663, 4163.292240319122, 4239.59723826236, 4373.825046998117, 4378.408914796525, 62403.0, 63545.36454635487, 63832.36167638311, 64202.678986605235, 64569.3543064568, 10736.838947415796, 10782.4069676167, 10826.079783218358, 10977.12183025356, 10980.286281391684, 19775.901120494305, 20300.898495507427, 20445.2844150454, 20474.590508189754, 20487.69268460974, 6751.662416879137, 6773.288804675537, 7075.115610548682, 7076.150861896605, 7467.327940485382, 3658.122050707811, 3787.6023017583307, 3796.430535419709, 3867.4446812652286, 3893.980530097331, 2822.6612806463354, 2898.666653334851, 2910.57796619489, 2910.752586030211, 2914.941701165965, 517.8239398604493, 534.8047962493739, 542.0459990416895, 548.3693752185019, 555.5389027107491, 524.2660275614095, 534.9037173308842, 551.4402881075712, 594.6224147666263, 601.8675891303906, 8130.552819594979, 8180.713675021346, 8299.211574900375, 8371.995360556772, 8519.105493923173, 551.0576913477997, 563.2368141168657, 590.3417689276512, 597.9910301345483, 610.3743662745633, 3875.8643447479203, 3984.6812255019527, 4021.557628660845, 4090.4682391288943, 4111.5477297497255, 102556.48721756492, 110963.0, 113187.0, 115324.42337788257, 115675.0, 93968.53015734878, 94204.0, 95171.0, 95766.52116739372, 96692.51653741686, 80431.19568804355, 83545.0, 83620.58189709013, 84592.57703711442, 85547.57226213954, 7388.445866559922, 7486.326230639051, 7546.811329716581, 7804.2585954334245, 8000.839983200187, 48233.51766482431, 50427.49572504228, 50873.74563127161, 51000.74499627478, 51404.22893656523, 63032.0, 63881.0, 68372.3162768366, 73174.26825731888, 75454.62272688601, 10089.798204036026, 10536.894631053592, 10615.840762388416, 10670.35977841332, 11176.497057632263, 10976.506057227603, 11281.21031527785, 11376.54493820238, 11520.88479115198, 11580.305181689126, 11019.118470522499, 11128.499217535069, 11174.88825111771, 11875.524979000744, 11996.64010079699, 10935.507902144263, 11788.882111178778, 12292.754144916873, 12297.631071067883, 12381.566645167737, 11633.243839150766, 12201.511939522676, 12249.448774804978, 12315.69210769738, 12716.109872308849, 10235.23235757336, 10304.587816487556, 10377.844332335171, 10524.421156836448, 10600.522976466233, 9675.758106047406, 10254.53854576531, 10366.170706343626, 10387.0, 10423.42671153094], "value": 6734.803746518531, "unit": "score"}], "name": "dromaeo_css", "value": 6339.857801073794, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 115.0, 113.0, 113.0, 117.0, 112.0, 115.0, 117.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 121.0, 174.0, 122.0, 123.0, 146.0, 126.0, 164.0, 123.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 124.0, 77.0, 77.0, 75.0, 75.0, 102.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 126.0, 85.0, 85.0, 87.0, 131.0, 86.0, 85.0, 134.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 62.0, 65.0, 63.0, 63.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 78.0, 81.0, 79.0, 78.0, 78.0, 79.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 129.0, 139.0, 128.0, 129.0, 136.0, 129.0, 220.0, 130.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 167.0, 167.0, 164.0, 172.0, 170.0, 165.0, 164.0, 168.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 68.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1532.8999999999999, "alertThreshold": 2.0}]} 16:34:00 INFO - Return code: 0 16:34:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:34:00 INFO - # TBPL SUCCESS # 16:34:00 INFO - Running post-action listener: _resource_record_post_action 16:34:00 INFO - [mozharness: 2016-07-28 23:34:00.757031Z] Finished run-tests step (success) 16:34:00 INFO - Running post-run listener: _resource_record_post_run 16:34:00 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560726016; Read time: 12; Write time: 2242628 16:34:00 INFO - TinderboxPrint: CPU usage
13.1% 16:34:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:34:00 INFO - TinderboxPrint: I/O write bytes / time
560,726,016 / 2,242,628 16:34:00 INFO - TinderboxPrint: CPU idle
8,354.8 (86.9%) 16:34:00 INFO - TinderboxPrint: CPU user
1,199.8 (12.5%) 16:34:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:00 INFO - install - Wall time: 19s; CPU: 20.0%; Read bytes: 0; Write bytes: 264495104; Read time: 0; Write time: 1444740 16:34:00 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 296230912; Read time: 0; Write time: 797888 16:34:01 INFO - Running post-run listener: _upload_blobber_files 16:34:01 INFO - Blob upload gear active. 16:34:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:01 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 16:34:01 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'] 16:34:01 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 16:34:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:34:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:02 INFO - (blobuploader) - INFO - Done attempting. 16:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:06 INFO - (blobuploader) - INFO - Done attempting. 16:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:07 INFO - (blobuploader) - INFO - Done attempting. 16:34:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:07 INFO - Return code: 0 16:34:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3cf07a935a111c133732200093ceabf0d6c3358b92abae99f632ba07ca7dda148725fe139dd142f35d58835cf5e1165a0a7b6b9c839880cdedc99ebe44e2b070", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5a3f2c1217771d2c962c37473c50352d5726f6d7a44867d81fe21421e27cd86166c0b5f5aecf4cbe6dd4b151f03470cf1add77ee3efb30d316ff6245a8c6ec8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b1a35474b179c0b912503fff2c1d8ec240f650dffa9a3caaef6e2263067e7308f22cf99e0fc32f6039978d375e5d3f069c7d20880c62110dd1b5b61a5b8342"} 16:34:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:07 INFO - Contents: 16:34:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3cf07a935a111c133732200093ceabf0d6c3358b92abae99f632ba07ca7dda148725fe139dd142f35d58835cf5e1165a0a7b6b9c839880cdedc99ebe44e2b070", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5a3f2c1217771d2c962c37473c50352d5726f6d7a44867d81fe21421e27cd86166c0b5f5aecf4cbe6dd4b151f03470cf1add77ee3efb30d316ff6245a8c6ec8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b1a35474b179c0b912503fff2c1d8ec240f650dffa9a3caaef6e2263067e7308f22cf99e0fc32f6039978d375e5d3f069c7d20880c62110dd1b5b61a5b8342"} 16:34:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:07 INFO - Copying logs to upload dir... 16:34:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.595165 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-28 16:34:06.971974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:34:06.975469) ========= 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=8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856 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/3cf07a935a111c133732200093ceabf0d6c3358b92abae99f632ba07ca7dda148725fe139dd142f35d58835cf5e1165a0a7b6b9c839880cdedc99ebe44e2b070", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5a3f2c1217771d2c962c37473c50352d5726f6d7a44867d81fe21421e27cd86166c0b5f5aecf4cbe6dd4b151f03470cf1add77ee3efb30d316ff6245a8c6ec8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b1a35474b179c0b912503fff2c1d8ec240f650dffa9a3caaef6e2263067e7308f22cf99e0fc32f6039978d375e5d3f069c7d20880c62110dd1b5b61a5b8342"} build_url:https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/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/3cf07a935a111c133732200093ceabf0d6c3358b92abae99f632ba07ca7dda148725fe139dd142f35d58835cf5e1165a0a7b6b9c839880cdedc99ebe44e2b070", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5a3f2c1217771d2c962c37473c50352d5726f6d7a44867d81fe21421e27cd86166c0b5f5aecf4cbe6dd4b151f03470cf1add77ee3efb30d316ff6245a8c6ec8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b1a35474b179c0b912503fff2c1d8ec240f650dffa9a3caaef6e2263067e7308f22cf99e0fc32f6039978d375e5d3f069c7d20880c62110dd1b5b61a5b8342"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:34:07.002234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:34:07.002623) ========= 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=8783db0840cc980e80bb0bd400000236-1469746645.896597-1977465856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:34:07.086581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:34:07.086999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:34:07.087432) ========= ========= Total master_lag: 0.76 =========