builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1469984700.16 results: success (0) buildid: 20160731084926 builduid: f6ad14077c3d48f4909c7e57e7e23103 revision: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.163255) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.163796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.164141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.219392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.219684) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 10:05:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-07-31 10:05:02 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.382586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.382890) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018128 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.431978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:00.432292) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 --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 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 --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=82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 10:05:02,773 truncating revision to first 12 chars 2016-07-31 10:05:02,773 Setting DEBUG logging. 2016-07-31 10:05:02,773 attempt 1/10 2016-07-31 10:05:02,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4a18b5cacb1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 10:05:03,073 unpacking tar archive at: fx-team-4a18b5cacb1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:01.074720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:01.075098) ========= script_repo_revision: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:01.075492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:01.075755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 10:05:01.084674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-31 10:05:01.085102) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:03 INFO - MultiFileLogger online at 20160731 10:05:03 in /builds/slave/test 10:05:03 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 10:05:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:03 INFO - {'append_to_log': False, 10:05:03 INFO - 'base_work_dir': '/builds/slave/test', 10:05:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:05:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:03 INFO - 'branch': 'Fx-Team-Non-PGO', 10:05:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:03 INFO - 'config_files': ('talos/linux_config.py',), 10:05:03 INFO - 'default_actions': ('clobber', 10:05:03 INFO - 'read-buildbot-config', 10:05:03 INFO - 'download-and-extract', 10:05:03 INFO - 'populate-webroot', 10:05:03 INFO - 'create-virtualenv', 10:05:03 INFO - 'install', 10:05:03 INFO - 'run-tests'), 10:05:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:03 INFO - 'download_minidump_stackwalk': True, 10:05:03 INFO - 'download_symbols': 'ondemand', 10:05:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:03 INFO - 'installer_path': 'installer.exe', 10:05:03 INFO - 'log_level': 'info', 10:05:03 INFO - 'log_name': 'talos', 10:05:03 INFO - 'log_to_console': True, 10:05:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:03 INFO - 'opt_config_files': (), 10:05:03 INFO - 'pip_index': False, 10:05:03 INFO - 'sps_profile': False, 10:05:03 INFO - 'sps_profile_interval': 0, 10:05:03 INFO - 'suite': 'dromaeojs', 10:05:03 INFO - 'system_bits': '32', 10:05:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:03 INFO - 'title': 'talos-linux64-ix-066', 10:05:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:03 INFO - 'use_talos_json': True, 10:05:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:03 INFO - 'work_dir': 'build'} 10:05:03 INFO - [mozharness: 2016-07-31 17:05:03.518641Z] Running clobber step. 10:05:03 INFO - Running pre-action listener: _resource_record_pre_action 10:05:03 INFO - Running main action method: clobber 10:05:03 INFO - rmtree: /builds/slave/test/build 10:05:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:04 INFO - Running post-action listener: _resource_record_post_action 10:05:04 INFO - [mozharness: 2016-07-31 17:05:04.495061Z] Finished clobber step (success) 10:05:04 INFO - [mozharness: 2016-07-31 17:05:04.495163Z] Running read-buildbot-config step. 10:05:04 INFO - Running pre-action listener: _resource_record_pre_action 10:05:04 INFO - Running main action method: read_buildbot_config 10:05:04 INFO - Using buildbot properties: 10:05:04 INFO - { 10:05:04 INFO - "project": "", 10:05:04 INFO - "product": "firefox", 10:05:04 INFO - "script_repo_revision": "production", 10:05:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:05:04 INFO - "repository": "", 10:05:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:05:04 INFO - "buildid": "20160731084926", 10:05:04 INFO - "pgo_build": "False", 10:05:04 INFO - "basedir": "/builds/slave/test", 10:05:04 INFO - "buildnumber": 2053, 10:05:04 INFO - "slavename": "talos-linux64-ix-066", 10:05:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:05:04 INFO - "platform": "ubuntu64_hw", 10:05:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:05:04 INFO - "branch": "fx-team", 10:05:04 INFO - "repo_path": "integration/fx-team", 10:05:04 INFO - "revision": "4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1", 10:05:04 INFO - "stage_platform": "linux64", 10:05:04 INFO - "builduid": "f6ad14077c3d48f4909c7e57e7e23103", 10:05:04 INFO - "slavebuilddir": "test" 10:05:04 INFO - } 10:05:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:05:04 INFO - Running post-action listener: _resource_record_post_action 10:05:04 INFO - [mozharness: 2016-07-31 17:05:04.497651Z] Finished read-buildbot-config step (success) 10:05:04 INFO - [mozharness: 2016-07-31 17:05:04.497743Z] Running download-and-extract step. 10:05:04 INFO - Running pre-action listener: _resource_record_pre_action 10:05:04 INFO - Running main action method: download_and_extract 10:05:04 INFO - mkdir: /builds/slave/test/build/tests 10:05:04 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')]} 10:05:04 INFO - https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:05:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:05:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:05:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:05 INFO - Downloaded 1361 bytes. 10:05:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:05:05 INFO - Using the following test package requirements: 10:05:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'jsshell-linux-x86_64.zip'], 10:05:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:05 INFO - https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:06 INFO - Downloaded 20237575 bytes. 10:05:06 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'] 10:05:06 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 10:05:07 INFO - Return code: 0 10:05:07 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 10:05:07 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')]} 10:05:07 INFO - https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:09 INFO - Downloaded 20237575 bytes. 10:05:09 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'] 10:05:09 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 10:05:10 INFO - Return code: 0 10:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:10 INFO - https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:11 INFO - Downloaded 14413723 bytes. 10:05:11 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'] 10:05:11 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 10:05:11 INFO - Return code: 0 10:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:11 INFO - https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBXpw2AnRmqYOCe63JspGA/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 10:05:12 INFO - Downloaded 55655109 bytes. 10:05:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:12 INFO - mkdir: /builds/slave/test/properties 10:05:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:12 INFO - Contents: 10:05:12 INFO - build_url:https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:13 INFO - Running post-action listener: _resource_record_post_action 10:05:13 INFO - Running post-action listener: set_extra_try_arguments 10:05:13 INFO - [mozharness: 2016-07-31 17:05:13.452713Z] Finished download-and-extract step (success) 10:05:13 INFO - [mozharness: 2016-07-31 17:05:13.452949Z] Running populate-webroot step. 10:05:13 INFO - Running pre-action listener: _resource_record_pre_action 10:05:13 INFO - Running main action method: populate_webroot 10:05:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:13 INFO - '--tppagecycles', 10:05:13 INFO - '7'], 10:05:13 INFO - 'tests': ['tsvgm']}}, 10:05:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['damp', 'tps']}, 10:05:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'tests': ['damp', 'tps']}, 10:05:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['dromaeo_dom']}, 10:05:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['basic_compositor_video']}, 10:05:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['a11yr', 10:05:13 INFO - 'ts_paint', 10:05:13 INFO - 'tpaint', 10:05:13 INFO - 'sessionrestore', 10:05:13 INFO - 'sessionrestore_no_auto_restore', 10:05:13 INFO - 'tabpaint']}, 10:05:13 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:13 INFO - 'ts_paint', 10:05:13 INFO - 'tpaint', 10:05:13 INFO - 'sessionrestore', 10:05:13 INFO - 'sessionrestore_no_auto_restore', 10:05:13 INFO - 'tabpaint']}, 10:05:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:13 INFO - 'ts_paint', 10:05:13 INFO - 'tpaint', 10:05:13 INFO - 'sessionrestore', 10:05:13 INFO - 'sessionrestore_no_auto_restore', 10:05:13 INFO - 'tabpaint']}, 10:05:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:13 INFO - 'ts_paint', 10:05:13 INFO - 'tpaint', 10:05:13 INFO - 'sessionrestore', 10:05:13 INFO - 'sessionrestore_no_auto_restore', 10:05:13 INFO - 'tabpaint']}, 10:05:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['a11yr', 10:05:13 INFO - 'ts_paint', 10:05:13 INFO - 'tpaint', 10:05:13 INFO - 'sessionrestore', 10:05:13 INFO - 'sessionrestore_no_auto_restore', 10:05:13 INFO - 'tabpaint']}, 10:05:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['a11yr', 10:05:13 INFO - 'ts_paint', 10:05:13 INFO - 'tpaint', 10:05:13 INFO - 'sessionrestore', 10:05:13 INFO - 'sessionrestore_no_auto_restore', 10:05:13 INFO - 'tabpaint']}, 10:05:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['tsvgx', 10:05:13 INFO - 'tsvgr_opacity', 10:05:13 INFO - 'tart', 10:05:13 INFO - 'tscrollx', 10:05:13 INFO - 'cart']}, 10:05:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:13 INFO - 'tsvgr_opacity', 10:05:13 INFO - 'tart', 10:05:13 INFO - 'tscrollx', 10:05:13 INFO - 'cart']}, 10:05:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'talos_options': ['--disable-e10s'], 10:05:13 INFO - 'tests': ['tp5o']}, 10:05:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'tests': ['tp5o']}, 10:05:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'talos_options': ['--disable-e10s', 10:05:13 INFO - '--xperf_path', 10:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:13 INFO - 'tests': ['tp5n']}, 10:05:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:13 INFO - 'talos_options': ['--xperf_path', 10:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:13 INFO - 'tests': ['tp5n']}}, 10:05:13 INFO - 'talos.zip': {'path': '', 10:05:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:13 INFO - Running post-action listener: _resource_record_post_action 10:05:13 INFO - [mozharness: 2016-07-31 17:05:13.474217Z] Finished populate-webroot step (success) 10:05:13 INFO - [mozharness: 2016-07-31 17:05:13.474308Z] Running create-virtualenv step. 10:05:13 INFO - Running pre-action listener: _resource_record_pre_action 10:05:13 INFO - Running main action method: create_virtualenv 10:05:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:13 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 10:05:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:13 INFO - Using real prefix '/usr' 10:05:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:16 INFO - Installing pip.................done. 10:05:16 INFO - Return code: 0 10:05:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:16 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')]} 10:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 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')]} 10:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:16 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 10:05:16 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 10:05:16 INFO - Using env: {'DISPLAY': ':0', 10:05:16 INFO - 'HOME': '/home/cltbld', 10:05:16 INFO - 'LANG': 'en_US.UTF-8', 10:05:16 INFO - 'LANGUAGE': 'en_US:en', 10:05:16 INFO - 'LOGNAME': 'cltbld', 10:05:16 INFO - 'MAIL': '/var/mail/cltbld', 10:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:16 INFO - 'MOZ_NO_REMOTE': '1', 10:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:16 INFO - 'NO_EM_RESTART': '1', 10:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:16 INFO - 'PWD': '/builds/slave/test', 10:05:16 INFO - 'SHELL': '/bin/bash', 10:05:16 INFO - 'SHLVL': '1', 10:05:16 INFO - 'TERM': 'linux', 10:05:16 INFO - 'TMOUT': '86400', 10:05:16 INFO - 'USER': 'cltbld', 10:05:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:16 INFO - '_': '/tools/buildbot/bin/python'} 10:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:16 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 10:05:16 INFO - Cleaning up... 10:05:16 INFO - Return code: 0 10:05:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:16 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')]} 10:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 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')]} 10:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:16 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 10:05:16 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 10:05:16 INFO - Using env: {'DISPLAY': ':0', 10:05:16 INFO - 'HOME': '/home/cltbld', 10:05:16 INFO - 'LANG': 'en_US.UTF-8', 10:05:16 INFO - 'LANGUAGE': 'en_US:en', 10:05:16 INFO - 'LOGNAME': 'cltbld', 10:05:16 INFO - 'MAIL': '/var/mail/cltbld', 10:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:16 INFO - 'MOZ_NO_REMOTE': '1', 10:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:16 INFO - 'NO_EM_RESTART': '1', 10:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:16 INFO - 'PWD': '/builds/slave/test', 10:05:16 INFO - 'SHELL': '/bin/bash', 10:05:16 INFO - 'SHLVL': '1', 10:05:16 INFO - 'TERM': 'linux', 10:05:16 INFO - 'TMOUT': '86400', 10:05:16 INFO - 'USER': 'cltbld', 10:05:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:16 INFO - '_': '/tools/buildbot/bin/python'} 10:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:16 INFO - Downloading/unpacking psutil>=3.1.1 10:05:16 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 10:05:16 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 10:05:16 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 10:05:16 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 10:05:16 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 10:05:16 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 10:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:18 INFO - Installing collected packages: psutil 10:05:18 INFO - Running setup.py install for psutil 10:05:18 INFO - building 'psutil._psutil_linux' extension 10:05:18 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 10:05:18 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 10:05:18 INFO - building 'psutil._psutil_posix' extension 10:05:18 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 10:05:18 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 10:05:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:19 INFO - Successfully installed psutil 10:05:19 INFO - Cleaning up... 10:05:19 INFO - Return code: 0 10:05:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:05:19 INFO - Using env: {'DISPLAY': ':0', 10:05:19 INFO - 'HOME': '/home/cltbld', 10:05:19 INFO - 'LANG': 'en_US.UTF-8', 10:05:19 INFO - 'LANGUAGE': 'en_US:en', 10:05:19 INFO - 'LOGNAME': 'cltbld', 10:05:19 INFO - 'MAIL': '/var/mail/cltbld', 10:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:19 INFO - 'MOZ_NO_REMOTE': '1', 10:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:19 INFO - 'NO_EM_RESTART': '1', 10:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:19 INFO - 'PWD': '/builds/slave/test', 10:05:19 INFO - 'SHELL': '/bin/bash', 10:05:19 INFO - 'SHLVL': '1', 10:05:19 INFO - 'TERM': 'linux', 10:05:19 INFO - 'TMOUT': '86400', 10:05:19 INFO - 'USER': 'cltbld', 10:05:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:19 INFO - '_': '/tools/buildbot/bin/python'} 10:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:21 INFO - Installing collected packages: mozsystemmonitor 10:05:21 INFO - Running setup.py install for mozsystemmonitor 10:05:21 INFO - Successfully installed mozsystemmonitor 10:05:21 INFO - Cleaning up... 10:05:21 INFO - Return code: 0 10:05:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:05:21 INFO - Using env: {'DISPLAY': ':0', 10:05:21 INFO - 'HOME': '/home/cltbld', 10:05:21 INFO - 'LANG': 'en_US.UTF-8', 10:05:21 INFO - 'LANGUAGE': 'en_US:en', 10:05:21 INFO - 'LOGNAME': 'cltbld', 10:05:21 INFO - 'MAIL': '/var/mail/cltbld', 10:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:21 INFO - 'MOZ_NO_REMOTE': '1', 10:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:21 INFO - 'NO_EM_RESTART': '1', 10:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:21 INFO - 'PWD': '/builds/slave/test', 10:05:21 INFO - 'SHELL': '/bin/bash', 10:05:21 INFO - 'SHLVL': '1', 10:05:21 INFO - 'TERM': 'linux', 10:05:21 INFO - 'TMOUT': '86400', 10:05:21 INFO - 'USER': 'cltbld', 10:05:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:21 INFO - '_': '/tools/buildbot/bin/python'} 10:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:21 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:21 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 10:05:21 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 10:05:21 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 10:05:21 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 10:05:21 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 10:05:21 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 10:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:23 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 10:05:23 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 10:05:23 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 10:05:23 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 10:05:23 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 10:05:23 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 10:05:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:23 INFO - warning: no files found matching '*.txt' 10:05:23 INFO - no previously-included directories found matching 'build' 10:05:23 INFO - no previously-included directories found matching 'dist' 10:05:23 INFO - no previously-included directories found matching '.git*' 10:05:23 INFO - Installing collected packages: jsonschema, functools32 10:05:23 INFO - Running setup.py install for functools32 10:05:24 INFO - warning: no files found matching '*.txt' 10:05:24 INFO - no previously-included directories found matching 'build' 10:05:24 INFO - no previously-included directories found matching 'dist' 10:05:24 INFO - no previously-included directories found matching '.git*' 10:05:24 INFO - Successfully installed jsonschema functools32 10:05:24 INFO - Cleaning up... 10:05:24 INFO - Return code: 0 10:05:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:24 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')]} 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:24 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')]} 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:24 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:24 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 10:05:24 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 10:05:24 INFO - Using env: {'DISPLAY': ':0', 10:05:24 INFO - 'HOME': '/home/cltbld', 10:05:24 INFO - 'LANG': 'en_US.UTF-8', 10:05:24 INFO - 'LANGUAGE': 'en_US:en', 10:05:24 INFO - 'LOGNAME': 'cltbld', 10:05:24 INFO - 'MAIL': '/var/mail/cltbld', 10:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:24 INFO - 'MOZ_NO_REMOTE': '1', 10:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:24 INFO - 'NO_EM_RESTART': '1', 10:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:24 INFO - 'PWD': '/builds/slave/test', 10:05:24 INFO - 'SHELL': '/bin/bash', 10:05:24 INFO - 'SHLVL': '1', 10:05:24 INFO - 'TERM': 'linux', 10:05:24 INFO - 'TMOUT': '86400', 10:05:24 INFO - 'USER': 'cltbld', 10:05:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:24 INFO - '_': '/tools/buildbot/bin/python'} 10:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:24 INFO - Cleaning up... 10:05:24 INFO - Return code: 0 10:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:24 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')]} 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:24 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')]} 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:24 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:24 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 10:05:24 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 10:05:24 INFO - Using env: {'DISPLAY': ':0', 10:05:24 INFO - 'HOME': '/home/cltbld', 10:05:24 INFO - 'LANG': 'en_US.UTF-8', 10:05:24 INFO - 'LANGUAGE': 'en_US:en', 10:05:24 INFO - 'LOGNAME': 'cltbld', 10:05:24 INFO - 'MAIL': '/var/mail/cltbld', 10:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:24 INFO - 'MOZ_NO_REMOTE': '1', 10:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:24 INFO - 'NO_EM_RESTART': '1', 10:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:24 INFO - 'PWD': '/builds/slave/test', 10:05:24 INFO - 'SHELL': '/bin/bash', 10:05:24 INFO - 'SHLVL': '1', 10:05:24 INFO - 'TERM': 'linux', 10:05:24 INFO - 'TMOUT': '86400', 10:05:24 INFO - 'USER': 'cltbld', 10:05:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:24 INFO - '_': '/tools/buildbot/bin/python'} 10:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:26 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 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 10:05:26 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 10:05:27 INFO - Downloading docopt-0.6.1.tar.gz 10:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:27 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:27 INFO - Running setup.py install for blobuploader 10:05:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:27 INFO - Running setup.py install for requests 10:05:27 INFO - Running setup.py install for docopt 10:05:27 INFO - Successfully installed blobuploader requests docopt 10:05:27 INFO - Cleaning up... 10:05:27 INFO - Return code: 0 10:05:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:27 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')]} 10:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:27 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')]} 10:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:27 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:27 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 10:05:27 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 10:05:27 INFO - Using env: {'DISPLAY': ':0', 10:05:27 INFO - 'HOME': '/home/cltbld', 10:05:27 INFO - 'LANG': 'en_US.UTF-8', 10:05:27 INFO - 'LANGUAGE': 'en_US:en', 10:05:27 INFO - 'LOGNAME': 'cltbld', 10:05:27 INFO - 'MAIL': '/var/mail/cltbld', 10:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:27 INFO - 'MOZ_NO_REMOTE': '1', 10:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:27 INFO - 'NO_EM_RESTART': '1', 10:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:27 INFO - 'PWD': '/builds/slave/test', 10:05:27 INFO - 'SHELL': '/bin/bash', 10:05:27 INFO - 'SHLVL': '1', 10:05:27 INFO - 'TERM': 'linux', 10:05:27 INFO - 'TMOUT': '86400', 10:05:27 INFO - 'USER': 'cltbld', 10:05:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:27 INFO - '_': '/tools/buildbot/bin/python'} 10:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:28 INFO - Running setup.py (path:/tmp/pip-oTsfh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:28 INFO - Running setup.py (path:/tmp/pip-b1iobK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:28 INFO - Running setup.py (path:/tmp/pip-1PWUMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:28 INFO - Running setup.py (path:/tmp/pip-FzaqBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:28 INFO - Running setup.py (path:/tmp/pip-LiWaJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:28 INFO - Running setup.py (path:/tmp/pip-iUPjrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:28 INFO - Running setup.py (path:/tmp/pip-rRY6ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:28 INFO - Running setup.py (path:/tmp/pip-wSUNGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:28 INFO - Running setup.py (path:/tmp/pip-0eF0uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:28 INFO - Running setup.py (path:/tmp/pip-btio1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:28 INFO - Running setup.py (path:/tmp/pip-vuII29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:28 INFO - Running setup.py (path:/tmp/pip-qPHKSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:28 INFO - Running setup.py (path:/tmp/pip-CA8rmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:28 INFO - Running setup.py (path:/tmp/pip-4csHtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:29 INFO - Running setup.py (path:/tmp/pip-TtF2RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:29 INFO - Running setup.py (path:/tmp/pip-Hs99va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:29 INFO - Running setup.py (path:/tmp/pip-GoBJm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:29 INFO - Running setup.py install for manifestparser 10:05:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:29 INFO - Running setup.py install for mozcrash 10:05:29 INFO - Running setup.py install for mozdebug 10:05:29 INFO - Running setup.py install for mozdevice 10:05:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:29 INFO - Running setup.py install for mozfile 10:05:29 INFO - Running setup.py install for mozhttpd 10:05:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:29 INFO - Running setup.py install for mozinfo 10:05:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:29 INFO - Running setup.py install for mozInstall 10:05:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Running setup.py install for mozleak 10:05:30 INFO - Running setup.py install for mozlog 10:05:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Running setup.py install for moznetwork 10:05:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Running setup.py install for mozprocess 10:05:30 INFO - Running setup.py install for mozprofile 10:05:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Running setup.py install for mozrunner 10:05:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:30 INFO - Running setup.py install for mozscreenshot 10:05:30 INFO - Running setup.py install for moztest 10:05:30 INFO - Running setup.py install for mozversion 10:05:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:31 INFO - Cleaning up... 10:05:31 INFO - Return code: 0 10:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:31 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:31 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 10:05:31 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 10:05:31 INFO - Using env: {'DISPLAY': ':0', 10:05:31 INFO - 'HOME': '/home/cltbld', 10:05:31 INFO - 'LANG': 'en_US.UTF-8', 10:05:31 INFO - 'LANGUAGE': 'en_US:en', 10:05:31 INFO - 'LOGNAME': 'cltbld', 10:05:31 INFO - 'MAIL': '/var/mail/cltbld', 10:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:31 INFO - 'MOZ_NO_REMOTE': '1', 10:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:31 INFO - 'NO_EM_RESTART': '1', 10:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:31 INFO - 'PWD': '/builds/slave/test', 10:05:31 INFO - 'SHELL': '/bin/bash', 10:05:31 INFO - 'SHLVL': '1', 10:05:31 INFO - 'TERM': 'linux', 10:05:31 INFO - 'TMOUT': '86400', 10:05:31 INFO - 'USER': 'cltbld', 10:05:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:31 INFO - '_': '/tools/buildbot/bin/python'} 10:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:31 INFO - Running setup.py (path:/tmp/pip-ZKMjJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:31 INFO - Running setup.py (path:/tmp/pip-gT8vFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:31 INFO - Running setup.py (path:/tmp/pip-s2gYyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:31 INFO - Running setup.py (path:/tmp/pip-Q92Zpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:31 INFO - Running setup.py (path:/tmp/pip-EHH0BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:31 INFO - Running setup.py (path:/tmp/pip-G5BpMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:31 INFO - Running setup.py (path:/tmp/pip-YKPnXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:31 INFO - Running setup.py (path:/tmp/pip-HNnGZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:31 INFO - Running setup.py (path:/tmp/pip-KxR5bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:31 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)) 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:31 INFO - Running setup.py (path:/tmp/pip-WT9EwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:32 INFO - Running setup.py (path:/tmp/pip-Et7mhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:32 INFO - Running setup.py (path:/tmp/pip-asmv_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:32 INFO - Running setup.py (path:/tmp/pip-v5DwjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:32 INFO - Running setup.py (path:/tmp/pip-eirH8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:32 INFO - Running setup.py (path:/tmp/pip-xfyZVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:32 INFO - Running setup.py (path:/tmp/pip-L5QIH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:32 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)) 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:32 INFO - Running setup.py (path:/tmp/pip-O1xO3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:32 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)) 10:05:32 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)) 10:05:32 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)) 10:05:32 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)) 10:05:32 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)) 10:05:32 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)) 10:05:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:32 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 10:05:32 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 10:05:32 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 10:05:32 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 10:05:32 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 10:05:32 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 10:05:34 INFO - Downloading blessings-1.6.tar.gz 10:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:34 INFO - Installing collected packages: blessings 10:05:34 INFO - Running setup.py install for blessings 10:05:34 INFO - Successfully installed blessings 10:05:34 INFO - Cleaning up... 10:05:34 INFO - Return code: 0 10:05:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:34 INFO - Reading from file tmpfile_stdout 10:05:34 INFO - Current package versions: 10:05:34 INFO - argparse == 1.2.1 10:05:34 INFO - blessings == 1.6 10:05:34 INFO - blobuploader == 1.2.4 10:05:34 INFO - docopt == 0.6.1 10:05:34 INFO - functools32 == 3.2.3-2 10:05:34 INFO - jsonschema == 2.5.1 10:05:34 INFO - manifestparser == 1.1 10:05:34 INFO - mozInstall == 1.12 10:05:34 INFO - mozcrash == 0.17 10:05:34 INFO - mozdebug == 0.1 10:05:34 INFO - mozdevice == 0.48 10:05:34 INFO - mozfile == 1.2 10:05:34 INFO - mozhttpd == 0.7 10:05:34 INFO - mozinfo == 0.9 10:05:34 INFO - mozleak == 0.1 10:05:34 INFO - mozlog == 3.3 10:05:34 INFO - moznetwork == 0.27 10:05:34 INFO - mozprocess == 0.23 10:05:34 INFO - mozprofile == 0.28 10:05:34 INFO - mozrunner == 6.12 10:05:34 INFO - mozscreenshot == 0.1 10:05:34 INFO - mozsystemmonitor == 0.3 10:05:34 INFO - moztest == 0.7 10:05:34 INFO - mozversion == 1.4 10:05:34 INFO - psutil == 3.1.1 10:05:34 INFO - requests == 1.2.3 10:05:34 INFO - wsgiref == 0.1.2 10:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:34 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')]} 10:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:34 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')]} 10:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:34 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:34 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 10:05:34 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 10:05:34 INFO - Using env: {'DISPLAY': ':0', 10:05:34 INFO - 'HOME': '/home/cltbld', 10:05:34 INFO - 'LANG': 'en_US.UTF-8', 10:05:34 INFO - 'LANGUAGE': 'en_US:en', 10:05:34 INFO - 'LOGNAME': 'cltbld', 10:05:34 INFO - 'MAIL': '/var/mail/cltbld', 10:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:34 INFO - 'MOZ_NO_REMOTE': '1', 10:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:34 INFO - 'NO_EM_RESTART': '1', 10:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:34 INFO - 'PWD': '/builds/slave/test', 10:05:34 INFO - 'SHELL': '/bin/bash', 10:05:34 INFO - 'SHLVL': '1', 10:05:34 INFO - 'TERM': 'linux', 10:05:34 INFO - 'TMOUT': '86400', 10:05:34 INFO - 'USER': 'cltbld', 10:05:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:34 INFO - '_': '/tools/buildbot/bin/python'} 10:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 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)) 10:05:35 INFO - Cleaning up... 10:05:35 INFO - Return code: 0 10:05:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 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 0x1ee9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', '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 10:05:35 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 10:05:35 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 10:05:35 INFO - Using env: {'DISPLAY': ':0', 10:05:35 INFO - 'HOME': '/home/cltbld', 10:05:35 INFO - 'LANG': 'en_US.UTF-8', 10:05:35 INFO - 'LANGUAGE': 'en_US:en', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MAIL': '/var/mail/cltbld', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SHLVL': '1', 10:05:35 INFO - 'TERM': 'linux', 10:05:35 INFO - 'TMOUT': '86400', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:35 INFO - '_': '/tools/buildbot/bin/python'} 10:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:05:35 INFO - Cleaning up... 10:05:35 INFO - Return code: 0 10:05:35 INFO - Running post-action listener: _resource_record_post_action 10:05:35 INFO - Running post-action listener: _start_resource_monitoring 10:05:35 INFO - Starting resource monitoring. 10:05:35 INFO - [mozharness: 2016-07-31 17:05:35.379750Z] Finished create-virtualenv step (success) 10:05:35 INFO - [mozharness: 2016-07-31 17:05:35.380185Z] Running install step. 10:05:35 INFO - Running pre-action listener: _resource_record_pre_action 10:05:35 INFO - Running main action method: install 10:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:35 INFO - Reading from file tmpfile_stdout 10:05:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:35 INFO - Reading from file tmpfile_stdout 10:05:35 INFO - Output received: 10:05:35 INFO - Usage: mozinstall [options] installer 10:05:35 INFO - Options: 10:05:35 INFO - -h, --help show this help message and exit 10:05:35 INFO - -d DEST, --destination=DEST 10:05:35 INFO - Directory to install application into. [default: 10:05:35 INFO - "/builds/slave/test"] 10:05:35 INFO - --app=APP Application being installed. [default: firefox] 10:05:35 INFO - mkdir: /builds/slave/test/build/application 10:05:35 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'] 10:05:35 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 10:05:51 INFO - Reading from file tmpfile_stdout 10:05:51 INFO - Output received: 10:05:51 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:51 INFO - Running post-action listener: _resource_record_post_action 10:05:51 INFO - [mozharness: 2016-07-31 17:05:51.729863Z] Finished install step (success) 10:05:51 INFO - [mozharness: 2016-07-31 17:05:51.730149Z] Running run-tests step. 10:05:51 INFO - Running pre-action listener: _resource_record_pre_action 10:05:51 INFO - Running main action method: run_tests 10:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:51 INFO - Python 2.7.3 10:05:51 INFO - Return code: 0 10:05:51 INFO - grabbing minidump binary from tooltool 10:05: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')]} 10:05:51 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 0x21a83b0>, '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 0x21a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:51 INFO - Return code: 0 10:05:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:51 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/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:05:51 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/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:05:51 INFO - Using env: {'DISPLAY': ':0', 10:05:51 INFO - 'HOME': '/home/cltbld', 10:05:51 INFO - 'LANG': 'en_US.UTF-8', 10:05:51 INFO - 'LANGUAGE': 'en_US:en', 10:05:51 INFO - 'LOGNAME': 'cltbld', 10:05:51 INFO - 'MAIL': '/var/mail/cltbld', 10:05:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:51 INFO - 'MOZ_NO_REMOTE': '1', 10:05:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:51 INFO - 'NO_EM_RESTART': '1', 10:05:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:51 INFO - 'PWD': '/builds/slave/test', 10:05:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:51 INFO - 'SHELL': '/bin/bash', 10:05:51 INFO - 'SHLVL': '1', 10:05:51 INFO - 'TERM': 'linux', 10:05:51 INFO - 'TMOUT': '86400', 10:05:51 INFO - 'USER': 'cltbld', 10:05:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778', 10:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:51 INFO - '_': '/tools/buildbot/bin/python'} 10:05:51 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/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:05:51 INFO - mozversion application_buildid: 20160731084926 10:05:51 INFO - mozversion application_changeset: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 10:05:51 INFO - mozversion application_display_name: Nightly 10:05:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:51 INFO - mozversion application_name: Firefox 10:05:51 INFO - mozversion application_remotingname: firefox 10:05:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:05:51 INFO - mozversion application_vendor: Mozilla 10:05:51 INFO - mozversion application_version: 50.0a1 10:05:51 INFO - mozversion platform_buildid: 20160731084926 10:05:51 INFO - mozversion platform_changeset: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 10:05:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:05:51 INFO - mozversion platform_version: 50.0a1 10:05:51 INFO - using testdate: 1469984751 10:05:51 INFO - actual date: 1469984751 10:05:51 INFO - starting webserver on 'localhost:38783' 10:05:52 INFO - SUITE-START | Running 2 tests 10:05:52 INFO - TEST-START | dromaeo_css 10:05:52 INFO - operating with platform_type : linux_ 10:05:52 INFO - Initialising browser for dromaeo_css test... 10:05:52 INFO - TEST-INFO | started process 24859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphu_2uV/profile http://localhost:38783/getInfo.html) 10:05:56 INFO - PROCESS | 24859 | __metrics Screen width/height:1600/1200 10:05:56 INFO - PROCESS | 24859 | colorDepth:24 10:05:56 INFO - PROCESS | 24859 | Browser inner width/height: 1024/697 10:05:56 INFO - PROCESS | 24859 | __metrics 10:05:57 INFO - PROCESS | 24859 | 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" 10:05:57 INFO - PROCESS | 24859 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:57 INFO - PROCESS | 24859 | console.error: PushService: 10:05:57 INFO - PROCESS | 24859 | stateChangeProcessEnqueue: Error transitioning state 10:05:57 INFO - PROCESS | 24859 | UnknownError 10:05:58 INFO - TEST-INFO | 24859: exit 0 10:05:58 INFO - Browser initialized. 10:05:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:58 INFO - TEST-INFO | started process 24937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphu_2uV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:10 INFO - PROCESS | 24937 | RSS: Main: 157667328 10:06:10 INFO - PROCESS | 24937 | 10:07:02 INFO - PROCESS | 24937 | 1469984822248 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] 10:09:14 INFO - PROCESS | 24937 | Cycle 1(1): loaded http://localhost:38783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38783/tests/dromaeo/cssquery-ext.html) 10:09:15 INFO - PROCESS | 24937 | RSS: Main: 245211136 10:09:15 INFO - PROCESS | 24937 | 10:12:18 INFO - PROCESS | 24937 | Cycle 1(1): loaded http://localhost:38783/tests/dromaeo/cssquery-ext.html (next: http://localhost:38783/tests/dromaeo/cssquery-jquery.html) 10:12:18 INFO - PROCESS | 24937 | RSS: Main: 241840128 10:12:18 INFO - PROCESS | 24937 | 10:15:21 INFO - PROCESS | 24937 | Cycle 1(1): loaded http://localhost:38783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38783/tests/dromaeo/cssquery-mootools.html) 10:15:21 INFO - PROCESS | 24937 | RSS: Main: 215183360 10:15:21 INFO - PROCESS | 24937 | 10:18:23 INFO - PROCESS | 24937 | Cycle 1(1): loaded http://localhost:38783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38783/tests/dromaeo/cssquery-prototype.html) 10:18:24 INFO - PROCESS | 24937 | RSS: Main: 214233088 10:18:24 INFO - PROCESS | 24937 | 10:21:27 INFO - PROCESS | 24937 | Cycle 1(1): loaded http://localhost:38783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38783/tests/dromaeo/cssquery-yui.html) 10:21:28 INFO - PROCESS | 24937 | RSS: Main: 188518400 10:21:28 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | Cycle 1(1): loaded http://localhost:38783/tests/dromaeo/cssquery-yui.html (next: http://localhost:38783/tests/dromaeo/cssquery-dojo.html) 10:24:31 INFO - PROCESS | 24937 | RSS: Main: 280920064 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | __start_tp_report 10:24:31 INFO - PROCESS | 24937 | _x_x_mozilla_page_load 10:24:31 INFO - PROCESS | 24937 | _x_x_mozilla_page_load_details 10:24:31 INFO - PROCESS | 24937 | |i|pagename|runs| 10:24:31 INFO - PROCESS | 24937 | |0;dojo.html;2644.9471010579778;2657.6677915260593;2704.445588654326;2705.8782354794034;2711.4305995740892;4651.930221046687;4700.083483720676;4734.43186817582;4831.25115607081;4858.902821943559;4715.78778954947;4718.811247550102;4776.832810851621;4779.426468823746;4780.30685550595;4302.290122129845;4318.5033721122;4372.890677733066;4429.224885645015;4502.909941801162;4424.225760491917;4452.510223875387;4480.059187570614;4499.370088187657;4501.504834468205;4281.850135245251;4321.891952701176;4437.5340589237985;4452.5992660660695;4529.456465224178;4358.4987726411555;4380.2772542530765;4384.079343337903;4415.933760993587;4421.668374871898;4350.7607081610495;4370.344448332744;4397.054633253833;4411.404460397837;4442.444694413199;4811.855644330641;4835.08133454646;4840.564349208553;4844.176489996709;4847.806087756486;4931.654784165074;4979.128652485801;5068.26510156029;5072.5434710875825;5148.819791307286;5076.492350764931;5090.414602320743;5108.923366149511;5149.150390185615;5153.3558305211845;4664.883377915579;4821.975890120527;4830;4831.106245344622;4835.419749630067;5214.895702085937;5278.155495120763;5291.814786482455;5335.653182543122;5364.302640656768;5067.391912970467;5134.229865520202;5137.6660517066275;5141.5886729061585;5144.151215049475;4972.726500042532;5212.166053431432;5216.295800066942;5228.241904923841;5231.790728370823;4970.353853998957;4976.477469865685;5030.698158110525;5043.218301163325;5126.15418455958;5058.418281897555;5062.569681577033;5063.139266324733;5067.771950262247;5113.64204505681;4389.517153113155;4391.802368893407;4398.516163222043;4405.691601587922;4453.4433195850515;3702.0374702577524;3738.4392341149046;3759.680427163667;3812.066043819282;3857.324968130622;4394.428724265825;4405.823767049346;4412.514623391425;4441.755703436342;4450.421445212167;5136.653236210683;5146.202338637442;5147.6654017488745;5148.253503242009;5196.76614552346;4295.355696645528;4324.113556720865;4342.261815491374;4373.016071383913;4396.032872767986;4632.281996290513;4642.117997580449;4654.25531914892;4691.014886873726;4698.765061746967;4790.688605240718;4800.087983283235;4804.399450068741;4805.447373552086;4813.350197723403;4971.229459433794;5074.391073071255;5093.930274642366;5130.948690513047;5137.280780690631;4824.0834241494;4850.7817148227705;4857.125717370907;4882.92675609859;4898.9020219594695;5037.992401519784;5057.494250574913;5058.1401161803315;5062.519060689228;5063.088644044107;4946.752662366939;4983.277424773315;5019.3976722793495;5041.117804384291;5166.3800343958965;4928.482509336468;4932.062908047459;4943.505649435172;4947.579455746302;4963.677360971526;4932.975335123301;4936.333594964633;4940.308356830118;4948.950510494993;4973.278874563241;4761.309610106585;4873.926891096566;4907.607391408607;4924.72913989734;4928.063667903087;5063.721495317793;5064.215046667772;5065.062963351792;5068.695878247317;5075.1625981712605;4962.032403681247;4963.454020057863;4964.280179374043;4967.230079337708;4998.225275082368 10:24:31 INFO - PROCESS | 24937 | |1;ext.html;570.8030729398358;575.1229375202817;582.9883402331953;583.2942140010592;584.777784441912;28033;38378.232435351274;39561.60438395615;39580.604193958054;43121.56878431215;39352.80323598378;39539.40690889639;39571.60428395715;39650.8017459913;39656.405153922715;7740.109887362969;7865.213478652117;7867.252611001974;7871.055473343207;7872.5670088145125;7721.9227807722045;7810.804729881742;7813.492123011986;7815.218478152167;7815.843683126334;7822.882656760153;7869.370450363986;7872.09470910844;7880.527168369917;7889.368850491946;7809.336206422461;7832.099308579529;7835.6473958671995;7837.255460731221;7852.450328477009;7728.497647652885;7803.609819509059;7806.921930780733;7809.219078092202;7823.804404889924;36618.267634647156;36846.63153368486;37015;37032.62967370346;37123.25753484915;2932.8973485928104;3287.211069343364;3539.1682954505673;3609.693176080036;3699.72252081095;28944.27639309013;29061.564076538867;29068;29152.708472915212;30464.69535304663;3313.204830840605;3407.335569563936;3412.6416726243633;3418.5897692276835;3503.7722548034553;246650.9999999982;247040;247115;247910;249167;32015.679843201735;50051;50449.747751261006;50458.49541504611;50620.49379506158;33231;33342.99913007841;33392.332153356794;33428.832855835564;33437.665623343455;13179.538716144889;13299.20204787716;13302.866971330162;13303.13529620591;13317.933410332886;10646.520906559223;10665.306755060896;10700.357978521313;10713.678589642323;10747.570097196181;7735.3424958878;7751.534907905544;7830.33442157423;7860.528368297921;7890.64492097857;3006.503926852045;3054.129573071664;3063.846807659608;3074.8001379910233;3081.198888289016;803.3412601666578;839.9832003359899;901.3870568013682;942.1104467812033;956.8756061712072;27183;27738.306542336602;28152.87388504437;28155.859220704177;28684.42631147407;923.3905622289257;930.3022732950287;938.5072836760755;975.4878688688353;1057.376148072641;14288.285585720672;14827.184504852337;15097.245137743288;15149.924250378897;15261.084334939938;414344;418891;418942;419490;420661;48200.51799482031;48774.51225487771;48776.512234877904;48887.5111248883;48889.511104888494;1150.79285728568;1163.057923082306;1190.3572071081692;1194.8267501212276;1201.9218750781347;24586.262412127664;26970.460590787683;27105.457890842466;28100.71899280981;28104.156875293775;42345.576544235395;42562.78718606511;42615;42683.786581066895;42735.572644274405;311055;312723;312762;312973;313138;24607.507849842546;25055.373615659755;25075.74924250734;25097.24708258755;25102;46229.30656040229;46703.06593868171;47209;48389.758051209516;48394.758026209645;35411.82294088513;35491.82254088713;36001.63998359983;36730.081747956516;36973.63026369702;36434.11239430317;36462.27075458423;36821.63178368289;37041.81479092587;37721;27935.44129117447;30738.231544211572;35685.821570893015;36601.63398366089;38877;30864.845675772376;31911.68088319087;33485;33647.831760841036;33651;25828.83692301574;25912.74087259179;26256.868715657063;26536.601950971137;26636.20091397261 10:24:31 INFO - PROCESS | 24937 | |2;jquery.html;355.89145310680243;356.07420706163975;362.8639260277394;367.845504887947;383.19911385204915;16070.919645401771;16976.405825796082;17026.489205323844;17151.656966860653;17153.74269385957;16578;16886.57783555412;17407.390741324056;17557.82442175581;17559.122043897816;4894.3147959285725;5130.692158470485;5132.435432102466;5133.230015497668;5136.8972620547565;3783.754055986366;3957.267905437489;5096.872578185556;5672.631278966875;6008;6003.279606447232;6124.050772130327;6129.448349648531;6134.049222370518;6134.355892631276;5824.398290470112;5924.644521328691;5929.73316200772;5934.465898069173;5939.70301484924;5136.794528218867;5229.058769421503;5244.423113457517;5245.714799874017;5246;21481.35555933309;22032;22141.335759927228;22359;23294.184703535295;2190.58378908007;2191.495955930145;2417.9240238094053;2581.8838152283192;2638.4723055389;14131.434742610283;14540.70918581633;14569.125852448888;15493.690126197525;15701.842981570153;1816.727490876366;1873.840723538501;1910.0831600831539;1942.3881477334594;1967.9704804427945;82448;82469;83616;83716.99999999939;84497;8324.375671824637;8568.386642074103;8726.04013558508;8817.382783205243;14840.703185936221;11497.080233581293;11536.711582210344;11545.36500492481;11553.768924621629;11560.190786644855;7067.717291308393;7135.143782746104;7211.7836464905085;7212.891806622905;7265.9273407265255;6831.521793474509;6839.563691624815;7049.154101507852;7098.751543695946;7265.963670181721;3633.9636603633626;3659.3596120678776;3678.2275722098125;3724.385476396364;3747.7001839852746;1676.6981943250332;1704.1223769758585;1736.3488691740597;1789.5640370488693;1817.4365946556609;807.3662175192563;820.6799348254185;830.5224495914873;839.3243439031638;960.0879164793474;16099.919500402422;16114.677706445806;16504.17479126039;17737.645247094984;17799;831.2809419851785;880.7269746378643;895.6596493332491;912.1972664055588;937.4843835890233;9169.266458683289;9859.112679858703;9869.358491698016;9876.901230987598;9900.60397584103;389309;390277;390901;392173;401942;74860;76930;79647;80394.19605803984;82044.58977705192;812.0864027968536;835.8924425136597;872.4634349874908;891.0866361978893;894.3873446689039;15453.84546154569;15474.381024759334;15891.695704123069;16179.75730364022;16491.422800201934;37854.62145378511;37867.431988519646;38033.088327145764;38047.619523805515;39612;49832;50283.24575131449;50499.49500504948;53044.73477632587;53971.73014134904;6084.14821924922;6560.212774467094;6811.65941702903;7103.573785572882;7631.1605723371495;10196.847047294148;10522.1056210223;11127.777444451227;11160.553577856796;11620.070394368262;6475.579087359307;9582.952085239529;10138.543765530421;10169.237307201842;10589.9470502647;6924.757633482804;6957.582545047313;7045.2954704531185;7084.610346430995;7185.497015208885;7123.501354905107;7314.012608297811;7462.5149365293255;7540.283673051052;7770.067591889009;10588.894111059099;10612.681619551426;10682.519286632276;10773.353598784099;11119.44402779874;10048.346857454535;10579.471026448493;10608.204384671335;10628.89371106279;10879.51042203087 10:24:31 INFO - PROCESS | 24937 | |3;mootools.html;1321.7951217561279;1351.5539871842293;1371.3691701817163;1596.590231689386;1602.751573506107;7152.0702308699865;7804.141544430108;7807.102183248928;7810.258025487584;7815.960920195391;6435.485161187105;6611.305812889649;6612.404883560491;6783.9321606783915;7607.885881711779;1849.3897013985386;2085.7392825896763;2125.6280150973594;2141.4218161096496;2146.774588668191;2108.2410332280365;2111.398251498323;2114.7356580427445;2115.6720708290163;2117.6823476478576;2073.067119796098;2177.42298290953;2178.5207254404004;2181.5309708412688;2182.7053347798083;2084.8436367272516;2089.780573039832;2100.1074543319182;2133.7410927552664;2136.1241890824685;2058.166442590753;2068.813806757384;2076.1384025629345;2080.864743791649;2085.384811480602;7540.359069479046;7601.201873803227;7667.961660191719;7670.8082297943;7674.040744906887;4440.7335559866515;4562.1560011398;4566.383538222331;4571.040081582872;4571.497135315112;2851.828890266591;2968.85155742212;3008.27801327682;3016.487197176485;3025.183200535865;913.392593925039;922.1101636920337;927.73364357652;930.9022552631944;938.5964035464748;10112.595496180144;10139.54372053252;10152.847707284396;10162;10189.847152292647;4055.371417430303;4069.694772892045;4145.937810932838;4205.201011807747;4206.85276015338;8717.041125476193;8751.124887511198;8755.124487551195;8773.166549177819;8795.648174073094;4440.023194897118;4445.177642136216;4446.599806017474;4453.398791163151;4455.6658250631335;3905.941410878839;3983.0440694233175;4018.9799051005143;4025.2352053109817;4031.496062992126;3305.8842940496966;3488.180277634754;3511.8068506231893;3584.8566057357934;3598.1364472526407;1149.9482523286472;1166.550877911993;1175.5532897498895;1190.9583164589199;1198.6404078776332;754.6528596845403;763.8275247495069;767.9923200767921;786.92130786922;792.1919641965163;4734.124187025412;4800.975995120072;4832.661713680009;4991.875203119951;5051.823186188466;835.6406745099544;846.826400587878;848.7920459487465;863.5725315968635;865.6277800545826;3272.4927636216426;3301.224212310105;3327.434336162858;3366.7643264971216;3410.1815564264894;9002.279817614575;9164.450132992042;9224.30817688676;9241.584128714225;9383.483908384967;9039;9209.953950230207;9235.261179105655;9241.815163696823;9245.352825302165;6846.246912839583;6949.3745562899585;6951.65241737911;6956.443484521226;6980.406665433495;4810.39870016248;4889.877753056202;4906.362172917497;5006.69959802413;5091.66904151229;8377.95811020941;8398.160183981552;8472.703455379033;8588.742337729878;8637.222649961534;8474.66101355939;8681.565921704016;8705.695300664447;8776.122387761172;8787.209151176425;6646.268910419946;6749.42629876466;6784.457243420416;6795.898061528982;6804.76183333581;7218.494705370574;7224.855502890018;7299.160596531255;7311.488195826241;7325.267473252632;6601.405873471411;6609.239937407259;6634;6635.767748128792;6671.733130674718;6576.80269591913;6645.335466453316;6647.401733843977;6650.4347130492515;6672;5837.182794408871;5942.554308426799;5948.256467941507;5950.851228719317;5952.345242023461;4279.9358009630505;4312.525622181494;4318.265894797829;4351.36905148758;4454.888627784331;4337.7397356158735;4453.866384008485;4461.643068554443;4484.573965473275;4663.114008338405 10:24:31 INFO - PROCESS | 24937 | |4;prototype.html;280.56792539489174;284.2226510493799;288.62911159160484;293.35901056192216;295.6954337032856;4878.9506558401;4903.6322275829325;4906.779194936227;4917;4945.6785308954895;4596.35651008859;4615.169269531483;4644.3033544968275;4710.163036415801;4833.951660483394;3704.7962362070075;3704.833282502287;3706.981465092684;3790.8248442982626;3809.657130858222;3748.1566647504364;3769.246150769857;3802.828872700721;3808.695304375657;3810.6951443884564;3650.7290539668634;3784.867529636463;3785.9432108518395;3802.429635554661;3805.450348266654;3577.2308953575107;3683.3922402803505;3684.1158122050515;3693.445983102529;3776.414655728353;3205.8877939272247;3249.8537565809597;3328.8502017409273;3342.298117395326;3350.949735753966;4690.226112691402;4692.817839704554;4700.764961751933;4713.835015774432;4726.645501587361;4015.19696060789;4282.122164956177;4298.688899885534;4308.9353659695125;4316.050468896838;4952.62855285855;5001.699898006095;5001.7499125043605;5004.9749751251375;5021.874453138665;3530.3645343838098;3540.398132317512;3541.3094446582927;3544.769589976643;3550.9112272193142;5243.501867322599;5272.604554658416;5301.7084060376665;5307.65500242483;5315.176147697074;3398.8300584970652;3560.501529785832;3604.9639503605154;3613.9638603613625;3623.673869351771;3665.0654083209142;3669.3395188865725;3669.5229620149744;3671.4125739881492;3676.860173346218;4207.537170911197;4245.8513952011535;4250.192463431938;4252.574742525722;4256.212600668886;4817;5019.548240658358;5050.3939527256225;5070.442251352349;5078.873028174326;1229.9077569182348;1248.2510493703887;1251.3180316727223;1252.1610520950985;1253.035162924543;782.8473447677649;799.6441583495289;803.0122948773042;825.529448214524;826.1366871619052;3996.2806694795217;4004.2992476316526;4011.438398624195;4016.357382818793;4030.5969403059457;4611.239145541015;4613.976930115328;4617.238155704271;4621.659718681612;4629.8842528936375;4024.5371782245415;4030.5969403059457;4032.233875563692;4052.696047796427;4063.6793042260792;2505.649209110726;2511.974880251211;2594.4551644154562;2750.514722050111;2788.888444462199;4954.504549545017;4954.5540901319055;4964.627652926045;4985.700857948462;4988;5365.275687782178;5377.569794416438;5378.731063446812;5379.004884096455;5380.461953804588;4698.483166851644;4948.505149485023;4980.203167493184;4986.276989836381;4988.251762235621;5249.816256431007;5251.737413129405;5261.131913234427;5277.630565860353;5280.603954703336;5180.844574662766;5190.532852043334;5194.558462530576;5218.191180367049;5236.136037553913;4699.76501174933;4932.778024988956;4941.813964648531;4964.106460837084;4970.279309500174;3738.1028553146507;3755.455458958381;3759.09781652396;3769.6041915598466;3783.791891445887;5288.471152884681;5302.151655735064;5303.893922121613;5310.814121505883;5317.8404647860625;4908.337374454403;5039.370078740158;5085.160948443466;5087.084324821568;5101.795928162832;5079.568236699922;5083.085044691991;5086.491350864884;5104.744762761921;5109.335786347751;4992.326035985096;4998.875253068176;5016.398032236009;5017.347744793154;5027.7737501813235;4804.615630749601;4822.397200349957;4924.679895806761;5068.163752980717;5073.8731531712;4968.037625138122;4972.627052970969;4980.377452818398;4987.576056035277;4989 10:24:31 INFO - PROCESS | 24937 | |5;yui.html;569.7692434564001;586.7125108696739;646.7154452041102;657.6941722099223;661.8047675935599;12481.375931203449;13212;13326.067175297732;13335.666608334797;13659.795103073462;13180.340982950862;13501.257430841324;13528;13535.864641353584;13539.932300338509;611.101680529623;751.6054071612406;771.7376092128675;774.9845003099935;775.7440044785208;626.0952923026206;636.4717284653726;636.9968150159243;733.4975541753889;765.2844590308052;806.2139414071293;812.5733989655419;812.8740045292959;813.1908750792969;813.4305985809957;807.11620775251;809.5345176523523;809.5587904592012;810.0846043970334;810.2909953790434;467.44841087516716;566.9801556945529;581.4011568084879;595.2589026661834;596.1117934277938;12138.575149869801;12339;12412.007039436823;12602.495900163982;12672;11189.552417903275;11283.266587671775;11485.540578376855;11544.653660390202;11772.705682357924;10851.403172825492;10996.12031037523;10996.615118470894;11059.612913548068;11326.603568875049;3808.295465338921;3808.90477738056;3826.4642949987024;3859.2667393195484;3894.4547763312876;67480;68309.65845170742;70239.64880175618;71702.28297717008;72696;9325.580348884316;9589.90410095904;9595.664151754656;9799.657012004545;10102.747431314128;18148;18541.536461588297;18544.629107417775;18569.53576160607;18593.90703046476;6617.338266173344;6622.139121914121;6653.500987425962;6767.966160169168;6890.896636550456;3530.0821786335223;3552.0587044433246;3584.19355644983;3608.4948107265004;3650.470681751184;2885.2354126156583;2983.9552406713915;2999.1602351341658;3020.3808219314988;3024.5765592817024;494.77487743077535;497.5000124874478;500.7195970256668;505.91146549354454;509.7986295413291;538.3996843519526;574.2936188488183;574.4973148495067;585.2830282903409;589.3684697824235;7147.2138064812825;7186.532875363085;7750.418718596128;7868.409869259828;8087.231712987257;516.5867306155061;523.5968304405586;549.0419218463727;561.9912257497801;574.2821473158551;3398.6091599465885;3796.2217745362136;3850.4994350734223;3917.804109794499;3983.7609743415487;95647;98516.50741746246;99265;101854;103325;68548.6572567134;70393.64803175951;70727.64636176787;81971;82982;67816;70907.64546177236;72255.63872180606;72772;73736.63131684414;7353.558786472829;7754.224577542201;7839.451238413257;7863.84272314562;7890.447668663139;43461.78269108761;43493.34759978666;43579.34630980474;43868.122637547705;43965.78017109894;59144.704276480064;59396.703016484644;62504.374956251675;63959.6802015987;66677.33322666906;10247.821500527534;10272.175151833306;10277.9486102569;10355.482225888825;10624.36253824773;11589.536418543164;11624;11808.763824723286;11833.349165795964;11854.229475084092;10815.45922703846;10894.727631809268;10912.945435272773;10976.23166378346;11533.538658453903;7420.369268612229;9142.817143656957;10382.169426446017;10596.576136954744;10715.089217416607;10451.94774026125;10465.16278697687;10501.527431265764;10645.946770266099;10953.068989136013;9438.38650487716;9448.574814133242;9777.706668799947;9865.506724663881;9929.156021737945;9107.22588579978;9699.66051188205;9782.559784809559;9853.753656158653;9866.901330986599 10:24:31 INFO - PROCESS | 24937 | __end_tp_report 10:24:31 INFO - PROCESS | 24937 | __start_cc_report 10:24:31 INFO - PROCESS | 24937 | _x_x_mozilla_cycle_collect,978 10:24:31 INFO - PROCESS | 24937 | __end_cc_report 10:24:31 INFO - PROCESS | 24937 | __startTimestamp1469985871323__endTimestamp 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | ------- Summary: start ------- 10:24:31 INFO - PROCESS | 24937 | Number of tests: 6 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | [#0] dojo.html Cycles:165 Average:4731.40 Median:4857.13 stddev:493.61 (10.2%) stddev-sans-first:467.20 10:24:31 INFO - PROCESS | 24937 | Values: 2644.9 2657.7 2704.4 2705.9 2711.4 4651.9 4700.1 4734.4 4831.3 4858.9 4715.8 4718.8 4776.8 4779.4 4780.3 4302.3 4318.5 4372.9 4429.2 4502.9 4424.2 4452.5 4480.1 4499.4 4501.5 4281.9 4321.9 4437.5 4452.6 4529.5 4358.5 4380.3 4384.1 4415.9 4421.7 4350.8 4370.3 4397.1 4411.4 4442.4 4811.9 4835.1 4840.6 4844.2 4847.8 4931.7 4979.1 5068.3 5072.5 5148.8 5076.5 5090.4 5108.9 5149.2 5153.4 4664.9 4822.0 4830.0 4831.1 4835.4 5214.9 5278.2 5291.8 5335.7 5364.3 5067.4 5134.2 5137.7 5141.6 5144.2 4972.7 5212.2 5216.3 5228.2 5231.8 4970.4 4976.5 5030.7 5043.2 5126.2 5058.4 5062.6 5063.1 5067.8 5113.6 4389.5 4391.8 4398.5 4405.7 4453.4 3702.0 3738.4 3759.7 3812.1 3857.3 4394.4 4405.8 4412.5 4441.8 4450.4 5136.7 5146.2 5147.7 5148.3 5196.8 4295.4 4324.1 4342.3 4373.0 4396.0 4632.3 4642.1 4654.3 4691.0 4698.8 4790.7 4800.1 4804.4 4805.4 4813.4 4971.2 5074.4 5093.9 5130.9 5137.3 4824.1 4850.8 4857.1 4882.9 4898.9 5038.0 5057.5 5058.1 5062.5 5063.1 4946.8 4983.3 5019.4 5041.1 5166.4 4928.5 4932.1 4943.5 4947.6 4963.7 4933.0 4936.3 4940.3 4949.0 4973.3 4761.3 4873.9 4907.6 4924.7 4928.1 5063.7 5064.2 5065.1 5068.7 5075.2 4962.0 4963.5 4964.3 4967.2 4998.2 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | [#1] ext.html Cycles:180 Average:46836.36 Median:36609.95 stddev:88246.35 (241.0%) stddev-sans-first:88425.54 10:24:31 INFO - PROCESS | 24937 | Values: 570.8 575.1 583.0 583.3 584.8 28033.0 38378.2 39561.6 39580.6 43121.6 39352.8 39539.4 39571.6 39650.8 39656.4 7740.1 7865.2 7867.3 7871.1 7872.6 7721.9 7810.8 7813.5 7815.2 7815.8 7822.9 7869.4 7872.1 7880.5 7889.4 7809.3 7832.1 7835.6 7837.3 7852.5 7728.5 7803.6 7806.9 7809.2 7823.8 36618.3 36846.6 37015.0 37032.6 37123.3 2932.9 3287.2 3539.2 3609.7 3699.7 28944.3 29061.6 29068.0 29152.7 30464.7 3313.2 3407.3 3412.6 3418.6 3503.8 246651.0 247040.0 247115.0 247910.0 249167.0 32015.7 50051.0 50449.7 50458.5 50620.5 33231.0 33343.0 33392.3 33428.8 33437.7 13179.5 13299.2 13302.9 13303.1 13317.9 10646.5 10665.3 10700.4 10713.7 10747.6 7735.3 7751.5 7830.3 7860.5 7890.6 3006.5 3054.1 3063.8 3074.8 3081.2 803.3 840.0 901.4 942.1 956.9 27183.0 27738.3 28152.9 28155.9 28684.4 923.4 930.3 938.5 975.5 1057.4 14288.3 14827.2 15097.2 15149.9 15261.1 414344.0 418891.0 418942.0 419490.0 420661.0 48200.5 48774.5 48776.5 48887.5 48889.5 1150.8 1163.1 1190.4 1194.8 1201.9 24586.3 26970.5 27105.5 28100.7 28104.2 42345.6 42562.8 42615.0 42683.8 42735.6 311055.0 312723.0 312762.0 312973.0 313138.0 24607.5 25055.4 25075.7 25097.2 25102.0 46229.3 46703.1 47209.0 48389.8 48394.8 35411.8 35491.8 36001.6 36730.1 36973.6 36434.1 36462.3 36821.6 37041.8 37721.0 27935.4 30738.2 35685.8 36601.6 38877.0 30864.8 31911.7 33485.0 33647.8 33651.0 25828.8 25912.7 26256.9 26536.6 26636.2 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | [#2] jquery.html Cycles:180 Average:24917.39 Median:203418.16 stddev:65240.41 (32.1%) stddev-sans-first:65397.36 10:24:31 INFO - PROCESS | 24937 | Values: 355.9 356.1 362.9 367.8 383.2 16070.9 16976.4 17026.5 17151.7 17153.7 16578.0 16886.6 17407.4 17557.8 17559.1 4894.3 5130.7 5132.4 5133.2 5136.9 3783.8 3957.3 5096.9 5672.6 6008.0 6003.3 6124.1 6129.4 6134.0 6134.4 5824.4 5924.6 5929.7 5934.5 5939.7 5136.8 5229.1 5244.4 5245.7 5246.0 21481.4 22032.0 22141.3 22359.0 23294.2 2190.6 2191.5 2417.9 2581.9 2638.5 14131.4 14540.7 14569.1 15493.7 15701.8 1816.7 1873.8 1910.1 1942.4 1968.0 82448.0 82469.0 83616.0 83717.0 84497.0 8324.4 8568.4 8726.0 8817.4 14840.7 11497.1 11536.7 11545.4 11553.8 11560.2 7067.7 7135.1 7211.8 7212.9 7265.9 6831.5 6839.6 7049.2 7098.8 7266.0 3634.0 3659.4 3678.2 3724.4 3747.7 1676.7 1704.1 1736.3 1789.6 1817.4 807.4 820.7 830.5 839.3 960.1 16099.9 16114.7 16504.2 17737.6 17799.0 831.3 880.7 895.7 912.2 937.5 9169.3 9859.1 9869.4 9876.9 9900.6 389309.0 390277.0 390901.0 392173.0 401942.0 74860.0 76930.0 79647.0 80394.2 82044.6 812.1 835.9 872.5 891.1 894.4 15453.8 15474.4 15891.7 16179.8 16491.4 37854.6 37867.4 38033.1 38047.6 39612.0 49832.0 50283.2 50499.5 53044.7 53971.7 6084.1 6560.2 6811.7 7103.6 7631.2 10196.8 10522.1 11127.8 11160.6 11620.1 6475.6 9583.0 10138.5 10169.2 10589.9 6924.8 6957.6 7045.3 7084.6 7185.5 7123.5 7314.0 7462.5 7540.3 7770.1 10588.9 10612.7 10682.5 10773.4 11119.4 10048.3 10579.5 10608.2 10628.9 10879.5 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | [#3] mootools.html Cycles:180 Average:4945.73 Median:4949.12 stddev:2748.90 (55.5%) stddev-sans-first:2743.13 10:24:31 INFO - PROCESS | 24937 | Values: 1321.8 1351.6 1371.4 1596.6 1602.8 7152.1 7804.1 7807.1 7810.3 7816.0 6435.5 6611.3 6612.4 6783.9 7607.9 1849.4 2085.7 2125.6 2141.4 2146.8 2108.2 2111.4 2114.7 2115.7 2117.7 2073.1 2177.4 2178.5 2181.5 2182.7 2084.8 2089.8 2100.1 2133.7 2136.1 2058.2 2068.8 2076.1 2080.9 2085.4 7540.4 7601.2 7668.0 7670.8 7674.0 4440.7 4562.2 4566.4 4571.0 4571.5 2851.8 2968.9 3008.3 3016.5 3025.2 913.4 922.1 927.7 930.9 938.6 10112.6 10139.5 10152.8 10162.0 10189.8 4055.4 4069.7 4145.9 4205.2 4206.9 8717.0 8751.1 8755.1 8773.2 8795.6 4440.0 4445.2 4446.6 4453.4 4455.7 3905.9 3983.0 4019.0 4025.2 4031.5 3305.9 3488.2 3511.8 3584.9 3598.1 1149.9 1166.6 1175.6 1191.0 1198.6 754.7 763.8 768.0 786.9 792.2 4734.1 4801.0 4832.7 4991.9 5051.8 835.6 846.8 848.8 863.6 865.6 3272.5 3301.2 3327.4 3366.8 3410.2 9002.3 9164.5 9224.3 9241.6 9383.5 9039.0 9210.0 9235.3 9241.8 9245.4 6846.2 6949.4 6951.7 6956.4 6980.4 4810.4 4889.9 4906.4 5006.7 5091.7 8378.0 8398.2 8472.7 8588.7 8637.2 8474.7 8681.6 8705.7 8776.1 8787.2 6646.3 6749.4 6784.5 6795.9 6804.8 7218.5 7224.9 7299.2 7311.5 7325.3 6601.4 6609.2 6634.0 6635.8 6671.7 6576.8 6645.3 6647.4 6650.4 6672.0 5837.2 5942.6 5948.3 5950.9 5952.3 4279.9 4312.5 4318.3 4351.4 4454.9 4337.7 4453.9 4461.6 4484.6 4663.1 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | [#4] prototype.html Cycles:180 Average:4153.73 Median:4699.12 stddev:1232.28 (26.2%) stddev-sans-first:1200.96 10:24:31 INFO - PROCESS | 24937 | Values: 280.6 284.2 288.6 293.4 295.7 4879.0 4903.6 4906.8 4917.0 4945.7 4596.4 4615.2 4644.3 4710.2 4834.0 3704.8 3704.8 3707.0 3790.8 3809.7 3748.2 3769.2 3802.8 3808.7 3810.7 3650.7 3784.9 3785.9 3802.4 3805.5 3577.2 3683.4 3684.1 3693.4 3776.4 3205.9 3249.9 3328.9 3342.3 3350.9 4690.2 4692.8 4700.8 4713.8 4726.6 4015.2 4282.1 4298.7 4308.9 4316.1 4952.6 5001.7 5001.7 5005.0 5021.9 3530.4 3540.4 3541.3 3544.8 3550.9 5243.5 5272.6 5301.7 5307.7 5315.2 3398.8 3560.5 3605.0 3614.0 3623.7 3665.1 3669.3 3669.5 3671.4 3676.9 4207.5 4245.9 4250.2 4252.6 4256.2 4817.0 5019.5 5050.4 5070.4 5078.9 1229.9 1248.3 1251.3 1252.2 1253.0 782.8 799.6 803.0 825.5 826.1 3996.3 4004.3 4011.4 4016.4 4030.6 4611.2 4614.0 4617.2 4621.7 4629.9 4024.5 4030.6 4032.2 4052.7 4063.7 2505.6 2512.0 2594.5 2750.5 2788.9 4954.5 4954.6 4964.6 4985.7 4988.0 5365.3 5377.6 5378.7 5379.0 5380.5 4698.5 4948.5 4980.2 4986.3 4988.3 5249.8 5251.7 5261.1 5277.6 5280.6 5180.8 5190.5 5194.6 5218.2 5236.1 4699.8 4932.8 4941.8 4964.1 4970.3 3738.1 3755.5 3759.1 3769.6 3783.8 5288.5 5302.2 5303.9 5310.8 5317.8 4908.3 5039.4 5085.2 5087.1 5101.8 5079.6 5083.1 5086.5 5104.7 5109.3 4992.3 4998.9 5016.4 5017.3 5027.8 4804.6 4822.4 4924.7 5068.2 5073.9 4968.0 4972.6 4980.4 4987.6 4989.0 10:24:31 INFO - PROCESS | 24937 | 10:24:31 INFO - PROCESS | 24937 | [#5] yui.html Cycles:180 Average:17411.85 Median:555.52 stddev:25181.50 (4533.0%) stddev-sans-first:25220.39 10:24:31 INFO - PROCESS | 24937 | Values: 569.8 586.7 646.7 657.7 661.8 12481.4 13212.0 13326.1 13335.7 13659.8 13180.3 13501.3 13528.0 13535.9 13539.9 611.1 751.6 771.7 775.0 775.7 626.1 636.5 637.0 733.5 765.3 806.2 812.6 812.9 813.2 813.4 807.1 809.5 809.6 810.1 810.3 467.4 567.0 581.4 595.3 596.1 12138.6 12339.0 12412.0 12602.5 12672.0 11189.6 11283.3 11485.5 11544.7 11772.7 10851.4 10996.1 10996.6 11059.6 11326.6 3808.3 3808.9 3826.5 3859.3 3894.5 67480.0 68309.7 70239.6 71702.3 72696.0 9325.6 9589.9 9595.7 9799.7 10102.7 18148.0 18541.5 18544.6 18569.5 18593.9 6617.3 6622.1 6653.5 6768.0 6890.9 3530.1 3552.1 3584.2 3608.5 3650.5 2885.2 2984.0 2999.2 3020.4 3024.6 494.8 497.5 500.7 505.9 509.8 538.4 574.3 574.5 585.3 589.4 7147.2 7186.5 7750.4 7868.4 8087.2 516.6 523.6 549.0 562.0 574.3 3398.6 3796.2 3850.5 3917.8 3983.8 95647.0 98516.5 99265.0 101854.0 103325.0 68548.7 70393.6 70727.6 81971.0 82982.0 67816.0 70907.6 72255.6 72772.0 73736.6 7353.6 7754.2 7839.5 7863.8 7890.4 43461.8 43493.3 43579.3 43868.1 43965.8 59144.7 59396.7 62504.4 63959.7 66677.3 10247.8 10272.2 10277.9 10355.5 10624.4 11589.5 11624.0 11808.8 11833.3 11854.2 10815.5 10894.7 10912.9 10976.2 11533.5 7420.4 9142.8 10382.2 10596.6 10715.1 10451.9 10465.2 10501.5 10645.9 10953.1 9438.4 9448.6 9777.7 9865.5 9929.2 9107.2 9699.7 9782.6 9853.8 9866.9 10:24:31 INFO - PROCESS | 24937 | -------- Summary: end -------- 10:24:31 INFO - PROCESS | 24937 | 10:24:32 INFO - TEST-INFO | 24937: exit 0 10:24:32 INFO - TEST-OK | dromaeo_css | took 1120193ms 10:24:32 INFO - TEST-START | kraken 10:24:32 INFO - operating with platform_type : linux_ 10:24:32 INFO - Initialising browser for kraken test... 10:24:32 INFO - TEST-INFO | started process 25123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprppzfC/profile http://localhost:38783/getInfo.html) 10:24:36 INFO - PROCESS | 25123 | __metrics Screen width/height:1600/1200 10:24:36 INFO - PROCESS | 25123 | colorDepth:24 10:24:36 INFO - PROCESS | 25123 | Browser inner width/height: 1024/697 10:24:36 INFO - PROCESS | 25123 | __metrics 10:24:37 INFO - PROCESS | 25123 | 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" 10:24:37 INFO - PROCESS | 25123 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:38 INFO - TEST-INFO | 25123: exit 0 10:24:38 INFO - Browser initialized. 10:24:38 INFO - Running cycle 1/1 for kraken test... 10:24:38 INFO - TEST-INFO | started process 25201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprppzfC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:50 INFO - PROCESS | 25201 | RSS: Main: 157396992 10:24:50 INFO - PROCESS | 25201 | 10:24:53 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38783/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:54 INFO - PROCESS | 25201 | RSS: Main: 214216704 10:24:54 INFO - PROCESS | 25201 | 10:24:57 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38783/tests/kraken/driver.html?testName=audio-dft) 10:24:57 INFO - PROCESS | 25201 | RSS: Main: 191533056 10:24:57 INFO - PROCESS | 25201 | 10:25:00 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38783/tests/kraken/driver.html?testName=audio-fft) 10:25:01 INFO - PROCESS | 25201 | RSS: Main: 271798272 10:25:01 INFO - PROCESS | 25201 | 10:25:03 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38783/tests/kraken/driver.html?testName=audio-oscillator) 10:25:04 INFO - PROCESS | 25201 | RSS: Main: 181043200 10:25:04 INFO - PROCESS | 25201 | 10:25:06 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:07 INFO - PROCESS | 25201 | RSS: Main: 185884672 10:25:07 INFO - PROCESS | 25201 | 10:25:10 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38783/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:10 INFO - PROCESS | 25201 | RSS: Main: 221638656 10:25:10 INFO - PROCESS | 25201 | 10:25:14 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38783/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:15 INFO - PROCESS | 25201 | RSS: Main: 220655616 10:25:15 INFO - PROCESS | 25201 | 10:25:17 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38783/tests/kraken/driver.html?testName=json-parse-financial) 10:25:18 INFO - PROCESS | 25201 | RSS: Main: 220876800 10:25:18 INFO - PROCESS | 25201 | 10:25:20 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:20 INFO - PROCESS | 25201 | RSS: Main: 185442304 10:25:20 INFO - PROCESS | 25201 | 10:25:22 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:23 INFO - PROCESS | 25201 | RSS: Main: 192778240 10:25:23 INFO - PROCESS | 25201 | 10:25:25 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:26 INFO - PROCESS | 25201 | RSS: Main: 195354624 10:25:26 INFO - PROCESS | 25201 | 10:25:28 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:29 INFO - PROCESS | 25201 | RSS: Main: 189960192 10:25:29 INFO - PROCESS | 25201 | 10:25:32 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:33 INFO - PROCESS | 25201 | RSS: Main: 193515520 10:25:33 INFO - PROCESS | 25201 | 10:25:34 INFO - PROCESS | 25201 | Cycle 1(1): loaded http://localhost:38783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38783/tests/kraken/driver.html?testName=ai-astar) 10:25:35 INFO - PROCESS | 25201 | RSS: Main: 244445184 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | __start_tp_report 10:25:35 INFO - PROCESS | 25201 | _x_x_mozilla_page_load 10:25:35 INFO - PROCESS | 25201 | _x_x_mozilla_page_load_details 10:25:35 INFO - PROCESS | 25201 | |i|pagename|runs| 10:25:35 INFO - PROCESS | 25201 | |0;ai-astar;104;114;114;114;114;113;113;114;114;115 10:25:35 INFO - PROCESS | 25201 | |1;audio-beat-detection;150;132;125;178;122;129;153;128;189;123 10:25:35 INFO - PROCESS | 25201 | |2;audio-dft;162;160;161;163;161;161;160;176;162;161 10:25:35 INFO - PROCESS | 25201 | |3;audio-fft;78;76;76;122;75;79;76;75;102;77 10:25:35 INFO - PROCESS | 25201 | |4;audio-oscillator;85;85;116;84;85;85;114;85;86;144 10:25:35 INFO - PROCESS | 25201 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;117;116;117 10:25:35 INFO - PROCESS | 25201 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;147 10:25:35 INFO - PROCESS | 25201 | |7;imaging-desaturate;96;95;95;96;95;95;96;95;95;94 10:25:35 INFO - PROCESS | 25201 | |8;json-parse-financial;63;62;61;61;62;63;61;61;63;61 10:25:35 INFO - PROCESS | 25201 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;65;66;65 10:25:35 INFO - PROCESS | 25201 | |10;stanford-crypto-aes;79;79;79;81;79;80;79;79;80;81 10:25:35 INFO - PROCESS | 25201 | |11;stanford-crypto-ccm;140;132;135;132;147;131;134;132;166;144 10:25:35 INFO - PROCESS | 25201 | |12;stanford-crypto-pbkdf2;165;171;163;172;169;164;170;164;166;163 10:25:35 INFO - PROCESS | 25201 | |13;stanford-crypto-sha256-iterative;67;70;67;67;67;67;68;66;67;67 10:25:35 INFO - PROCESS | 25201 | __end_tp_report 10:25:35 INFO - PROCESS | 25201 | __start_cc_report 10:25:35 INFO - PROCESS | 25201 | _x_x_mozilla_cycle_collect,1930 10:25:35 INFO - PROCESS | 25201 | __end_cc_report 10:25:35 INFO - PROCESS | 25201 | __startTimestamp1469985935049__endTimestamp 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | ------- Summary: start ------- 10:25:35 INFO - PROCESS | 25201 | Number of tests: 14 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.18 (2.8%) stddev-sans-first:0.60 10:25:35 INFO - PROCESS | 25201 | Values: 104.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 115.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:141.00 stddev:24.03 (17.0%) stddev-sans-first:25.35 10:25:35 INFO - PROCESS | 25201 | Values: 150.0 132.0 125.0 178.0 122.0 129.0 153.0 128.0 189.0 123.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#2] audio-dft Cycles:10 Average:162.70 Median:161.50 stddev:4.76 (2.9%) stddev-sans-first:5.04 10:25:35 INFO - PROCESS | 25201 | Values: 162.0 160.0 161.0 163.0 161.0 161.0 160.0 176.0 162.0 161.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:15.74 (20.7%) stddev-sans-first:16.57 10:25:35 INFO - PROCESS | 25201 | Values: 78.0 76.0 76.0 122.0 75.0 79.0 76.0 75.0 102.0 77.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:20.73 (24.4%) stddev-sans-first:21.54 10:25:35 INFO - PROCESS | 25201 | Values: 85.0 85.0 116.0 84.0 85.0 85.0 114.0 85.0 86.0 144.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:25:35 INFO - PROCESS | 25201 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 10:25:35 INFO - PROCESS | 25201 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 10:25:35 INFO - PROCESS | 25201 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 94.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 10:25:35 INFO - PROCESS | 25201 | Values: 63.0 62.0 61.0 61.0 62.0 63.0 61.0 61.0 63.0 61.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 10:25:35 INFO - PROCESS | 25201 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 65.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.87 10:25:35 INFO - PROCESS | 25201 | Values: 79.0 79.0 79.0 81.0 79.0 80.0 79.0 79.0 80.0 81.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:137.50 stddev:10.90 (7.9%) stddev-sans-first:11.56 10:25:35 INFO - PROCESS | 25201 | Values: 140.0 132.0 135.0 132.0 147.0 131.0 134.0 132.0 166.0 144.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.50 stddev:3.47 (2.1%) stddev-sans-first:3.62 10:25:35 INFO - PROCESS | 25201 | Values: 165.0 171.0 163.0 172.0 169.0 164.0 170.0 164.0 166.0 163.0 10:25:35 INFO - PROCESS | 25201 | 10:25:35 INFO - PROCESS | 25201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 10:25:35 INFO - PROCESS | 25201 | Values: 67.0 70.0 67.0 67.0 67.0 67.0 68.0 66.0 67.0 67.0 10:25:35 INFO - PROCESS | 25201 | -------- Summary: end -------- 10:25:35 INFO - PROCESS | 25201 | 10:25:36 INFO - TEST-INFO | 25201: exit 0 10:25:36 INFO - TEST-OK | kraken | took 63980ms 10:25:36 INFO - SUITE-END | took 1184s 10:25:36 INFO - Completed test suite (00:19:44) 10:25:36 INFO - javascript benchmark 10:25:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.9471010579778, 2657.6677915260593, 2704.445588654326, 2705.8782354794034, 2711.4305995740892, 4651.930221046687, 4700.083483720676, 4734.43186817582, 4831.25115607081, 4858.902821943559, 4715.78778954947, 4718.811247550102, 4776.832810851621, 4779.426468823746, 4780.30685550595, 4302.290122129845, 4318.5033721122, 4372.890677733066, 4429.224885645015, 4502.909941801162, 4424.225760491917, 4452.510223875387, 4480.059187570614, 4499.370088187657, 4501.504834468205, 4281.850135245251, 4321.891952701176, 4437.5340589237985, 4452.5992660660695, 4529.456465224178, 4358.4987726411555, 4380.2772542530765, 4384.079343337903, 4415.933760993587, 4421.668374871898, 4350.7607081610495, 4370.344448332744, 4397.054633253833, 4411.404460397837, 4442.444694413199, 4811.855644330641, 4835.08133454646, 4840.564349208553, 4844.176489996709, 4847.806087756486, 4931.654784165074, 4979.128652485801, 5068.26510156029, 5072.5434710875825, 5148.819791307286, 5076.492350764931, 5090.414602320743, 5108.923366149511, 5149.150390185615, 5153.3558305211845, 4664.883377915579, 4821.975890120527, 4830.0, 4831.106245344622, 4835.419749630067, 5214.895702085937, 5278.155495120763, 5291.814786482455, 5335.653182543122, 5364.302640656768, 5067.391912970467, 5134.229865520202, 5137.6660517066275, 5141.5886729061585, 5144.151215049475, 4972.726500042532, 5212.166053431432, 5216.295800066942, 5228.241904923841, 5231.790728370823, 4970.353853998957, 4976.477469865685, 5030.698158110525, 5043.218301163325, 5126.15418455958, 5058.418281897555, 5062.569681577033, 5063.139266324733, 5067.771950262247, 5113.64204505681, 4389.517153113155, 4391.802368893407, 4398.516163222043, 4405.691601587922, 4453.4433195850515, 3702.0374702577524, 3738.4392341149046, 3759.680427163667, 3812.066043819282, 3857.324968130622, 4394.428724265825, 4405.823767049346, 4412.514623391425, 4441.755703436342, 4450.421445212167, 5136.653236210683, 5146.202338637442, 5147.6654017488745, 5148.253503242009, 5196.76614552346, 4295.355696645528, 4324.113556720865, 4342.261815491374, 4373.016071383913, 4396.032872767986, 4632.281996290513, 4642.117997580449, 4654.25531914892, 4691.014886873726, 4698.765061746967, 4790.688605240718, 4800.087983283235, 4804.399450068741, 4805.447373552086, 4813.350197723403, 4971.229459433794, 5074.391073071255, 5093.930274642366, 5130.948690513047, 5137.280780690631, 4824.0834241494, 4850.7817148227705, 4857.125717370907, 4882.92675609859, 4898.9020219594695, 5037.992401519784, 5057.494250574913, 5058.1401161803315, 5062.519060689228, 5063.088644044107, 4946.752662366939, 4983.277424773315, 5019.3976722793495, 5041.117804384291, 5166.3800343958965, 4928.482509336468, 4932.062908047459, 4943.505649435172, 4947.579455746302, 4963.677360971526, 4932.975335123301, 4936.333594964633, 4940.308356830118, 4948.950510494993, 4973.278874563241, 4761.309610106585, 4873.926891096566, 4907.607391408607, 4924.72913989734, 4928.063667903087, 5063.721495317793, 5064.215046667772, 5065.062963351792, 5068.695878247317, 5075.1625981712605, 4962.032403681247, 4963.454020057863, 4964.280179374043, 4967.230079337708, 4998.225275082368], "value": 4700.055409141478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8030729398358, 575.1229375202817, 582.9883402331953, 583.2942140010592, 584.777784441912, 28033.0, 38378.232435351274, 39561.60438395615, 39580.604193958054, 43121.56878431215, 39352.80323598378, 39539.40690889639, 39571.60428395715, 39650.8017459913, 39656.405153922715, 7740.109887362969, 7865.213478652117, 7867.252611001974, 7871.055473343207, 7872.5670088145125, 7721.9227807722045, 7810.804729881742, 7813.492123011986, 7815.218478152167, 7815.843683126334, 7822.882656760153, 7869.370450363986, 7872.09470910844, 7880.527168369917, 7889.368850491946, 7809.336206422461, 7832.099308579529, 7835.6473958671995, 7837.255460731221, 7852.450328477009, 7728.497647652885, 7803.609819509059, 7806.921930780733, 7809.219078092202, 7823.804404889924, 36618.267634647156, 36846.63153368486, 37015.0, 37032.62967370346, 37123.25753484915, 2932.8973485928104, 3287.211069343364, 3539.1682954505673, 3609.693176080036, 3699.72252081095, 28944.27639309013, 29061.564076538867, 29068.0, 29152.708472915212, 30464.69535304663, 3313.204830840605, 3407.335569563936, 3412.6416726243633, 3418.5897692276835, 3503.7722548034553, 246650.9999999982, 247040.0, 247115.0, 247910.0, 249167.0, 32015.679843201735, 50051.0, 50449.747751261006, 50458.49541504611, 50620.49379506158, 33231.0, 33342.99913007841, 33392.332153356794, 33428.832855835564, 33437.665623343455, 13179.538716144889, 13299.20204787716, 13302.866971330162, 13303.13529620591, 13317.933410332886, 10646.520906559223, 10665.306755060896, 10700.357978521313, 10713.678589642323, 10747.570097196181, 7735.3424958878, 7751.534907905544, 7830.33442157423, 7860.528368297921, 7890.64492097857, 3006.503926852045, 3054.129573071664, 3063.846807659608, 3074.8001379910233, 3081.198888289016, 803.3412601666578, 839.9832003359899, 901.3870568013682, 942.1104467812033, 956.8756061712072, 27183.0, 27738.306542336602, 28152.87388504437, 28155.859220704177, 28684.42631147407, 923.3905622289257, 930.3022732950287, 938.5072836760755, 975.4878688688353, 1057.376148072641, 14288.285585720672, 14827.184504852337, 15097.245137743288, 15149.924250378897, 15261.084334939938, 414344.0, 418891.0, 418942.0, 419490.0, 420661.0, 48200.51799482031, 48774.51225487771, 48776.512234877904, 48887.5111248883, 48889.511104888494, 1150.79285728568, 1163.057923082306, 1190.3572071081692, 1194.8267501212276, 1201.9218750781347, 24586.262412127664, 26970.460590787683, 27105.457890842466, 28100.71899280981, 28104.156875293775, 42345.576544235395, 42562.78718606511, 42615.0, 42683.786581066895, 42735.572644274405, 311055.0, 312723.0, 312762.0, 312973.0, 313138.0, 24607.507849842546, 25055.373615659755, 25075.74924250734, 25097.24708258755, 25102.0, 46229.30656040229, 46703.06593868171, 47209.0, 48389.758051209516, 48394.758026209645, 35411.82294088513, 35491.82254088713, 36001.63998359983, 36730.081747956516, 36973.63026369702, 36434.11239430317, 36462.27075458423, 36821.63178368289, 37041.81479092587, 37721.0, 27935.44129117447, 30738.231544211572, 35685.821570893015, 36601.63398366089, 38877.0, 30864.845675772376, 31911.68088319087, 33485.0, 33647.831760841036, 33651.0, 25828.83692301574, 25912.74087259179, 26256.868715657063, 26536.601950971137, 26636.20091397261], "value": 16445.76244319918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.89145310680243, 356.07420706163975, 362.8639260277394, 367.845504887947, 383.19911385204915, 16070.919645401771, 16976.405825796082, 17026.489205323844, 17151.656966860653, 17153.74269385957, 16578.0, 16886.57783555412, 17407.390741324056, 17557.82442175581, 17559.122043897816, 4894.3147959285725, 5130.692158470485, 5132.435432102466, 5133.230015497668, 5136.8972620547565, 3783.754055986366, 3957.267905437489, 5096.872578185556, 5672.631278966875, 6008.0, 6003.279606447232, 6124.050772130327, 6129.448349648531, 6134.049222370518, 6134.355892631276, 5824.398290470112, 5924.644521328691, 5929.73316200772, 5934.465898069173, 5939.70301484924, 5136.794528218867, 5229.058769421503, 5244.423113457517, 5245.714799874017, 5246.0, 21481.35555933309, 22032.0, 22141.335759927228, 22359.0, 23294.184703535295, 2190.58378908007, 2191.495955930145, 2417.9240238094053, 2581.8838152283192, 2638.4723055389, 14131.434742610283, 14540.70918581633, 14569.125852448888, 15493.690126197525, 15701.842981570153, 1816.727490876366, 1873.840723538501, 1910.0831600831539, 1942.3881477334594, 1967.9704804427945, 82448.0, 82469.0, 83616.0, 83716.99999999939, 84497.0, 8324.375671824637, 8568.386642074103, 8726.04013558508, 8817.382783205243, 14840.703185936221, 11497.080233581293, 11536.711582210344, 11545.36500492481, 11553.768924621629, 11560.190786644855, 7067.717291308393, 7135.143782746104, 7211.7836464905085, 7212.891806622905, 7265.9273407265255, 6831.521793474509, 6839.563691624815, 7049.154101507852, 7098.751543695946, 7265.963670181721, 3633.9636603633626, 3659.3596120678776, 3678.2275722098125, 3724.385476396364, 3747.7001839852746, 1676.6981943250332, 1704.1223769758585, 1736.3488691740597, 1789.5640370488693, 1817.4365946556609, 807.3662175192563, 820.6799348254185, 830.5224495914873, 839.3243439031638, 960.0879164793474, 16099.919500402422, 16114.677706445806, 16504.17479126039, 17737.645247094984, 17799.0, 831.2809419851785, 880.7269746378643, 895.6596493332491, 912.1972664055588, 937.4843835890233, 9169.266458683289, 9859.112679858703, 9869.358491698016, 9876.901230987598, 9900.60397584103, 389309.0, 390277.0, 390901.0, 392173.0, 401942.0, 74860.0, 76930.0, 79647.0, 80394.19605803984, 82044.58977705192, 812.0864027968536, 835.8924425136597, 872.4634349874908, 891.0866361978893, 894.3873446689039, 15453.84546154569, 15474.381024759334, 15891.695704123069, 16179.75730364022, 16491.422800201934, 37854.62145378511, 37867.431988519646, 38033.088327145764, 38047.619523805515, 39612.0, 49832.0, 50283.24575131449, 50499.49500504948, 53044.73477632587, 53971.73014134904, 6084.14821924922, 6560.212774467094, 6811.65941702903, 7103.573785572882, 7631.1605723371495, 10196.847047294148, 10522.1056210223, 11127.777444451227, 11160.553577856796, 11620.070394368262, 6475.579087359307, 9582.952085239529, 10138.543765530421, 10169.237307201842, 10589.9470502647, 6924.757633482804, 6957.582545047313, 7045.2954704531185, 7084.610346430995, 7185.497015208885, 7123.501354905107, 7314.012608297811, 7462.5149365293255, 7540.283673051052, 7770.067591889009, 10588.894111059099, 10612.681619551426, 10682.519286632276, 10773.353598784099, 11119.44402779874, 10048.346857454535, 10579.471026448493, 10608.204384671335, 10628.89371106279, 10879.51042203087], "value": 8257.032006776168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.7951217561279, 1351.5539871842293, 1371.3691701817163, 1596.590231689386, 1602.751573506107, 7152.0702308699865, 7804.141544430108, 7807.102183248928, 7810.258025487584, 7815.960920195391, 6435.485161187105, 6611.305812889649, 6612.404883560491, 6783.9321606783915, 7607.885881711779, 1849.3897013985386, 2085.7392825896763, 2125.6280150973594, 2141.4218161096496, 2146.774588668191, 2108.2410332280365, 2111.398251498323, 2114.7356580427445, 2115.6720708290163, 2117.6823476478576, 2073.067119796098, 2177.42298290953, 2178.5207254404004, 2181.5309708412688, 2182.7053347798083, 2084.8436367272516, 2089.780573039832, 2100.1074543319182, 2133.7410927552664, 2136.1241890824685, 2058.166442590753, 2068.813806757384, 2076.1384025629345, 2080.864743791649, 2085.384811480602, 7540.359069479046, 7601.201873803227, 7667.961660191719, 7670.8082297943, 7674.040744906887, 4440.7335559866515, 4562.1560011398, 4566.383538222331, 4571.040081582872, 4571.497135315112, 2851.828890266591, 2968.85155742212, 3008.27801327682, 3016.487197176485, 3025.183200535865, 913.392593925039, 922.1101636920337, 927.73364357652, 930.9022552631944, 938.5964035464748, 10112.595496180144, 10139.54372053252, 10152.847707284396, 10162.0, 10189.847152292647, 4055.371417430303, 4069.694772892045, 4145.937810932838, 4205.201011807747, 4206.85276015338, 8717.041125476193, 8751.124887511198, 8755.124487551195, 8773.166549177819, 8795.648174073094, 4440.023194897118, 4445.177642136216, 4446.599806017474, 4453.398791163151, 4455.6658250631335, 3905.941410878839, 3983.0440694233175, 4018.9799051005143, 4025.2352053109817, 4031.496062992126, 3305.8842940496966, 3488.180277634754, 3511.8068506231893, 3584.8566057357934, 3598.1364472526407, 1149.9482523286472, 1166.550877911993, 1175.5532897498895, 1190.9583164589199, 1198.6404078776332, 754.6528596845403, 763.8275247495069, 767.9923200767921, 786.92130786922, 792.1919641965163, 4734.124187025412, 4800.975995120072, 4832.661713680009, 4991.875203119951, 5051.823186188466, 835.6406745099544, 846.826400587878, 848.7920459487465, 863.5725315968635, 865.6277800545826, 3272.4927636216426, 3301.224212310105, 3327.434336162858, 3366.7643264971216, 3410.1815564264894, 9002.279817614575, 9164.450132992042, 9224.30817688676, 9241.584128714225, 9383.483908384967, 9039.0, 9209.953950230207, 9235.261179105655, 9241.815163696823, 9245.352825302165, 6846.246912839583, 6949.3745562899585, 6951.65241737911, 6956.443484521226, 6980.406665433495, 4810.39870016248, 4889.877753056202, 4906.362172917497, 5006.69959802413, 5091.66904151229, 8377.95811020941, 8398.160183981552, 8472.703455379033, 8588.742337729878, 8637.222649961534, 8474.66101355939, 8681.565921704016, 8705.695300664447, 8776.122387761172, 8787.209151176425, 6646.268910419946, 6749.42629876466, 6784.457243420416, 6795.898061528982, 6804.76183333581, 7218.494705370574, 7224.855502890018, 7299.160596531255, 7311.488195826241, 7325.267473252632, 6601.405873471411, 6609.239937407259, 6634.0, 6635.767748128792, 6671.733130674718, 6576.80269591913, 6645.335466453316, 6647.401733843977, 6650.4347130492515, 6672.0, 5837.182794408871, 5942.554308426799, 5948.256467941507, 5950.851228719317, 5952.345242023461, 4279.9358009630505, 4312.525622181494, 4318.265894797829, 4351.36905148758, 4454.888627784331, 4337.7397356158735, 4453.866384008485, 4461.643068554443, 4484.573965473275, 4663.114008338405], "value": 3997.454900227238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.56792539489174, 284.2226510493799, 288.62911159160484, 293.35901056192216, 295.6954337032856, 4878.9506558401, 4903.6322275829325, 4906.779194936227, 4917.0, 4945.6785308954895, 4596.35651008859, 4615.169269531483, 4644.3033544968275, 4710.163036415801, 4833.951660483394, 3704.7962362070075, 3704.833282502287, 3706.981465092684, 3790.8248442982626, 3809.657130858222, 3748.1566647504364, 3769.246150769857, 3802.828872700721, 3808.695304375657, 3810.6951443884564, 3650.7290539668634, 3784.867529636463, 3785.9432108518395, 3802.429635554661, 3805.450348266654, 3577.2308953575107, 3683.3922402803505, 3684.1158122050515, 3693.445983102529, 3776.414655728353, 3205.8877939272247, 3249.8537565809597, 3328.8502017409273, 3342.298117395326, 3350.949735753966, 4690.226112691402, 4692.817839704554, 4700.764961751933, 4713.835015774432, 4726.645501587361, 4015.19696060789, 4282.122164956177, 4298.688899885534, 4308.9353659695125, 4316.050468896838, 4952.62855285855, 5001.699898006095, 5001.7499125043605, 5004.9749751251375, 5021.874453138665, 3530.3645343838098, 3540.398132317512, 3541.3094446582927, 3544.769589976643, 3550.9112272193142, 5243.501867322599, 5272.604554658416, 5301.7084060376665, 5307.65500242483, 5315.176147697074, 3398.8300584970652, 3560.501529785832, 3604.9639503605154, 3613.9638603613625, 3623.673869351771, 3665.0654083209142, 3669.3395188865725, 3669.5229620149744, 3671.4125739881492, 3676.860173346218, 4207.537170911197, 4245.8513952011535, 4250.192463431938, 4252.574742525722, 4256.212600668886, 4817.0, 5019.548240658358, 5050.3939527256225, 5070.442251352349, 5078.873028174326, 1229.9077569182348, 1248.2510493703887, 1251.3180316727223, 1252.1610520950985, 1253.035162924543, 782.8473447677649, 799.6441583495289, 803.0122948773042, 825.529448214524, 826.1366871619052, 3996.2806694795217, 4004.2992476316526, 4011.438398624195, 4016.357382818793, 4030.5969403059457, 4611.239145541015, 4613.976930115328, 4617.238155704271, 4621.659718681612, 4629.8842528936375, 4024.5371782245415, 4030.5969403059457, 4032.233875563692, 4052.696047796427, 4063.6793042260792, 2505.649209110726, 2511.974880251211, 2594.4551644154562, 2750.514722050111, 2788.888444462199, 4954.504549545017, 4954.5540901319055, 4964.627652926045, 4985.700857948462, 4988.0, 5365.275687782178, 5377.569794416438, 5378.731063446812, 5379.004884096455, 5380.461953804588, 4698.483166851644, 4948.505149485023, 4980.203167493184, 4986.276989836381, 4988.251762235621, 5249.816256431007, 5251.737413129405, 5261.131913234427, 5277.630565860353, 5280.603954703336, 5180.844574662766, 5190.532852043334, 5194.558462530576, 5218.191180367049, 5236.136037553913, 4699.76501174933, 4932.778024988956, 4941.813964648531, 4964.106460837084, 4970.279309500174, 3738.1028553146507, 3755.455458958381, 3759.09781652396, 3769.6041915598466, 3783.791891445887, 5288.471152884681, 5302.151655735064, 5303.893922121613, 5310.814121505883, 5317.8404647860625, 4908.337374454403, 5039.370078740158, 5085.160948443466, 5087.084324821568, 5101.795928162832, 5079.568236699922, 5083.085044691991, 5086.491350864884, 5104.744762761921, 5109.335786347751, 4992.326035985096, 4998.875253068176, 5016.398032236009, 5017.347744793154, 5027.7737501813235, 4804.615630749601, 4822.397200349957, 4924.679895806761, 5068.163752980717, 5073.8731531712, 4968.037625138122, 4972.627052970969, 4980.377452818398, 4987.576056035277, 4989.0], "value": 3756.9687319080026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7692434564001, 586.7125108696739, 646.7154452041102, 657.6941722099223, 661.8047675935599, 12481.375931203449, 13212.0, 13326.067175297732, 13335.666608334797, 13659.795103073462, 13180.340982950862, 13501.257430841324, 13528.0, 13535.864641353584, 13539.932300338509, 611.101680529623, 751.6054071612406, 771.7376092128675, 774.9845003099935, 775.7440044785208, 626.0952923026206, 636.4717284653726, 636.9968150159243, 733.4975541753889, 765.2844590308052, 806.2139414071293, 812.5733989655419, 812.8740045292959, 813.1908750792969, 813.4305985809957, 807.11620775251, 809.5345176523523, 809.5587904592012, 810.0846043970334, 810.2909953790434, 467.44841087516716, 566.9801556945529, 581.4011568084879, 595.2589026661834, 596.1117934277938, 12138.575149869801, 12339.0, 12412.007039436823, 12602.495900163982, 12672.0, 11189.552417903275, 11283.266587671775, 11485.540578376855, 11544.653660390202, 11772.705682357924, 10851.403172825492, 10996.12031037523, 10996.615118470894, 11059.612913548068, 11326.603568875049, 3808.295465338921, 3808.90477738056, 3826.4642949987024, 3859.2667393195484, 3894.4547763312876, 67480.0, 68309.65845170742, 70239.64880175618, 71702.28297717008, 72696.0, 9325.580348884316, 9589.90410095904, 9595.664151754656, 9799.657012004545, 10102.747431314128, 18148.0, 18541.536461588297, 18544.629107417775, 18569.53576160607, 18593.90703046476, 6617.338266173344, 6622.139121914121, 6653.500987425962, 6767.966160169168, 6890.896636550456, 3530.0821786335223, 3552.0587044433246, 3584.19355644983, 3608.4948107265004, 3650.470681751184, 2885.2354126156583, 2983.9552406713915, 2999.1602351341658, 3020.3808219314988, 3024.5765592817024, 494.77487743077535, 497.5000124874478, 500.7195970256668, 505.91146549354454, 509.7986295413291, 538.3996843519526, 574.2936188488183, 574.4973148495067, 585.2830282903409, 589.3684697824235, 7147.2138064812825, 7186.532875363085, 7750.418718596128, 7868.409869259828, 8087.231712987257, 516.5867306155061, 523.5968304405586, 549.0419218463727, 561.9912257497801, 574.2821473158551, 3398.6091599465885, 3796.2217745362136, 3850.4994350734223, 3917.804109794499, 3983.7609743415487, 95647.0, 98516.50741746246, 99265.0, 101854.0, 103325.0, 68548.6572567134, 70393.64803175951, 70727.64636176787, 81971.0, 82982.0, 67816.0, 70907.64546177236, 72255.63872180606, 72772.0, 73736.63131684414, 7353.558786472829, 7754.224577542201, 7839.451238413257, 7863.84272314562, 7890.447668663139, 43461.78269108761, 43493.34759978666, 43579.34630980474, 43868.122637547705, 43965.78017109894, 59144.704276480064, 59396.703016484644, 62504.374956251675, 63959.6802015987, 66677.33322666906, 10247.821500527534, 10272.175151833306, 10277.9486102569, 10355.482225888825, 10624.36253824773, 11589.536418543164, 11624.0, 11808.763824723286, 11833.349165795964, 11854.229475084092, 10815.45922703846, 10894.727631809268, 10912.945435272773, 10976.23166378346, 11533.538658453903, 7420.369268612229, 9142.817143656957, 10382.169426446017, 10596.576136954744, 10715.089217416607, 10451.94774026125, 10465.16278697687, 10501.527431265764, 10645.946770266099, 10953.068989136013, 9438.38650487716, 9448.574814133242, 9777.706668799947, 9865.506724663881, 9929.156021737945, 9107.22588579978, 9699.66051188205, 9782.559784809559, 9853.753656158653, 9866.901330986599], "value": 6336.552250281221, "unit": "score"}], "name": "dromaeo_css", "value": 6269.755649047267, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 125.0, 178.0, 122.0, 129.0, 153.0, 128.0, 189.0, 123.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 163.0, 161.0, 161.0, 160.0, 176.0, 162.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 122.0, 75.0, 79.0, 76.0, 75.0, 102.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 84.0, 85.0, 85.0, 114.0, 85.0, 86.0, 144.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 62.0, 63.0, 61.0, 61.0, 63.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 81.0, 79.0, 80.0, 79.0, 79.0, 80.0, 81.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 135.0, 132.0, 147.0, 131.0, 134.0, 132.0, 166.0, 144.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 163.0, 172.0, 169.0, 164.0, 170.0, 164.0, 166.0, 163.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 67.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1537.4999999999998, "alertThreshold": 2.0}]} 10:25:36 INFO - Return code: 0 10:25:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:36 INFO - # TBPL SUCCESS # 10:25:36 INFO - Running post-action listener: _resource_record_post_action 10:25:36 INFO - [mozharness: 2016-07-31 17:25:36.365889Z] Finished run-tests step (success) 10:25:36 INFO - Running post-run listener: _resource_record_post_run 10:25:36 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538796032; Read time: 12; Write time: 578960 10:25:36 INFO - TinderboxPrint: CPU usage
13.0% 10:25:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:25:36 INFO - TinderboxPrint: I/O write bytes / time
538,796,032 / 578,960 10:25:36 INFO - TinderboxPrint: CPU idle
8,331.2 (87.0%) 10:25:36 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 10:25:36 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255115264; Read time: 0; Write time: 363420 10:25:36 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 283680768; Read time: 0; Write time: 215540 10:25:37 INFO - Running post-run listener: _upload_blobber_files 10:25:37 INFO - Blob upload gear active. 10:25:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:37 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 10:25:37 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'] 10:25:37 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 10:25:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:40 INFO - (blobuploader) - INFO - Done attempting. 10:25:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:41 INFO - (blobuploader) - INFO - Done attempting. 10:25:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:42 INFO - (blobuploader) - INFO - Done attempting. 10:25:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:42 INFO - Return code: 0 10:25:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d385ca9600c64bcaa9d9ac0d127ab72e57811b19e7547348cf34cd6ec5c91a69affe9cf4f3df92ddd875fd27edd4f2a7b89406b6d95ab71401edaacb562ce784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4171b5bdc2e8515ad5152445ee2a6e9b5b82faa7d3abf0aaf6773e5d3482f168a8e42baba74d12c3aabe30ab9e3b6384e3be2b754fa092ab865253b66ddbc18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/249378043823999874d10ee119349b4a1ac829a482fd68cff0fa4e835bfc7ebe800f74b4a4f9ef4be3685661835dcdddb6800c5724570031e8c99e9243b16862"} 10:25:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:42 INFO - Contents: 10:25:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d385ca9600c64bcaa9d9ac0d127ab72e57811b19e7547348cf34cd6ec5c91a69affe9cf4f3df92ddd875fd27edd4f2a7b89406b6d95ab71401edaacb562ce784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4171b5bdc2e8515ad5152445ee2a6e9b5b82faa7d3abf0aaf6773e5d3482f168a8e42baba74d12c3aabe30ab9e3b6384e3be2b754fa092ab865253b66ddbc18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/249378043823999874d10ee119349b4a1ac829a482fd68cff0fa4e835bfc7ebe800f74b4a4f9ef4be3685661835dcdddb6800c5724570031e8c99e9243b16862"} 10:25:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:42 INFO - Copying logs to upload dir... 10:25:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.974386 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-31 10:25:40.054961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 10:25:40.058794) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778 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/d385ca9600c64bcaa9d9ac0d127ab72e57811b19e7547348cf34cd6ec5c91a69affe9cf4f3df92ddd875fd27edd4f2a7b89406b6d95ab71401edaacb562ce784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4171b5bdc2e8515ad5152445ee2a6e9b5b82faa7d3abf0aaf6773e5d3482f168a8e42baba74d12c3aabe30ab9e3b6384e3be2b754fa092ab865253b66ddbc18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/249378043823999874d10ee119349b4a1ac829a482fd68cff0fa4e835bfc7ebe800f74b4a4f9ef4be3685661835dcdddb6800c5724570031e8c99e9243b16862"} build_url:https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/HBXpw2AnRmqYOCe63JspGA/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/d385ca9600c64bcaa9d9ac0d127ab72e57811b19e7547348cf34cd6ec5c91a69affe9cf4f3df92ddd875fd27edd4f2a7b89406b6d95ab71401edaacb562ce784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4171b5bdc2e8515ad5152445ee2a6e9b5b82faa7d3abf0aaf6773e5d3482f168a8e42baba74d12c3aabe30ab9e3b6384e3be2b754fa092ab865253b66ddbc18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/249378043823999874d10ee119349b4a1ac829a482fd68cff0fa4e835bfc7ebe800f74b4a4f9ef4be3685661835dcdddb6800c5724570031e8c99e9243b16862"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 10:25:40.086010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:25:40.086341) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469984323.490099-1855598778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:25:40.171043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 10:25:40.171363) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 10:25:40.171643) ========= ========= Total master_lag: 0.15 =========