builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1469763194.48 results: success (0) buildid: 20160728173009 builduid: 210f2180c8ee496099391e3a01a83db0 revision: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.478682) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.479240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.479513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.538841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.539118) ========= 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=523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 20:33:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.7M=0s 2016-07-28 20:33:14 (95.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.643185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.643497) ========= 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=523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017850 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.696491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:14.696818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2932bdab2bf7872c9cddac95d5d327e3c51a2784 --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 2932bdab2bf7872c9cddac95d5d327e3c51a2784 --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=523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 20:33:14,900 truncating revision to first 12 chars 2016-07-28 20:33:14,900 Setting DEBUG logging. 2016-07-28 20:33:14,900 attempt 1/10 2016-07-28 20:33:14,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2932bdab2bf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 20:33:15,207 unpacking tar archive at: fx-team-2932bdab2bf7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:15.345100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:15.345407) ========= script_repo_revision: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:15.345824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:15.346100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 20:33:15.354934) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-28 20:33:15.355208) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:33:15 INFO - MultiFileLogger online at 20160728 20:33:15 in /builds/slave/test 20:33:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:33:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:33:15 INFO - {'append_to_log': False, 20:33:15 INFO - 'base_work_dir': '/builds/slave/test', 20:33:15 INFO - 'blob_upload_branch': 'Fx-Team', 20:33:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:33:15 INFO - 'branch': 'Fx-Team', 20:33:15 INFO - 'buildbot_json_path': 'buildprops.json', 20:33:15 INFO - 'config_files': ('talos/linux_config.py',), 20:33:15 INFO - 'default_actions': ('clobber', 20:33:15 INFO - 'read-buildbot-config', 20:33:15 INFO - 'download-and-extract', 20:33:15 INFO - 'populate-webroot', 20:33:15 INFO - 'create-virtualenv', 20:33:15 INFO - 'install', 20:33:15 INFO - 'run-tests'), 20:33:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:33:15 INFO - 'download_minidump_stackwalk': True, 20:33:15 INFO - 'download_symbols': 'ondemand', 20:33:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:33:15 INFO - 'tooltool.py': '/tools/tooltool.py', 20:33:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:33:15 INFO - '/tools/misc-python/virtualenv.py')}, 20:33:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:33:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:33:15 INFO - 'installer_path': 'installer.exe', 20:33:15 INFO - 'log_level': 'info', 20:33:15 INFO - 'log_name': 'talos', 20:33:15 INFO - 'log_to_console': True, 20:33:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:33:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:33:15 INFO - 'opt_config_files': (), 20:33:15 INFO - 'pip_index': False, 20:33:15 INFO - 'sps_profile': False, 20:33:15 INFO - 'sps_profile_interval': 0, 20:33:15 INFO - 'suite': 'dromaeojs', 20:33:15 INFO - 'system_bits': '32', 20:33:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:33:15 INFO - 'title': 'talos-linux64-ix-065', 20:33:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:33:15 INFO - 'use_talos_json': True, 20:33:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:33:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:33:15 INFO - 'work_dir': 'build'} 20:33:15 INFO - [mozharness: 2016-07-29 03:33:15.651087Z] Running clobber step. 20:33:15 INFO - Running pre-action listener: _resource_record_pre_action 20:33:15 INFO - Running main action method: clobber 20:33:15 INFO - rmtree: /builds/slave/test/build 20:33:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:33:16 INFO - Running post-action listener: _resource_record_post_action 20:33:16 INFO - [mozharness: 2016-07-29 03:33:16.111605Z] Finished clobber step (success) 20:33:16 INFO - [mozharness: 2016-07-29 03:33:16.111705Z] Running read-buildbot-config step. 20:33:16 INFO - Running pre-action listener: _resource_record_pre_action 20:33:16 INFO - Running main action method: read_buildbot_config 20:33:16 INFO - Using buildbot properties: 20:33:16 INFO - { 20:33:16 INFO - "project": "", 20:33:16 INFO - "product": "firefox", 20:33:16 INFO - "script_repo_revision": "production", 20:33:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:33:16 INFO - "repository": "", 20:33:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:33:16 INFO - "buildid": "20160728173009", 20:33:16 INFO - "pgo_build": "True", 20:33:16 INFO - "basedir": "/builds/slave/test", 20:33:16 INFO - "buildnumber": 938, 20:33:16 INFO - "slavename": "talos-linux64-ix-065", 20:33:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:33:16 INFO - "platform": "ubuntu64_hw", 20:33:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:33:16 INFO - "branch": "fx-team", 20:33:16 INFO - "repo_path": "integration/fx-team", 20:33:16 INFO - "revision": "2932bdab2bf7872c9cddac95d5d327e3c51a2784", 20:33:16 INFO - "stage_platform": "linux64-pgo", 20:33:16 INFO - "builduid": "210f2180c8ee496099391e3a01a83db0", 20:33:16 INFO - "slavebuilddir": "test" 20:33:16 INFO - } 20:33:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:33:16 INFO - Running post-action listener: _resource_record_post_action 20:33:16 INFO - [mozharness: 2016-07-29 03:33:16.114147Z] Finished read-buildbot-config step (success) 20:33:16 INFO - [mozharness: 2016-07-29 03:33:16.114236Z] Running download-and-extract step. 20:33:16 INFO - Running pre-action listener: _resource_record_pre_action 20:33:16 INFO - Running main action method: download_and_extract 20:33:16 INFO - mkdir: /builds/slave/test/build/tests 20:33: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')]} 20:33:16 INFO - https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:33:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:33:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:33:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:22 INFO - Downloaded 1361 bytes. 20:33:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:33:22 INFO - Using the following test package requirements: 20:33:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:33:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:33:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'jsshell-linux-x86_64.zip'], 20:33:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:33:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:33:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:33:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:33:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:33:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:33:22 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')]} 20:33:22 INFO - https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:33:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:33:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:33:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:34 INFO - Downloaded 24320992 bytes. 20:33:34 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'] 20:33:34 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 20:33:35 INFO - Return code: 0 20:33:35 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 20:33: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')]} 20:33:35 INFO - https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:36 INFO - Downloaded 24320992 bytes. 20:33:36 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'] 20:33:36 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 20:33:37 INFO - Return code: 0 20:33:37 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')]} 20:33:37 INFO - https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:38 INFO - Downloaded 14413725 bytes. 20:33:38 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'] 20:33:38 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 20:33:39 INFO - Return code: 0 20:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:39 INFO - https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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 20:33:40 INFO - Downloaded 61023457 bytes. 20:33:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:33:40 INFO - mkdir: /builds/slave/test/properties 20:33:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:33:40 INFO - Writing to file /builds/slave/test/properties/build_url 20:33:40 INFO - Contents: 20:33:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:33:41 INFO - Running post-action listener: _resource_record_post_action 20:33:41 INFO - Running post-action listener: set_extra_try_arguments 20:33:41 INFO - [mozharness: 2016-07-29 03:33:41.152290Z] Finished download-and-extract step (success) 20:33:41 INFO - [mozharness: 2016-07-29 03:33:41.152526Z] Running populate-webroot step. 20:33:41 INFO - Running pre-action listener: _resource_record_pre_action 20:33:41 INFO - Running main action method: populate_webroot 20:33:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:33:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:33:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:33:41 INFO - '--tppagecycles', 20:33:41 INFO - '7'], 20:33:41 INFO - 'tests': ['tsvgm']}}, 20:33:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:33:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:33:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:33:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:33:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:33:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:33:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['damp', 'tps']}, 20:33:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'tests': ['damp', 'tps']}, 20:33:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['dromaeo_dom']}, 20:33:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:33:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['basic_compositor_video']}, 20:33:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:33:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['a11yr', 20:33:41 INFO - 'ts_paint', 20:33:41 INFO - 'tpaint', 20:33:41 INFO - 'sessionrestore', 20:33:41 INFO - 'sessionrestore_no_auto_restore', 20:33:41 INFO - 'tabpaint']}, 20:33:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:33:41 INFO - 'ts_paint', 20:33:41 INFO - 'tpaint', 20:33:41 INFO - 'sessionrestore', 20:33:41 INFO - 'sessionrestore_no_auto_restore', 20:33:41 INFO - 'tabpaint']}, 20:33:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:33:41 INFO - 'ts_paint', 20:33:41 INFO - 'tpaint', 20:33:41 INFO - 'sessionrestore', 20:33:41 INFO - 'sessionrestore_no_auto_restore', 20:33:41 INFO - 'tabpaint']}, 20:33:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:33:41 INFO - 'ts_paint', 20:33:41 INFO - 'tpaint', 20:33:41 INFO - 'sessionrestore', 20:33:41 INFO - 'sessionrestore_no_auto_restore', 20:33:41 INFO - 'tabpaint']}, 20:33:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['a11yr', 20:33:41 INFO - 'ts_paint', 20:33:41 INFO - 'tpaint', 20:33:41 INFO - 'sessionrestore', 20:33:41 INFO - 'sessionrestore_no_auto_restore', 20:33:41 INFO - 'tabpaint']}, 20:33:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['a11yr', 20:33:41 INFO - 'ts_paint', 20:33:41 INFO - 'tpaint', 20:33:41 INFO - 'sessionrestore', 20:33:41 INFO - 'sessionrestore_no_auto_restore', 20:33:41 INFO - 'tabpaint']}, 20:33:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['tsvgx', 20:33:41 INFO - 'tsvgr_opacity', 20:33:41 INFO - 'tart', 20:33:41 INFO - 'tscrollx', 20:33:41 INFO - 'cart']}, 20:33:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:33:41 INFO - 'tsvgr_opacity', 20:33:41 INFO - 'tart', 20:33:41 INFO - 'tscrollx', 20:33:41 INFO - 'cart']}, 20:33:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'talos_options': ['--disable-e10s'], 20:33:41 INFO - 'tests': ['tp5o']}, 20:33:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'tests': ['tp5o']}, 20:33:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'talos_options': ['--disable-e10s', 20:33:41 INFO - '--xperf_path', 20:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:33:41 INFO - 'tests': ['tp5n']}, 20:33:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:41 INFO - 'talos_options': ['--xperf_path', 20:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:33:41 INFO - 'tests': ['tp5n']}}, 20:33:41 INFO - 'talos.zip': {'path': '', 20:33:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:33:41 INFO - Running post-action listener: _resource_record_post_action 20:33:41 INFO - [mozharness: 2016-07-29 03:33:41.171795Z] Finished populate-webroot step (success) 20:33:41 INFO - [mozharness: 2016-07-29 03:33:41.171884Z] Running create-virtualenv step. 20:33:41 INFO - Running pre-action listener: _resource_record_pre_action 20:33:41 INFO - Running main action method: create_virtualenv 20:33:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:33:41 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 20:33:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:33:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:33:41 INFO - Using real prefix '/usr' 20:33:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:33:41 INFO - Installing distribute.............................................................................................................................................................................................done. 20:33:43 INFO - Installing pip.................done. 20:33:43 INFO - Return code: 0 20:33:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:33:43 INFO - Using env: {'DISPLAY': ':0', 20:33:43 INFO - 'HOME': '/home/cltbld', 20:33:43 INFO - 'LANG': 'en_US.UTF-8', 20:33:43 INFO - 'LANGUAGE': 'en_US:en', 20:33:43 INFO - 'LOGNAME': 'cltbld', 20:33:43 INFO - 'MAIL': '/var/mail/cltbld', 20:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:43 INFO - 'MOZ_NO_REMOTE': '1', 20:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:43 INFO - 'NO_EM_RESTART': '1', 20:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:43 INFO - 'PWD': '/builds/slave/test', 20:33:43 INFO - 'SHELL': '/bin/bash', 20:33:43 INFO - 'SHLVL': '1', 20:33:43 INFO - 'TERM': 'linux', 20:33:43 INFO - 'TMOUT': '86400', 20:33:43 INFO - 'USER': 'cltbld', 20:33:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:43 INFO - '_': '/tools/buildbot/bin/python'} 20:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:43 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 20:33:43 INFO - Cleaning up... 20:33:44 INFO - Return code: 0 20:33:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:33:44 INFO - Using env: {'DISPLAY': ':0', 20:33:44 INFO - 'HOME': '/home/cltbld', 20:33:44 INFO - 'LANG': 'en_US.UTF-8', 20:33:44 INFO - 'LANGUAGE': 'en_US:en', 20:33:44 INFO - 'LOGNAME': 'cltbld', 20:33:44 INFO - 'MAIL': '/var/mail/cltbld', 20:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:44 INFO - 'MOZ_NO_REMOTE': '1', 20:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:44 INFO - 'NO_EM_RESTART': '1', 20:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:44 INFO - 'PWD': '/builds/slave/test', 20:33:44 INFO - 'SHELL': '/bin/bash', 20:33:44 INFO - 'SHLVL': '1', 20:33:44 INFO - 'TERM': 'linux', 20:33:44 INFO - 'TMOUT': '86400', 20:33:44 INFO - 'USER': 'cltbld', 20:33:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:44 INFO - '_': '/tools/buildbot/bin/python'} 20:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:44 INFO - Downloading/unpacking psutil>=3.1.1 20:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:33:46 INFO - Installing collected packages: psutil 20:33:46 INFO - Running setup.py install for psutil 20:33:46 INFO - building 'psutil._psutil_linux' extension 20:33:46 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 20:33:46 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 20:33:46 INFO - building 'psutil._psutil_posix' extension 20:33:46 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 20:33:46 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 20:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:33:46 INFO - Successfully installed psutil 20:33:46 INFO - Cleaning up... 20:33:46 INFO - Return code: 0 20:33:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:33:46 INFO - Using env: {'DISPLAY': ':0', 20:33:46 INFO - 'HOME': '/home/cltbld', 20:33:46 INFO - 'LANG': 'en_US.UTF-8', 20:33:46 INFO - 'LANGUAGE': 'en_US:en', 20:33:46 INFO - 'LOGNAME': 'cltbld', 20:33:46 INFO - 'MAIL': '/var/mail/cltbld', 20:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:46 INFO - 'MOZ_NO_REMOTE': '1', 20:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:46 INFO - 'NO_EM_RESTART': '1', 20:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:46 INFO - 'PWD': '/builds/slave/test', 20:33:46 INFO - 'SHELL': '/bin/bash', 20:33:46 INFO - 'SHLVL': '1', 20:33:46 INFO - 'TERM': 'linux', 20:33:46 INFO - 'TMOUT': '86400', 20:33:46 INFO - 'USER': 'cltbld', 20:33:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:46 INFO - '_': '/tools/buildbot/bin/python'} 20:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:33:48 INFO - Installing collected packages: mozsystemmonitor 20:33:48 INFO - Running setup.py install for mozsystemmonitor 20:33:49 INFO - Successfully installed mozsystemmonitor 20:33:49 INFO - Cleaning up... 20:33:49 INFO - Return code: 0 20:33:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:33:49 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')]} 20:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:49 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')]} 20:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:49 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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:49 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 20:33:49 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 20:33:49 INFO - Using env: {'DISPLAY': ':0', 20:33:49 INFO - 'HOME': '/home/cltbld', 20:33:49 INFO - 'LANG': 'en_US.UTF-8', 20:33:49 INFO - 'LANGUAGE': 'en_US:en', 20:33:49 INFO - 'LOGNAME': 'cltbld', 20:33:49 INFO - 'MAIL': '/var/mail/cltbld', 20:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:49 INFO - 'MOZ_NO_REMOTE': '1', 20:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:49 INFO - 'NO_EM_RESTART': '1', 20:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:49 INFO - 'PWD': '/builds/slave/test', 20:33:49 INFO - 'SHELL': '/bin/bash', 20:33:49 INFO - 'SHLVL': '1', 20:33:49 INFO - 'TERM': 'linux', 20:33:49 INFO - 'TMOUT': '86400', 20:33:49 INFO - 'USER': 'cltbld', 20:33:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:49 INFO - '_': '/tools/buildbot/bin/python'} 20:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:49 INFO - Downloading/unpacking jsonschema==2.5.1 20:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:33:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:33:51 INFO - warning: no files found matching '*.txt' 20:33:51 INFO - no previously-included directories found matching 'build' 20:33:51 INFO - no previously-included directories found matching 'dist' 20:33:51 INFO - no previously-included directories found matching '.git*' 20:33:51 INFO - Installing collected packages: jsonschema, functools32 20:33:51 INFO - Running setup.py install for functools32 20:33:51 INFO - warning: no files found matching '*.txt' 20:33:51 INFO - no previously-included directories found matching 'build' 20:33:51 INFO - no previously-included directories found matching 'dist' 20:33:51 INFO - no previously-included directories found matching '.git*' 20:33:51 INFO - Successfully installed jsonschema functools32 20:33:51 INFO - Cleaning up... 20:33:51 INFO - Return code: 0 20:33:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:33: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')]} 20:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33: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')]} 20:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:51 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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:51 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 20:33:51 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 20:33:51 INFO - Using env: {'DISPLAY': ':0', 20:33:51 INFO - 'HOME': '/home/cltbld', 20:33:51 INFO - 'LANG': 'en_US.UTF-8', 20:33:51 INFO - 'LANGUAGE': 'en_US:en', 20:33:51 INFO - 'LOGNAME': 'cltbld', 20:33:51 INFO - 'MAIL': '/var/mail/cltbld', 20:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:51 INFO - 'MOZ_NO_REMOTE': '1', 20:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:51 INFO - 'NO_EM_RESTART': '1', 20:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:51 INFO - 'PWD': '/builds/slave/test', 20:33:51 INFO - 'SHELL': '/bin/bash', 20:33:51 INFO - 'SHLVL': '1', 20:33:51 INFO - 'TERM': 'linux', 20:33:51 INFO - 'TMOUT': '86400', 20:33:51 INFO - 'USER': 'cltbld', 20:33:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:51 INFO - '_': '/tools/buildbot/bin/python'} 20:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:33:52 INFO - Cleaning up... 20:33:52 INFO - Return code: 0 20:33:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:33:52 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')]} 20:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:52 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')]} 20:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:52 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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:52 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 20:33:52 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 20:33:52 INFO - Using env: {'DISPLAY': ':0', 20:33:52 INFO - 'HOME': '/home/cltbld', 20:33:52 INFO - 'LANG': 'en_US.UTF-8', 20:33:52 INFO - 'LANGUAGE': 'en_US:en', 20:33:52 INFO - 'LOGNAME': 'cltbld', 20:33:52 INFO - 'MAIL': '/var/mail/cltbld', 20:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:52 INFO - 'MOZ_NO_REMOTE': '1', 20:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:52 INFO - 'NO_EM_RESTART': '1', 20:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:52 INFO - 'PWD': '/builds/slave/test', 20:33:52 INFO - 'SHELL': '/bin/bash', 20:33:52 INFO - 'SHLVL': '1', 20:33:52 INFO - 'TERM': 'linux', 20:33:52 INFO - 'TMOUT': '86400', 20:33:52 INFO - 'USER': 'cltbld', 20:33:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:52 INFO - '_': '/tools/buildbot/bin/python'} 20:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:54 INFO - Downloading blobuploader-1.2.4.tar.gz 20:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:33:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:33:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:54 INFO - Downloading docopt-0.6.1.tar.gz 20:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:33:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:33:54 INFO - Running setup.py install for blobuploader 20:33:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:33:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:33:55 INFO - Running setup.py install for requests 20:33:55 INFO - Running setup.py install for docopt 20:33:55 INFO - Successfully installed blobuploader requests docopt 20:33:55 INFO - Cleaning up... 20:33:55 INFO - Return code: 0 20:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:33:55 INFO - Using env: {'DISPLAY': ':0', 20:33:55 INFO - 'HOME': '/home/cltbld', 20:33:55 INFO - 'LANG': 'en_US.UTF-8', 20:33:55 INFO - 'LANGUAGE': 'en_US:en', 20:33:55 INFO - 'LOGNAME': 'cltbld', 20:33:55 INFO - 'MAIL': '/var/mail/cltbld', 20:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:55 INFO - 'MOZ_NO_REMOTE': '1', 20:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:55 INFO - 'NO_EM_RESTART': '1', 20:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:55 INFO - 'PWD': '/builds/slave/test', 20:33:55 INFO - 'SHELL': '/bin/bash', 20:33:55 INFO - 'SHLVL': '1', 20:33:55 INFO - 'TERM': 'linux', 20:33:55 INFO - 'TMOUT': '86400', 20:33:55 INFO - 'USER': 'cltbld', 20:33:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:55 INFO - '_': '/tools/buildbot/bin/python'} 20:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:33:55 INFO - Running setup.py (path:/tmp/pip-nANBq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:33:55 INFO - Running setup.py (path:/tmp/pip-yOUKbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:33:55 INFO - Running setup.py (path:/tmp/pip-fuS4Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:33:55 INFO - Running setup.py (path:/tmp/pip-x_UYM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:33:56 INFO - Running setup.py (path:/tmp/pip-LwOMu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:33:56 INFO - Running setup.py (path:/tmp/pip-aBmkjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:33:56 INFO - Running setup.py (path:/tmp/pip-a1Y6Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:33:56 INFO - Running setup.py (path:/tmp/pip-IdJCZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:33:56 INFO - Running setup.py (path:/tmp/pip-XSFlVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:33:56 INFO - Running setup.py (path:/tmp/pip-fUFFKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:33:56 INFO - Running setup.py (path:/tmp/pip-KbV0N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:33:56 INFO - Running setup.py (path:/tmp/pip-2FrvUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:33:56 INFO - Running setup.py (path:/tmp/pip-I5lXFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:33:56 INFO - Running setup.py (path:/tmp/pip-pxTSyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:33:56 INFO - Running setup.py (path:/tmp/pip-QY5Wu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:33:56 INFO - Running setup.py (path:/tmp/pip-6fm0Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:33:56 INFO - Running setup.py (path:/tmp/pip-FNM9fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:33:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:33:56 INFO - Running setup.py install for manifestparser 20:33:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozcrash 20:33:57 INFO - Running setup.py install for mozdebug 20:33:57 INFO - Running setup.py install for mozdevice 20:33:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozfile 20:33:57 INFO - Running setup.py install for mozhttpd 20:33:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozinfo 20:33:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozInstall 20:33:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozleak 20:33:57 INFO - Running setup.py install for mozlog 20:33:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Running setup.py install for moznetwork 20:33:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Running setup.py install for mozprocess 20:33:58 INFO - Running setup.py install for mozprofile 20:33:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Running setup.py install for mozrunner 20:33:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Running setup.py install for mozscreenshot 20:33:58 INFO - Running setup.py install for moztest 20:33:58 INFO - Running setup.py install for mozversion 20:33:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:33:58 INFO - Cleaning up... 20:33:58 INFO - Return code: 0 20:33:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:33:58 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 20:33:58 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 20:33:58 INFO - Using env: {'DISPLAY': ':0', 20:33:58 INFO - 'HOME': '/home/cltbld', 20:33:58 INFO - 'LANG': 'en_US.UTF-8', 20:33:58 INFO - 'LANGUAGE': 'en_US:en', 20:33:58 INFO - 'LOGNAME': 'cltbld', 20:33:58 INFO - 'MAIL': '/var/mail/cltbld', 20:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:58 INFO - 'MOZ_NO_REMOTE': '1', 20:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:58 INFO - 'NO_EM_RESTART': '1', 20:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:58 INFO - 'PWD': '/builds/slave/test', 20:33:58 INFO - 'SHELL': '/bin/bash', 20:33:58 INFO - 'SHLVL': '1', 20:33:58 INFO - 'TERM': 'linux', 20:33:58 INFO - 'TMOUT': '86400', 20:33:58 INFO - 'USER': 'cltbld', 20:33:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:58 INFO - '_': '/tools/buildbot/bin/python'} 20:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:33:58 INFO - Running setup.py (path:/tmp/pip-EIUavp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:33:59 INFO - Running setup.py (path:/tmp/pip-IOtAoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:33:59 INFO - Running setup.py (path:/tmp/pip-fOCvcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:33:59 INFO - Running setup.py (path:/tmp/pip-wixg4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:33:59 INFO - Running setup.py (path:/tmp/pip-UMLPhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:33:59 INFO - Running setup.py (path:/tmp/pip-Eu6v1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:33:59 INFO - Running setup.py (path:/tmp/pip-h7bkdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:33:59 INFO - Running setup.py (path:/tmp/pip-DKTM0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:33:59 INFO - Running setup.py (path:/tmp/pip-iHxnW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:33:59 INFO - Running setup.py (path:/tmp/pip-8DOoxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:33:59 INFO - Running setup.py (path:/tmp/pip-EfViMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:33:59 INFO - Running setup.py (path:/tmp/pip-OxDqt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:33:59 INFO - Running setup.py (path:/tmp/pip-vTNe8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:33:59 INFO - Running setup.py (path:/tmp/pip-8OxQwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:00 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)) 20:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:00 INFO - Running setup.py (path:/tmp/pip-5pYW4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:00 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)) 20:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:00 INFO - Running setup.py (path:/tmp/pip-Fl3QAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:00 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)) 20:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:00 INFO - Running setup.py (path:/tmp/pip-eXeCIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:00 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)) 20:34:00 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)) 20:34:00 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)) 20:34:00 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)) 20:34:00 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)) 20:34:00 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)) 20:34:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:00 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 20:34:00 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 20:34:00 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 20:34:00 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 20:34:00 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 20:34:00 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 20:34:02 INFO - Downloading blessings-1.6.tar.gz 20:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:34:02 INFO - Installing collected packages: blessings 20:34:02 INFO - Running setup.py install for blessings 20:34:02 INFO - Successfully installed blessings 20:34:02 INFO - Cleaning up... 20:34:02 INFO - Return code: 0 20:34:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:02 INFO - Reading from file tmpfile_stdout 20:34:02 INFO - Current package versions: 20:34:02 INFO - argparse == 1.2.1 20:34:02 INFO - blessings == 1.6 20:34:02 INFO - blobuploader == 1.2.4 20:34:02 INFO - docopt == 0.6.1 20:34:02 INFO - functools32 == 3.2.3-2 20:34:02 INFO - jsonschema == 2.5.1 20:34:02 INFO - manifestparser == 1.1 20:34:02 INFO - mozInstall == 1.12 20:34:02 INFO - mozcrash == 0.17 20:34:02 INFO - mozdebug == 0.1 20:34:02 INFO - mozdevice == 0.48 20:34:02 INFO - mozfile == 1.2 20:34:02 INFO - mozhttpd == 0.7 20:34:02 INFO - mozinfo == 0.9 20:34:02 INFO - mozleak == 0.1 20:34:02 INFO - mozlog == 3.3 20:34:02 INFO - moznetwork == 0.27 20:34:02 INFO - mozprocess == 0.23 20:34:02 INFO - mozprofile == 0.28 20:34:02 INFO - mozrunner == 6.12 20:34:02 INFO - mozscreenshot == 0.1 20:34:02 INFO - mozsystemmonitor == 0.3 20:34:02 INFO - moztest == 0.7 20:34:02 INFO - mozversion == 1.4 20:34:02 INFO - psutil == 3.1.1 20:34:02 INFO - requests == 1.2.3 20:34:02 INFO - wsgiref == 0.1.2 20:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:02 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')]} 20:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 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')]} 20:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:34:02 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 20:34:02 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 20:34:02 INFO - Using env: {'DISPLAY': ':0', 20:34:02 INFO - 'HOME': '/home/cltbld', 20:34:02 INFO - 'LANG': 'en_US.UTF-8', 20:34:02 INFO - 'LANGUAGE': 'en_US:en', 20:34:02 INFO - 'LOGNAME': 'cltbld', 20:34:02 INFO - 'MAIL': '/var/mail/cltbld', 20:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:02 INFO - 'MOZ_NO_REMOTE': '1', 20:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:02 INFO - 'NO_EM_RESTART': '1', 20:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:02 INFO - 'PWD': '/builds/slave/test', 20:34:02 INFO - 'SHELL': '/bin/bash', 20:34:02 INFO - 'SHLVL': '1', 20:34:02 INFO - 'TERM': 'linux', 20:34:02 INFO - 'TMOUT': '86400', 20:34:02 INFO - 'USER': 'cltbld', 20:34:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:02 INFO - '_': '/tools/buildbot/bin/python'} 20:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 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)) 20:34:02 INFO - Cleaning up... 20:34:02 INFO - Return code: 0 20:34:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:34:02 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')]} 20:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 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')]} 20:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 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 0xe1d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, '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': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', '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 20:34:02 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 20:34:02 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 20:34:02 INFO - Using env: {'DISPLAY': ':0', 20:34:02 INFO - 'HOME': '/home/cltbld', 20:34:02 INFO - 'LANG': 'en_US.UTF-8', 20:34:02 INFO - 'LANGUAGE': 'en_US:en', 20:34:02 INFO - 'LOGNAME': 'cltbld', 20:34:02 INFO - 'MAIL': '/var/mail/cltbld', 20:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:02 INFO - 'MOZ_NO_REMOTE': '1', 20:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:02 INFO - 'NO_EM_RESTART': '1', 20:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:02 INFO - 'PWD': '/builds/slave/test', 20:34:02 INFO - 'SHELL': '/bin/bash', 20:34:02 INFO - 'SHLVL': '1', 20:34:02 INFO - 'TERM': 'linux', 20:34:02 INFO - 'TMOUT': '86400', 20:34:02 INFO - 'USER': 'cltbld', 20:34:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:02 INFO - '_': '/tools/buildbot/bin/python'} 20:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:34:02 INFO - Cleaning up... 20:34:03 INFO - Return code: 0 20:34:03 INFO - Running post-action listener: _resource_record_post_action 20:34:03 INFO - Running post-action listener: _start_resource_monitoring 20:34:03 INFO - Starting resource monitoring. 20:34:03 INFO - [mozharness: 2016-07-29 03:34:03.027903Z] Finished create-virtualenv step (success) 20:34:03 INFO - [mozharness: 2016-07-29 03:34:03.028331Z] Running install step. 20:34:03 INFO - Running pre-action listener: _resource_record_pre_action 20:34:03 INFO - Running main action method: install 20:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:03 INFO - Reading from file tmpfile_stdout 20:34:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:34:03 INFO - Reading from file tmpfile_stdout 20:34:03 INFO - Output received: 20:34:03 INFO - Usage: mozinstall [options] installer 20:34:03 INFO - Options: 20:34:03 INFO - -h, --help show this help message and exit 20:34:03 INFO - -d DEST, --destination=DEST 20:34:03 INFO - Directory to install application into. [default: 20:34:03 INFO - "/builds/slave/test"] 20:34:03 INFO - --app=APP Application being installed. [default: firefox] 20:34:03 INFO - mkdir: /builds/slave/test/build/application 20:34:03 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'] 20:34:03 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 20:34:20 INFO - Reading from file tmpfile_stdout 20:34:20 INFO - Output received: 20:34:20 INFO - /builds/slave/test/build/application/firefox/firefox 20:34:20 INFO - Running post-action listener: _resource_record_post_action 20:34:20 INFO - [mozharness: 2016-07-29 03:34:20.830510Z] Finished install step (success) 20:34:20 INFO - [mozharness: 2016-07-29 03:34:20.830662Z] Running run-tests step. 20:34:20 INFO - Running pre-action listener: _resource_record_pre_action 20:34:20 INFO - Running main action method: run_tests 20:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:34:20 INFO - Python 2.7.3 20:34:20 INFO - Return code: 0 20:34:20 INFO - grabbing minidump binary from tooltool 20:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:34:20 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 0x10dc3b0>, '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 0x10dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:34:20 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 20:34:20 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 20:34:20 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 20:34:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:34:20 INFO - Return code: 0 20:34:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:34:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:34:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:34:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:34:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 20:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 20:34:20 INFO - Using env: {'DISPLAY': ':0', 20:34:20 INFO - 'HOME': '/home/cltbld', 20:34:20 INFO - 'LANG': 'en_US.UTF-8', 20:34:20 INFO - 'LANGUAGE': 'en_US:en', 20:34:20 INFO - 'LOGNAME': 'cltbld', 20:34:20 INFO - 'MAIL': '/var/mail/cltbld', 20:34:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:34:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:20 INFO - 'MOZ_NO_REMOTE': '1', 20:34:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:20 INFO - 'NO_EM_RESTART': '1', 20:34:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:20 INFO - 'PWD': '/builds/slave/test', 20:34:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:34:20 INFO - 'SHELL': '/bin/bash', 20:34:20 INFO - 'SHLVL': '1', 20:34:20 INFO - 'TERM': 'linux', 20:34:20 INFO - 'TMOUT': '86400', 20:34:20 INFO - 'USER': 'cltbld', 20:34:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138', 20:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:20 INFO - '_': '/tools/buildbot/bin/python'} 20:34:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 20:34:21 INFO - mozversion application_buildid: 20160728173009 20:34:21 INFO - mozversion application_changeset: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 20:34:21 INFO - mozversion application_display_name: Nightly 20:34:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:34:21 INFO - mozversion application_name: Firefox 20:34:21 INFO - mozversion application_remotingname: firefox 20:34:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:34:21 INFO - mozversion application_vendor: Mozilla 20:34:21 INFO - mozversion application_version: 50.0a1 20:34:21 INFO - mozversion platform_buildid: 20160728173009 20:34:21 INFO - mozversion platform_changeset: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 20:34:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:34:21 INFO - mozversion platform_version: 50.0a1 20:34:21 INFO - using testdate: 1469763261 20:34:21 INFO - actual date: 1469763261 20:34:21 INFO - starting webserver on 'localhost:46634' 20:34:21 INFO - SUITE-START | Running 2 tests 20:34:21 INFO - TEST-START | dromaeo_css 20:34:21 INFO - operating with platform_type : linux_ 20:34:21 INFO - Initialising browser for dromaeo_css test... 20:34:21 INFO - TEST-INFO | started process 4908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuUVN03/profile http://localhost:46634/getInfo.html) 20:34:24 INFO - PROCESS | 4908 | JavaScript error: , line 0: uncaught exception: undefined 20:34:25 INFO - PROCESS | 4908 | __metrics Screen width/height:1600/1200 20:34:25 INFO - PROCESS | 4908 | colorDepth:24 20:34:25 INFO - PROCESS | 4908 | Browser inner width/height: 1024/697 20:34:25 INFO - PROCESS | 4908 | __metrics 20:34:27 INFO - PROCESS | 4908 | 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" 20:34:27 INFO - PROCESS | 4908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:34:28 INFO - TEST-INFO | 4908: exit 0 20:34:28 INFO - Browser initialized. 20:34:28 INFO - Running cycle 1/1 for dromaeo_css test... 20:34:28 INFO - TEST-INFO | started process 4989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuUVN03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:40 INFO - PROCESS | 4989 | RSS: Main: 158535680 20:34:40 INFO - PROCESS | 4989 | 20:35:30 INFO - PROCESS | 4989 | 1469763330856 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] 20:37:39 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46634/tests/dromaeo/cssquery-ext.html) 20:37:41 INFO - PROCESS | 4989 | RSS: Main: 260505600 20:37:41 INFO - PROCESS | 4989 | 20:40:43 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-ext.html (next: http://localhost:46634/tests/dromaeo/cssquery-jquery.html) 20:40:44 INFO - PROCESS | 4989 | RSS: Main: 241217536 20:40:44 INFO - PROCESS | 4989 | 20:43:46 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46634/tests/dromaeo/cssquery-mootools.html) 20:43:46 INFO - PROCESS | 4989 | RSS: Main: 186478592 20:43:46 INFO - PROCESS | 4989 | 20:46:48 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46634/tests/dromaeo/cssquery-prototype.html) 20:46:49 INFO - PROCESS | 4989 | RSS: Main: 186126336 20:46:49 INFO - PROCESS | 4989 | 20:49:51 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46634/tests/dromaeo/cssquery-yui.html) 20:49:52 INFO - PROCESS | 4989 | RSS: Main: 187088896 20:49:52 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-yui.html (next: http://localhost:46634/tests/dromaeo/cssquery-dojo.html) 20:52:55 INFO - PROCESS | 4989 | RSS: Main: 276938752 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | __start_tp_report 20:52:55 INFO - PROCESS | 4989 | _x_x_mozilla_page_load 20:52:55 INFO - PROCESS | 4989 | _x_x_mozilla_page_load_details 20:52:55 INFO - PROCESS | 4989 | |i|pagename|runs| 20:52:55 INFO - PROCESS | 4989 | |0;dojo.html;3020.1241639924424;3025.7881948263625;3045.5279431688095;3064.3258483133704;3074.538819177123;5101.744912754357;5155.871103222421;5217.582593392524;5313.0967735484965;5340.279062326589;5268.841934741954;5320.787168513255;5346;5348.839534813952;5397.433269506704;4741.786619602126;4824.493428190042;4831.975840120795;4839.637027222955;4987.401511818569;4906.9263961040615;4915.5821755150855;4941.579965702919;4952.752362381884;4963.553280204781;4748.406449193868;4748.620110391161;4764.475907650156;4783.952160478386;4861.635377346695;4758.1673207188605;4764.499727528629;4770.499097594772;4775.092732380871;4871.683340582851;4764.976175119137;4796.544328288842;4806.206975848981;4807.6394270429855;4841.249606310992;5151.227315902607;5307.044731948247;5337.786488540453;5369.677819330853;5370.570354371641;5774.335951365605;5784.248047753765;5804.100364443518;5809.331926828427;5824.621399609055;5813.360530341659;5837.445442682981;5854.326752423483;5865.560082993792;5873.060310350366;5171.4311425743135;5264.631475796696;5314.654547454442;5319.335083114611;5403.756830942617;5911.024680927685;5920.615160014671;5927.081302398049;5927.851803704942;5928.466438020512;5635.492805647511;5688.800891968761;5695.145728140729;5696.743646535916;5701.743421546041;5519.558435325164;5612.607117501817;5617.662940223599;5670.829875103754;5671.943280567141;5682.062459694187;5746.9425305747245;5765.85585360361;5797.681127538026;5808.94191058084;5707.200991861143;5720.713964301768;5735.2257445245195;5750.654960702288;5755.6834374108985;4268.957310426918;4288.935665965013;4427.40230068943;4432.246518091868;4480.372747815309;3890.5525864525375;3919.0790164311366;3923.74495657787;3934.6852251819787;4009.2382447334912;5418.972905135449;5456.127019676912;5458.918116228259;5461.0716178249795;5505.366882808448;5518.475744804237;5796.42035796417;5797.536197104221;5803.7968671096305;5835.387284335168;5300.469953004668;5369.892602147936;5370.516653501126;5405.486478784509;5450.155225939986;4951.876203094951;4959.479254678279;4961.330220420197;4965.162418120497;5007.173816320339;5777.971110144506;5860;5919.792807251725;5921.526277897844;5921.5558833086825;5598.524125449219;5601.439856014366;5620.213170156099;5621.634593751557;5671.347795003628;5905.114232864933;5908.852278692895;5912;5912.438318359749;5912.911306330322;5426.294581704353;5540.944590554042;5592.692401917933;5603.159526071122;5605.32736071674;5693.544516438592;5710.600257982068;5728.112142617901;5743.971280143573;5761.452661997104;5514.669119852661;5553.6390134641115;5557.055300598827;5559.33288005442;5565.276514053147;5383.5962302826665;5531.778728850801;5544.112941929272;5548.389677135593;5590.608657394106;5387.299651045339;5439.728013599225;5444.3194600674915;5480.6437581557075;5522.806701765419;5574.9442505574425;5608.46719561641;5663.32040155184;5666.17840413146;5668.064769313182;5391.784328626811;5471.370792358771;5477.561795056306;5477.863053423696;5480.945190548044 20:52:55 INFO - PROCESS | 4989 | |1;ext.html;580.9070548712207;599.5233789137635;616.9753209871604;626.7806267806266;628.0171531553116;43504.12991740163;44263.77868110663;44349;44363.33454998174;47946.52053479473;45891.541084589146;46207.768961155234;46272.30591541129;46334;46385.304220436636;8888.644454221823;9022.413543119708;9025.638974441015;9027.548622568846;9036.909630903672;8947.821043579124;9040.321975851804;9048.049954754755;9061.864072038925;9069.183773460387;9050.366474346798;9099;9110.726678199664;9111.726648200565;9115.22520585751;9043.864342034874;9056.501892395916;9075.092490750905;9089.454632722058;9100.044495328028;9082.364234503588;9143.862842057375;9147.451152930846;9147.634094636207;9151.313651476166;43103.35344969828;43273;43445;43455.56544434547;43477;3477.9652203477895;3603.549556305462;3637.5998640149564;3657.487951686766;4142.627163555295;32075.6792432075;32256.677433225603;32997.83501082503;33225.840320379095;33879.153021174425;4250.978745106286;4327.7619730914785;4343.348497725335;4407.338899165119;4600.35595016698;370693;371320;371467.14266428765;371519;372078.99999999726;55984.72007639936;56134.43865561374;56142;56189.31432057045;56214.43785562174;51161.744191278805;57431.425685743445;59352.40647593555;59503.70248148818;59568;14939;15795.763063554055;15835.366585336687;15840.207989600474;15874.682506349809;12136.939315303367;12199;12199.024078073733;12202.389880506116;12208.816867746991;14080.436782528788;15170.165640889856;15674.68650626981;15707.528774136794;15812.762808557882;5705.258316418922;5713.657180569179;5733.598648094677;5759.85600359986;5896.6756828374855;1000.9099181073739;1011.0445628880638;1021.7854250607307;1079.7624522605015;1098.8846171152074;31498.842505787325;31919.680803192135;32027.51958720621;32034.519482207786;32350.191245218586;1055.963041293551;1077.5097330714507;1080.9135269178446;1090.7109615951779;1102.2945314998408;16428.589285267964;16907.57731056709;16925.322987080624;16944.57638559046;16975;533593;535178;535801;538155;538582;58570;58678.066096694994;58736;58813.117803232984;58841.70579147163;1235.4810979388678;1280.5454063807215;1292.3409061378763;1320.7094439223356;1330.035724100039;29884.402311953203;30810;31579.84210079027;31672;32090.35819283648;50923.490765091876;55206.44793552174;56235;56371.15443268272;59845.40154598398;370193;376376;378583;383496;384087;23153.76846231516;26966.32584185411;27186.592201117393;27335.72664273332;27645;42937;45679.172833086304;48234.27648585344;48500.2724959133;49481.50518494913;38771;40273.79863100783;40690.79654601708;41037;42573;41250;41961.79019104885;42031.36876934431;42408.575914241694;42530;39926.800365999145;40281.395779062754;40719;40799.59200408077;41076.178476430905;34384.82807585946;37097.814510927274;37279.25441491101;38071;38286.23427531378;28042.43915121727;28084.43831123407;28133.718662813928;28145.71854281431;28521.714782851905 20:52:55 INFO - PROCESS | 4989 | |2;jquery.html;383.1761712318513;389.66683485619785;389.79730540119124;397.6302039103633;413.1633442279384;14513.854861451382;17499.650006999884;18351.449456516308;20124.09441575129;20127.899360503194;14981.400743970255;15020.699586008273;18130.546736331566;18426.355077572254;18671.25314987402;5682.374938756733;5742.28221472316;5892.823215303548;5933.199018132562;5981.730822113015;5767.394423585526;5816.796412125576;5830.44610761979;5836.387179346171;5840.795572154975;5630.183623374608;5805.216295800055;5807;5810.9418905811035;5819.592628516006;5624.634398764068;5791.797287094932;5825.417458254183;5827.708614569255;5834.3873893241025;5133.897322053575;5149.897002059975;5164.8967020659375;5185.325907632021;5186.325777648882;22713.20503782376;22806.429839253986;23025;23119.768802312097;23317.3004809856;2182.1053368118996;2186.650135978252;2300.953980920372;2330.8135349172194;2427.9028838846425;14125;14607.92696036513;14632.41470341185;14748.115113093249;15267.618309542238;1940.922363105488;1971.9901400492906;2024.8848477597573;2028.7869773673847;2042.805933436321;77265;80400.59799700964;81996.59001705013;82251;83521.58239208825;9658.613655453702;10000.0999910007;10148.492575371201;10737.409442480739;11117.610883619034;13455.663608409868;13801.447942082204;14475.638109047359;15161.696766064837;15220.467283645241;7294.766387640094;7372;7405.33351998312;7427.480076394709;7708.38332933364;6949.722011119599;7000.7549735759;7118.679659415338;7162.641867906584;7392.667329970164;4612.976935115303;4647.976760116246;4655.883602909887;4689.296605509133;4799.544043315879;1920.769507659062;1930.845532357408;2012.134782043706;2012.4868158619752;2018.6770116781538;897.8339007283543;966.840471322224;993.2500961773959;1024.9180065594735;1026.440589878518;18963.43109706711;19494.31769888047;19646.508837279183;19707.40877773669;19992.400227993185;905.5064989580562;917.9265658747285;977.5894124467599;1048.1614708233535;1052.6315789473622;10251.026152515498;10579.259451838452;10840.186985976083;10916.399598022184;10944.343339399662;325369;467930;471524;472332;472693;57198.7140064297;77722.61138694384;93230.53384733033;94586;95710.52144739371;995.8804943406838;1034.6637342863598;1069.556134204312;1102.52040362441;1102.6361300770727;16450.83549164541;16491.83508164903;16542.255598497857;17130.40043598468;17557.912210438866;43084;43375.34936976011;43391;43772;43836.34245486256;60988;61605.38394616176;62689;62857;63262.367376325645;5249.291345668286;6511;6923.723051077901;8530.573471326534;8799.384043116921;12475.376231188586;13219.272939988394;13279.53521626777;13431;13935.860641393456;11401.201915866142;11496;11622.18644694897;11661.125415593695;11756.05951523893;11224.607138750105;11374.772504550028;11604;11687.670002245766;11936.820947685617;11269.830952535882;11478.770424591294;11787.351695656822;12094.939525302318;12108.455119519467;7143.749968751069;8460.11168827289;8524.701635442978;8668;8949.970753363186;6116.847078822887;9565.330426870052;10861.269828585268;11593.420328983348;11854.288742675468 20:52:55 INFO - PROCESS | 4989 | |3;mootools.html;1337.3112846883862;1457.2786470697006;1518.1953564610753;1650.6368598908243;1785.7678501794765;8532.91467085329;8882.378233523656;8913.777155571106;9130.452172869633;9134.040925702806;9036.186743193111;9071.501067441304;9115.49864757438;9119.77200569986;9150.679726209568;2380.428697112689;2422.8546287222734;2424.8181386396004;2429.793467555251;2431.513697260546;2321.048370168223;2368.7275963264187;2379.119725701484;2379.4408314046186;2387.7015373078366;2403.182917807945;2413.263954493879;2420.8184386171106;2442.829001969854;2446.4740080882607;2328.4528135888054;2332.4402143485613;2338.1816364272454;2345.8357914945877;2385.439421735891;2322.326525307659;2346.671465994762;2346.941326466835;2354.4702441950594;2354.693889794316;8841.955790221073;9030.413023153475;9068.8639670405;9138.360314777969;9159.587818548114;5145.4597267287145;5316.867078323035;5324.787008519655;5333.466653334674;5334.386545547273;3377.307651931348;3391.796492210475;3448.1724386147143;3448.3620530201742;3459.7405194610255;1107.058999850129;1109.4009235013084;1122.9943850280697;1125.116783325094;1143.3425780176433;12210.938945305306;12227.816582751177;12239.571614993432;12257.019438444991;12274.202176858476;4311.288637374798;4429.09203613265;4546.40896683429;4548.295014272793;4608.723476591415;9499.432593621976;9505.762355941157;9564.760880977892;9570.47362395075;9572.952135239419;5204.4014938281825;5209.869753256123;5211;5216.504432078947;5216.843494695166;4052.2098190852503;4330.501992270866;4476.462824461086;4505.211587972091;4909.337239472626;3648.3797754381817;3759.548854137521;3780.319542482325;3791;3793.260314238697;1101.058594901364;1113.8440618313443;1117.5585643670704;1118.4966764955802;1135.8523391958993;790.5849429049795;876.5617191404298;902.9413088149381;941.7316064921602;1019.2050200843354;5505.587080968863;5576.302962129734;5803.970980145073;5846.412360986162;5952.375000624872;940.2055263302499;957.7653474898694;964.8745663063897;973.8295798235281;1004.2668851738126;3965.0682089708894;4164.292070348048;4195.454590903163;4197.8320867165585;4308.935365969451;11214.32714037144;11444.256123351955;11590.304581725124;11598.304101753922;11630.418479076012;11400.486978086006;11464.426778661034;11497.942510287563;11499.827502587468;11517.424128793527;8014.318782903402;8290.29532489733;8379.162083791573;8406.579671016425;8423.06269558005;5725.8568535786935;5828.708564571839;5842.38654941225;5893.263342082239;5943.049112142209;10484.580616775549;10627.309224900357;10640.52117654692;10654.520546575577;10787.137029037815;8547.316214702685;10283.691489255334;10547.156227501935;10676.199285053497;10714.517846697074;7747.1090824555895;8211.83576328482;8216.178382161735;8232.382571307056;8237.670493180205;8655.437396569203;8733.65065397377;8814.91185088141;8854.601542930455;8861.867071993796;7835.3731701464885;7993.760187194393;8023;8106.959465202636;8218.58907054633;7832.84334313322;7921;7923.564203968606;7969.920300796918;7982.6806927724565;6676.198856137295;6699.732010719516;6767.89848152288;6776.830579235361;6797.320267973361;5064.721440320818;5200.869978250423;5253.842384728464;5313.282706834682;5383.730813459233;5140.717260550706;5204.653854597015;5367.973160134175;5370.03339398912;5393.83818485446 20:52:55 INFO - PROCESS | 4989 | |4;prototype.html;329.7790480378147;335.44986222594935;337.3775384415754;341.9230673098552;344.3594913460962;5187.455317191697;5233.842984710455;5244.239585260135;5244.895102097956;5272.393674727398;5201.921971170435;5205.947940520594;5217.069684216845;5223.37319521657;5224.660397074187;3905.9804700976456;3953.3081710700512;4048.149888523399;4070.5725898780647;4086.3257562502154;3995.8002099895034;4076.429299898017;4078.9592104078874;4082.795575305292;4086.550479447273;4043.737157084795;4071.877843664695;4072.552019277877;4078.837531303579;4092.5088989321325;3882.9611703883024;3963.702722295825;4046.4941882264425;4051.3517837145914;4071.42999980003;3613.259281847215;3616.2948225096115;3622.2212224371888;3627.988769321457;3628.6371362863765;5029.346184995964;5043.470435604282;5047.2429135629945;5048.1418158913075;5050.419201791804;4495.190865644183;4634.374359461497;4652.348671186037;4690.695104818176;4691.29630555416;5354.303940487751;5363.356397232318;5377.9512994966;5378.327709036371;5379.9731001345135;3942.448057271984;3952.940705889414;3960.3465428204313;3960.7821569813937;3981.9845939285296;5471.562275017989;5575.163725441175;5608.691521966291;5615.1750681028425;5618.91571626426;4072.75563466193;4076.612721791425;4078.899366826087;4080.836766529365;4082.3264161413626;4109.732867363612;4119.505659320901;4120.402541631506;4126.216018956388;4126.339785634284;4559.31436188995;4571.131485017836;4640.628749700083;4649.279361698942;4669.2062349400685;5421.2952316199435;5428.96849598575;5440.265564148789;5440.319960004999;5457.727113644302;1413.9363728632236;1427.3790900958115;1427.5003748687875;1428.9428422862968;1431.5991522373752;884.6284560484612;939.7462685075128;941.8022215334856;949.7768024514234;951.6145960885852;5106.723319170207;5230.8169214077325;5234.246527413359;5252;5261.842144735664;5536.916946245809;5539.944600554023;5543.972280138573;5547.618809754532;5547.694876781735;5049.2426136079885;5211.687298762086;5229.137192363218;5235.345581802275;5303.549198318109;2931.7068293170937;2952.0516459136866;2977.196157037588;2979.910602681923;2980.5395356275267;5801.8549536261935;5804.390538993429;5819.592628516048;5820.798560791548;5869.589128760946;5610.747516361774;5687.658740475585;5695.867272999833;5716.628419152742;5731.197632331477;5757.107648314518;5789.2763404574425;5813.7383817728305;5820.505257053113;5832.795852145155;5394.379646340564;5567.972160139173;5621.55027597783;5643.689597072201;5659.320881494247;5488.600406896376;5522.337319521683;5522.834314970557;5542.140968149944;5551.22282880389;5733.541316694738;5754.280714910637;5755.7409916553015;5759.193712880116;5768.134779783066;3576.6423357664025;3645.635436456439;3651.817409129586;3670.8348124335002;3693.501377314028;4876.561109500162;4877.268409738567;4981.850544483671;4992.651983964237;5029.415734043764;4851.719691744875;4860.392450943632;4883.926741098815;4927.802887884588;4936.8645211600815;4569.086182763527;4823.493533178966;4844.8304309349005;4872.512748725099;4879.292502587176;4790.808042962408;4795.95204047969;4802.927956080732;4832.197325551102;4844.660873738945;5235.089192444806;5239.349604874453;5461.453854614507;5470.890582188414;5473.644213126134;5397.298351214317;5407.134858422633;5410.891782164256;5411.323584551931;5419.376771671151 20:52:55 INFO - PROCESS | 4989 | |5;yui.html;742.2354974376392;816.4978538199006;829.5603330234974;836.8407776882025;846.8179341441596;15233.31450084746;16589.170541472937;16630.750538741915;16637.41769038084;16645.583860403494;15077.396904123849;15588.688226235468;15759.60600984976;16256;16293.266802993865;791.631891170607;809.9919000810005;810.3436216664492;810.5055915891302;811.0186674124317;668.1314291421157;791.1850793682516;811.8416908702806;815.9224873636995;816.9795755106111;857.3655494933736;858.2833334165979;858.4720396955889;858.8582883824162;859.0507489224411;850.8000619854329;851.8211175653121;851.974440766778;852.0286872964825;852.2372476633441;504.4249555506725;604.6553464525223;618.2025187508109;619.4270299972508;620.9968950155265;15633.530994070195;15640.921795391065;15656.686866262726;15676.608084797972;15677.764833527506;13788.310584470737;13972.650683732887;14214.360353784105;14267.928660356632;14387.136771793621;12536.623901282885;12645.178063425848;12749.681257968625;12933.935330323382;13446.676200489319;4514.571115743999;4517.2094883395275;4593.356930029799;4611.21609326412;4747.643926705477;77060;77897.61051194707;80676.59661701653;81266.59366703188;81509.18490815075;11467.598634047768;11484.368359740294;11529;11631.302121872546;11720;20856.165753369998;20936.267230646856;20944.162233510793;20954.266600668903;21011.684824727643;8211.34309255258;8314.251717345347;8346.09609235083;8348.540830254273;8671.306295496344;4638.55933686306;4710.528947105262;4717.976410117927;4796.2805579162705;4898.730569818694;3383.3064221834466;3430.794152350867;3446.2245994651003;3474.114100904253;3477.3740726669444;628.2963081348919;628.3841835001724;629.471244154912;630.612173513286;650.7722297195944;575.32686756495;616.4852348289229;689.3795583974463;710.1939298895791;712.1418690477961;9156.633734650539;9171.678991235274;9204.355695101278;9351.812963740824;9481.478518681539;697.2121502701914;701.0920857489564;709.9006139140524;718.2745427118543;725.9963700181465;4023.7384570002855;4464.732116072981;4513.571210734975;4516.548345165523;4528.750918699503;67858.32141678619;83234;114168.42915785368;116778;118511.40744296396;96047.51976240074;96439;96777.5161124204;97342;98366.5081674587;86101.56949215214;86158.53810964078;86174;86699;88296;8397.496150231005;8475.364347674073;8513.106123856905;8568.186022327869;8764.298856091626;41065.60366057746;51035.74482127566;51721.7413912928;53131.468685312655;53678;75429;77944;80606.59696701479;80896.59551702204;83214.58392707998;10909.781804364027;11220.719482012688;11308.49111789988;11349.262297950607;11561.421928903354;12763.234205947672;12933.288669122912;12954.28751418681;13242;13336;10107.797844043225;11963.820542691692;12125.15123941351;12142.210756300812;13093.541726039542;13824.792628110385;13875.306234688023;14276;14287.71424571482;14291.42834286617;13603.455861765418;14073.437062517385;14105.294735263402;14286.42854285817;14474.27628618586;10563.313384629975;10757.246992710436;10929.18031147683;11029.61396351124;11232.382218977707;11463.828042579202;11957.940210298893;12012.074528989098;12034.458449369624;12129.514819407477 20:52:55 INFO - PROCESS | 4989 | __end_tp_report 20:52:55 INFO - PROCESS | 4989 | __start_cc_report 20:52:55 INFO - PROCESS | 4989 | _x_x_mozilla_cycle_collect,1002 20:52:55 INFO - PROCESS | 4989 | __end_cc_report 20:52:55 INFO - PROCESS | 4989 | __startTimestamp1469764375568__endTimestamp 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | ------- Summary: start ------- 20:52:55 INFO - PROCESS | 4989 | Number of tests: 6 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | [#0] dojo.html Cycles:165 Average:5300.61 Median:5477.86 stddev:611.48 (11.2%) stddev-sans-first:586.60 20:52:55 INFO - PROCESS | 4989 | Values: 3020.1 3025.8 3045.5 3064.3 3074.5 5101.7 5155.9 5217.6 5313.1 5340.3 5268.8 5320.8 5346.0 5348.8 5397.4 4741.8 4824.5 4832.0 4839.6 4987.4 4906.9 4915.6 4941.6 4952.8 4963.6 4748.4 4748.6 4764.5 4784.0 4861.6 4758.2 4764.5 4770.5 4775.1 4871.7 4765.0 4796.5 4806.2 4807.6 4841.2 5151.2 5307.0 5337.8 5369.7 5370.6 5774.3 5784.2 5804.1 5809.3 5824.6 5813.4 5837.4 5854.3 5865.6 5873.1 5171.4 5264.6 5314.7 5319.3 5403.8 5911.0 5920.6 5927.1 5927.9 5928.5 5635.5 5688.8 5695.1 5696.7 5701.7 5519.6 5612.6 5617.7 5670.8 5671.9 5682.1 5746.9 5765.9 5797.7 5808.9 5707.2 5720.7 5735.2 5750.7 5755.7 4269.0 4288.9 4427.4 4432.2 4480.4 3890.6 3919.1 3923.7 3934.7 4009.2 5419.0 5456.1 5458.9 5461.1 5505.4 5518.5 5796.4 5797.5 5803.8 5835.4 5300.5 5369.9 5370.5 5405.5 5450.2 4951.9 4959.5 4961.3 4965.2 5007.2 5778.0 5860.0 5919.8 5921.5 5921.6 5598.5 5601.4 5620.2 5621.6 5671.3 5905.1 5908.9 5912.0 5912.4 5912.9 5426.3 5540.9 5592.7 5603.2 5605.3 5693.5 5710.6 5728.1 5744.0 5761.5 5514.7 5553.6 5557.1 5559.3 5565.3 5383.6 5531.8 5544.1 5548.4 5590.6 5387.3 5439.7 5444.3 5480.6 5522.8 5574.9 5608.5 5663.3 5666.2 5668.1 5391.8 5471.4 5477.6 5477.9 5480.9 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | [#1] ext.html Cycles:180 Average:59161.31 Median:41996.58 stddev:115372.02 (274.7%) stddev-sans-first:115611.83 20:52:55 INFO - PROCESS | 4989 | Values: 580.9 599.5 617.0 626.8 628.0 43504.1 44263.8 44349.0 44363.3 47946.5 45891.5 46207.8 46272.3 46334.0 46385.3 8888.6 9022.4 9025.6 9027.5 9036.9 8947.8 9040.3 9048.0 9061.9 9069.2 9050.4 9099.0 9110.7 9111.7 9115.2 9043.9 9056.5 9075.1 9089.5 9100.0 9082.4 9143.9 9147.5 9147.6 9151.3 43103.4 43273.0 43445.0 43455.6 43477.0 3478.0 3603.5 3637.6 3657.5 4142.6 32075.7 32256.7 32997.8 33225.8 33879.2 4251.0 4327.8 4343.3 4407.3 4600.4 370693.0 371320.0 371467.1 371519.0 372079.0 55984.7 56134.4 56142.0 56189.3 56214.4 51161.7 57431.4 59352.4 59503.7 59568.0 14939.0 15795.8 15835.4 15840.2 15874.7 12136.9 12199.0 12199.0 12202.4 12208.8 14080.4 15170.2 15674.7 15707.5 15812.8 5705.3 5713.7 5733.6 5759.9 5896.7 1000.9 1011.0 1021.8 1079.8 1098.9 31498.8 31919.7 32027.5 32034.5 32350.2 1056.0 1077.5 1080.9 1090.7 1102.3 16428.6 16907.6 16925.3 16944.6 16975.0 533593.0 535178.0 535801.0 538155.0 538582.0 58570.0 58678.1 58736.0 58813.1 58841.7 1235.5 1280.5 1292.3 1320.7 1330.0 29884.4 30810.0 31579.8 31672.0 32090.4 50923.5 55206.4 56235.0 56371.2 59845.4 370193.0 376376.0 378583.0 383496.0 384087.0 23153.8 26966.3 27186.6 27335.7 27645.0 42937.0 45679.2 48234.3 48500.3 49481.5 38771.0 40273.8 40690.8 41037.0 42573.0 41250.0 41961.8 42031.4 42408.6 42530.0 39926.8 40281.4 40719.0 40799.6 41076.2 34384.8 37097.8 37279.3 38071.0 38286.2 28042.4 28084.4 28133.7 28145.7 28521.7 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | [#2] jquery.html Cycles:180 Average:27451.48 Median:162876.09 stddev:73759.15 (45.3%) stddev-sans-first:73938.06 20:52:55 INFO - PROCESS | 4989 | Values: 383.2 389.7 389.8 397.6 413.2 14513.9 17499.7 18351.4 20124.1 20127.9 14981.4 15020.7 18130.5 18426.4 18671.3 5682.4 5742.3 5892.8 5933.2 5981.7 5767.4 5816.8 5830.4 5836.4 5840.8 5630.2 5805.2 5807.0 5810.9 5819.6 5624.6 5791.8 5825.4 5827.7 5834.4 5133.9 5149.9 5164.9 5185.3 5186.3 22713.2 22806.4 23025.0 23119.8 23317.3 2182.1 2186.7 2301.0 2330.8 2427.9 14125.0 14607.9 14632.4 14748.1 15267.6 1940.9 1972.0 2024.9 2028.8 2042.8 77265.0 80400.6 81996.6 82251.0 83521.6 9658.6 10000.1 10148.5 10737.4 11117.6 13455.7 13801.4 14475.6 15161.7 15220.5 7294.8 7372.0 7405.3 7427.5 7708.4 6949.7 7000.8 7118.7 7162.6 7392.7 4613.0 4648.0 4655.9 4689.3 4799.5 1920.8 1930.8 2012.1 2012.5 2018.7 897.8 966.8 993.3 1024.9 1026.4 18963.4 19494.3 19646.5 19707.4 19992.4 905.5 917.9 977.6 1048.2 1052.6 10251.0 10579.3 10840.2 10916.4 10944.3 325369.0 467930.0 471524.0 472332.0 472693.0 57198.7 77722.6 93230.5 94586.0 95710.5 995.9 1034.7 1069.6 1102.5 1102.6 16450.8 16491.8 16542.3 17130.4 17557.9 43084.0 43375.3 43391.0 43772.0 43836.3 60988.0 61605.4 62689.0 62857.0 63262.4 5249.3 6511.0 6923.7 8530.6 8799.4 12475.4 13219.3 13279.5 13431.0 13935.9 11401.2 11496.0 11622.2 11661.1 11756.1 11224.6 11374.8 11604.0 11687.7 11936.8 11269.8 11478.8 11787.4 12094.9 12108.5 7143.7 8460.1 8524.7 8668.0 8950.0 6116.8 9565.3 10861.3 11593.4 11854.3 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | [#3] mootools.html Cycles:180 Average:5861.50 Median:4987.03 stddev:3386.03 (67.9%) stddev-sans-first:3378.46 20:52:55 INFO - PROCESS | 4989 | Values: 1337.3 1457.3 1518.2 1650.6 1785.8 8532.9 8882.4 8913.8 9130.5 9134.0 9036.2 9071.5 9115.5 9119.8 9150.7 2380.4 2422.9 2424.8 2429.8 2431.5 2321.0 2368.7 2379.1 2379.4 2387.7 2403.2 2413.3 2420.8 2442.8 2446.5 2328.5 2332.4 2338.2 2345.8 2385.4 2322.3 2346.7 2346.9 2354.5 2354.7 8842.0 9030.4 9068.9 9138.4 9159.6 5145.5 5316.9 5324.8 5333.5 5334.4 3377.3 3391.8 3448.2 3448.4 3459.7 1107.1 1109.4 1123.0 1125.1 1143.3 12210.9 12227.8 12239.6 12257.0 12274.2 4311.3 4429.1 4546.4 4548.3 4608.7 9499.4 9505.8 9564.8 9570.5 9573.0 5204.4 5209.9 5211.0 5216.5 5216.8 4052.2 4330.5 4476.5 4505.2 4909.3 3648.4 3759.5 3780.3 3791.0 3793.3 1101.1 1113.8 1117.6 1118.5 1135.9 790.6 876.6 902.9 941.7 1019.2 5505.6 5576.3 5804.0 5846.4 5952.4 940.2 957.8 964.9 973.8 1004.3 3965.1 4164.3 4195.5 4197.8 4308.9 11214.3 11444.3 11590.3 11598.3 11630.4 11400.5 11464.4 11497.9 11499.8 11517.4 8014.3 8290.3 8379.2 8406.6 8423.1 5725.9 5828.7 5842.4 5893.3 5943.0 10484.6 10627.3 10640.5 10654.5 10787.1 8547.3 10283.7 10547.2 10676.2 10714.5 7747.1 8211.8 8216.2 8232.4 8237.7 8655.4 8733.7 8814.9 8854.6 8861.9 7835.4 7993.8 8023.0 8107.0 8218.6 7832.8 7921.0 7923.6 7969.9 7982.7 6676.2 6699.7 6767.9 6776.8 6797.3 5064.7 5200.9 5253.8 5313.3 5383.7 5140.7 5204.7 5368.0 5370.0 5393.8 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | [#4] prototype.html Cycles:180 Average:4520.86 Median:5036.44 stddev:1315.48 (26.1%) stddev-sans-first:1281.01 20:52:55 INFO - PROCESS | 4989 | Values: 329.8 335.4 337.4 341.9 344.4 5187.5 5233.8 5244.2 5244.9 5272.4 5201.9 5205.9 5217.1 5223.4 5224.7 3906.0 3953.3 4048.1 4070.6 4086.3 3995.8 4076.4 4079.0 4082.8 4086.6 4043.7 4071.9 4072.6 4078.8 4092.5 3883.0 3963.7 4046.5 4051.4 4071.4 3613.3 3616.3 3622.2 3628.0 3628.6 5029.3 5043.5 5047.2 5048.1 5050.4 4495.2 4634.4 4652.3 4690.7 4691.3 5354.3 5363.4 5378.0 5378.3 5380.0 3942.4 3952.9 3960.3 3960.8 3982.0 5471.6 5575.2 5608.7 5615.2 5618.9 4072.8 4076.6 4078.9 4080.8 4082.3 4109.7 4119.5 4120.4 4126.2 4126.3 4559.3 4571.1 4640.6 4649.3 4669.2 5421.3 5429.0 5440.3 5440.3 5457.7 1413.9 1427.4 1427.5 1428.9 1431.6 884.6 939.7 941.8 949.8 951.6 5106.7 5230.8 5234.2 5252.0 5261.8 5536.9 5539.9 5544.0 5547.6 5547.7 5049.2 5211.7 5229.1 5235.3 5303.5 2931.7 2952.1 2977.2 2979.9 2980.5 5801.9 5804.4 5819.6 5820.8 5869.6 5610.7 5687.7 5695.9 5716.6 5731.2 5757.1 5789.3 5813.7 5820.5 5832.8 5394.4 5568.0 5621.6 5643.7 5659.3 5488.6 5522.3 5522.8 5542.1 5551.2 5733.5 5754.3 5755.7 5759.2 5768.1 3576.6 3645.6 3651.8 3670.8 3693.5 4876.6 4877.3 4981.9 4992.7 5029.4 4851.7 4860.4 4883.9 4927.8 4936.9 4569.1 4823.5 4844.8 4872.5 4879.3 4790.8 4796.0 4802.9 4832.2 4844.7 5235.1 5239.3 5461.5 5470.9 5473.6 5397.3 5407.1 5410.9 5411.3 5419.4 20:52:55 INFO - PROCESS | 4989 | 20:52:55 INFO - PROCESS | 4989 | [#5] yui.html Cycles:180 Average:20496.17 Median:4732.81 stddev:29231.88 (617.6%) stddev-sans-first:29276.25 20:52:55 INFO - PROCESS | 4989 | Values: 742.2 816.5 829.6 836.8 846.8 15233.3 16589.2 16630.8 16637.4 16645.6 15077.4 15588.7 15759.6 16256.0 16293.3 791.6 810.0 810.3 810.5 811.0 668.1 791.2 811.8 815.9 817.0 857.4 858.3 858.5 858.9 859.1 850.8 851.8 852.0 852.0 852.2 504.4 604.7 618.2 619.4 621.0 15633.5 15640.9 15656.7 15676.6 15677.8 13788.3 13972.7 14214.4 14267.9 14387.1 12536.6 12645.2 12749.7 12933.9 13446.7 4514.6 4517.2 4593.4 4611.2 4747.6 77060.0 77897.6 80676.6 81266.6 81509.2 11467.6 11484.4 11529.0 11631.3 11720.0 20856.2 20936.3 20944.2 20954.3 21011.7 8211.3 8314.3 8346.1 8348.5 8671.3 4638.6 4710.5 4718.0 4796.3 4898.7 3383.3 3430.8 3446.2 3474.1 3477.4 628.3 628.4 629.5 630.6 650.8 575.3 616.5 689.4 710.2 712.1 9156.6 9171.7 9204.4 9351.8 9481.5 697.2 701.1 709.9 718.3 726.0 4023.7 4464.7 4513.6 4516.5 4528.8 67858.3 83234.0 114168.4 116778.0 118511.4 96047.5 96439.0 96777.5 97342.0 98366.5 86101.6 86158.5 86174.0 86699.0 88296.0 8397.5 8475.4 8513.1 8568.2 8764.3 41065.6 51035.7 51721.7 53131.5 53678.0 75429.0 77944.0 80606.6 80896.6 83214.6 10909.8 11220.7 11308.5 11349.3 11561.4 12763.2 12933.3 12954.3 13242.0 13336.0 10107.8 11963.8 12125.2 12142.2 13093.5 13824.8 13875.3 14276.0 14287.7 14291.4 13603.5 14073.4 14105.3 14286.4 14474.3 10563.3 10757.2 10929.2 11029.6 11232.4 11463.8 11957.9 12012.1 12034.5 12129.5 20:52:55 INFO - PROCESS | 4989 | -------- Summary: end -------- 20:52:55 INFO - PROCESS | 4989 | 20:52:56 INFO - TEST-INFO | 4989: exit 0 20:52:56 INFO - TEST-OK | dromaeo_css | took 1115267ms 20:52:56 INFO - TEST-START | kraken 20:52:56 INFO - operating with platform_type : linux_ 20:52:56 INFO - Initialising browser for kraken test... 20:52:56 INFO - TEST-INFO | started process 5174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0Lh1Z/profile http://localhost:46634/getInfo.html) 20:52:59 INFO - PROCESS | 5174 | JavaScript error: , line 0: uncaught exception: undefined 20:53:00 INFO - PROCESS | 5174 | __metrics Screen width/height:1600/1200 20:53:00 INFO - PROCESS | 5174 | colorDepth:24 20:53:00 INFO - PROCESS | 5174 | Browser inner width/height: 1024/697 20:53:00 INFO - PROCESS | 5174 | __metrics 20:53:01 INFO - PROCESS | 5174 | 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" 20:53:01 INFO - PROCESS | 5174 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:53:02 INFO - TEST-INFO | 5174: exit 0 20:53:02 INFO - Browser initialized. 20:53:02 INFO - Running cycle 1/1 for kraken test... 20:53:02 INFO - TEST-INFO | started process 5255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0Lh1Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:53:14 INFO - PROCESS | 5255 | RSS: Main: 157556736 20:53:14 INFO - PROCESS | 5255 | 20:53:16 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-beat-detection) 20:53:17 INFO - PROCESS | 5255 | RSS: Main: 213037056 20:53:17 INFO - PROCESS | 5255 | 20:53:20 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-dft) 20:53:20 INFO - PROCESS | 5255 | RSS: Main: 188567552 20:53:20 INFO - PROCESS | 5255 | 20:53:23 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-fft) 20:53:24 INFO - PROCESS | 5255 | RSS: Main: 271556608 20:53:24 INFO - PROCESS | 5255 | 20:53:26 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-oscillator) 20:53:27 INFO - PROCESS | 5255 | RSS: Main: 180936704 20:53:27 INFO - PROCESS | 5255 | 20:53:29 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:53:29 INFO - PROCESS | 5255 | RSS: Main: 185921536 20:53:29 INFO - PROCESS | 5255 | 20:53:32 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46634/tests/kraken/driver.html?testName=imaging-darkroom) 20:53:33 INFO - PROCESS | 5255 | RSS: Main: 220491776 20:53:33 INFO - PROCESS | 5255 | 20:53:36 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46634/tests/kraken/driver.html?testName=imaging-desaturate) 20:53:37 INFO - PROCESS | 5255 | RSS: Main: 221351936 20:53:37 INFO - PROCESS | 5255 | 20:53:40 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46634/tests/kraken/driver.html?testName=json-parse-financial) 20:53:40 INFO - PROCESS | 5255 | RSS: Main: 221552640 20:53:40 INFO - PROCESS | 5255 | 20:53:42 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:53:42 INFO - PROCESS | 5255 | RSS: Main: 185802752 20:53:42 INFO - PROCESS | 5255 | 20:53:44 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:53:45 INFO - PROCESS | 5255 | RSS: Main: 191553536 20:53:45 INFO - PROCESS | 5255 | 20:53:47 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:53:48 INFO - PROCESS | 5255 | RSS: Main: 195719168 20:53:48 INFO - PROCESS | 5255 | 20:53:50 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:53:51 INFO - PROCESS | 5255 | RSS: Main: 188456960 20:53:51 INFO - PROCESS | 5255 | 20:53:53 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:53:54 INFO - PROCESS | 5255 | RSS: Main: 193859584 20:53:54 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46634/tests/kraken/driver.html?testName=ai-astar) 20:53:56 INFO - PROCESS | 5255 | RSS: Main: 244682752 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | __start_tp_report 20:53:56 INFO - PROCESS | 5255 | _x_x_mozilla_page_load 20:53:56 INFO - PROCESS | 5255 | _x_x_mozilla_page_load_details 20:53:56 INFO - PROCESS | 5255 | |i|pagename|runs| 20:53:56 INFO - PROCESS | 5255 | |0;ai-astar;103;111;111;111;112;112;110;110;110;110 20:53:56 INFO - PROCESS | 5255 | |1;audio-beat-detection;146;122;122;186;122;124;148;124;165;120 20:53:56 INFO - PROCESS | 5255 | |2;audio-dft;161;161;161;160;160;160;161;161;161;159 20:53:56 INFO - PROCESS | 5255 | |3;audio-fft;74;76;75;115;76;76;74;74;100;74 20:53:56 INFO - PROCESS | 5255 | |4;audio-oscillator;84;83;112;84;83;84;112;84;84;127 20:53:56 INFO - PROCESS | 5255 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;117;116 20:53:56 INFO - PROCESS | 5255 | |6;imaging-darkroom;146;145;145;144;145;145;146;146;146;147 20:53:56 INFO - PROCESS | 5255 | |7;imaging-desaturate;94;95;94;95;95;95;95;94;94;94 20:53:56 INFO - PROCESS | 5255 | |8;json-parse-financial;53;54;53;52;52;54;53;51;54;52 20:53:56 INFO - PROCESS | 5255 | |9;json-stringify-tinderbox;63;64;64;64;64;63;63;63;64;63 20:53:56 INFO - PROCESS | 5255 | |10;stanford-crypto-aes;77;75;75;81;75;75;75;76;75;80 20:53:56 INFO - PROCESS | 5255 | |11;stanford-crypto-ccm;131;121;125;119;120;117;120;125;190;126 20:53:56 INFO - PROCESS | 5255 | |12;stanford-crypto-pbkdf2;159;156;159;163;162;159;159;159;159;156 20:53:56 INFO - PROCESS | 5255 | |13;stanford-crypto-sha256-iterative;64;65;64;63;63;63;62;67;62;63 20:53:56 INFO - PROCESS | 5255 | __end_tp_report 20:53:56 INFO - PROCESS | 5255 | __start_cc_report 20:53:56 INFO - PROCESS | 5255 | _x_x_mozilla_cycle_collect,1694 20:53:56 INFO - PROCESS | 5255 | __end_cc_report 20:53:56 INFO - PROCESS | 5255 | __startTimestamp1469764436356__endTimestamp 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | ------- Summary: start ------- 20:53:56 INFO - PROCESS | 5255 | Number of tests: 14 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 20:53:56 INFO - PROCESS | 5255 | Values: 103.0 111.0 111.0 111.0 112.0 112.0 110.0 110.0 110.0 110.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:135.00 stddev:22.81 (16.9%) stddev-sans-first:24.00 20:53:56 INFO - PROCESS | 5255 | Values: 146.0 122.0 122.0 186.0 122.0 124.0 148.0 124.0 165.0 120.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 20:53:56 INFO - PROCESS | 5255 | Values: 161.0 161.0 161.0 160.0 160.0 160.0 161.0 161.0 161.0 159.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.50 stddev:14.23 (19.1%) stddev-sans-first:14.84 20:53:56 INFO - PROCESS | 5255 | Values: 74.0 76.0 75.0 115.0 76.0 76.0 74.0 74.0 100.0 74.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:84.00 stddev:16.59 (19.8%) stddev-sans-first:17.22 20:53:56 INFO - PROCESS | 5255 | Values: 84.0 83.0 112.0 84.0 83.0 84.0 112.0 84.0 84.0 127.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:53:56 INFO - PROCESS | 5255 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 20:53:56 INFO - PROCESS | 5255 | Values: 146.0 145.0 145.0 144.0 145.0 145.0 146.0 146.0 146.0 147.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 20:53:56 INFO - PROCESS | 5255 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 20:53:56 INFO - PROCESS | 5255 | Values: 53.0 54.0 53.0 52.0 52.0 54.0 53.0 51.0 54.0 52.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 20:53:56 INFO - PROCESS | 5255 | Values: 63.0 64.0 64.0 64.0 64.0 63.0 63.0 63.0 64.0 63.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:75.50 stddev:2.27 (3.0%) stddev-sans-first:2.40 20:53:56 INFO - PROCESS | 5255 | Values: 77.0 75.0 75.0 81.0 75.0 75.0 75.0 76.0 75.0 80.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:125.00 stddev:21.69 (17.4%) stddev-sans-first:23.00 20:53:56 INFO - PROCESS | 5255 | Values: 131.0 121.0 125.0 119.0 120.0 117.0 120.0 125.0 190.0 126.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.00 stddev:2.18 (1.4%) stddev-sans-first:2.32 20:53:56 INFO - PROCESS | 5255 | Values: 159.0 156.0 159.0 163.0 162.0 159.0 159.0 159.0 159.0 156.0 20:53:56 INFO - PROCESS | 5255 | 20:53:56 INFO - PROCESS | 5255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.51 (2.4%) stddev-sans-first:1.59 20:53:56 INFO - PROCESS | 5255 | Values: 64.0 65.0 64.0 63.0 63.0 63.0 62.0 67.0 62.0 63.0 20:53:56 INFO - PROCESS | 5255 | -------- Summary: end -------- 20:53:56 INFO - PROCESS | 5255 | 20:53:57 INFO - TEST-INFO | 5255: exit 0 20:53:57 INFO - TEST-OK | kraken | took 61005ms 20:53:57 INFO - SUITE-END | took 1176s 20:53:57 INFO - Completed test suite (00:19:36) 20:53:57 INFO - javascript benchmark 20:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.1241639924424, 3025.7881948263625, 3045.5279431688095, 3064.3258483133704, 3074.538819177123, 5101.744912754357, 5155.871103222421, 5217.582593392524, 5313.0967735484965, 5340.279062326589, 5268.841934741954, 5320.787168513255, 5346.0, 5348.839534813952, 5397.433269506704, 4741.786619602126, 4824.493428190042, 4831.975840120795, 4839.637027222955, 4987.401511818569, 4906.9263961040615, 4915.5821755150855, 4941.579965702919, 4952.752362381884, 4963.553280204781, 4748.406449193868, 4748.620110391161, 4764.475907650156, 4783.952160478386, 4861.635377346695, 4758.1673207188605, 4764.499727528629, 4770.499097594772, 4775.092732380871, 4871.683340582851, 4764.976175119137, 4796.544328288842, 4806.206975848981, 4807.6394270429855, 4841.249606310992, 5151.227315902607, 5307.044731948247, 5337.786488540453, 5369.677819330853, 5370.570354371641, 5774.335951365605, 5784.248047753765, 5804.100364443518, 5809.331926828427, 5824.621399609055, 5813.360530341659, 5837.445442682981, 5854.326752423483, 5865.560082993792, 5873.060310350366, 5171.4311425743135, 5264.631475796696, 5314.654547454442, 5319.335083114611, 5403.756830942617, 5911.024680927685, 5920.615160014671, 5927.081302398049, 5927.851803704942, 5928.466438020512, 5635.492805647511, 5688.800891968761, 5695.145728140729, 5696.743646535916, 5701.743421546041, 5519.558435325164, 5612.607117501817, 5617.662940223599, 5670.829875103754, 5671.943280567141, 5682.062459694187, 5746.9425305747245, 5765.85585360361, 5797.681127538026, 5808.94191058084, 5707.200991861143, 5720.713964301768, 5735.2257445245195, 5750.654960702288, 5755.6834374108985, 4268.957310426918, 4288.935665965013, 4427.40230068943, 4432.246518091868, 4480.372747815309, 3890.5525864525375, 3919.0790164311366, 3923.74495657787, 3934.6852251819787, 4009.2382447334912, 5418.972905135449, 5456.127019676912, 5458.918116228259, 5461.0716178249795, 5505.366882808448, 5518.475744804237, 5796.42035796417, 5797.536197104221, 5803.7968671096305, 5835.387284335168, 5300.469953004668, 5369.892602147936, 5370.516653501126, 5405.486478784509, 5450.155225939986, 4951.876203094951, 4959.479254678279, 4961.330220420197, 4965.162418120497, 5007.173816320339, 5777.971110144506, 5860.0, 5919.792807251725, 5921.526277897844, 5921.5558833086825, 5598.524125449219, 5601.439856014366, 5620.213170156099, 5621.634593751557, 5671.347795003628, 5905.114232864933, 5908.852278692895, 5912.0, 5912.438318359749, 5912.911306330322, 5426.294581704353, 5540.944590554042, 5592.692401917933, 5603.159526071122, 5605.32736071674, 5693.544516438592, 5710.600257982068, 5728.112142617901, 5743.971280143573, 5761.452661997104, 5514.669119852661, 5553.6390134641115, 5557.055300598827, 5559.33288005442, 5565.276514053147, 5383.5962302826665, 5531.778728850801, 5544.112941929272, 5548.389677135593, 5590.608657394106, 5387.299651045339, 5439.728013599225, 5444.3194600674915, 5480.6437581557075, 5522.806701765419, 5574.9442505574425, 5608.46719561641, 5663.32040155184, 5666.17840413146, 5668.064769313182, 5391.784328626811, 5471.370792358771, 5477.561795056306, 5477.863053423696, 5480.945190548044], "value": 5258.668549428144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9070548712207, 599.5233789137635, 616.9753209871604, 626.7806267806266, 628.0171531553116, 43504.12991740163, 44263.77868110663, 44349.0, 44363.33454998174, 47946.52053479473, 45891.541084589146, 46207.768961155234, 46272.30591541129, 46334.0, 46385.304220436636, 8888.644454221823, 9022.413543119708, 9025.638974441015, 9027.548622568846, 9036.909630903672, 8947.821043579124, 9040.321975851804, 9048.049954754755, 9061.864072038925, 9069.183773460387, 9050.366474346798, 9099.0, 9110.726678199664, 9111.726648200565, 9115.22520585751, 9043.864342034874, 9056.501892395916, 9075.092490750905, 9089.454632722058, 9100.044495328028, 9082.364234503588, 9143.862842057375, 9147.451152930846, 9147.634094636207, 9151.313651476166, 43103.35344969828, 43273.0, 43445.0, 43455.56544434547, 43477.0, 3477.9652203477895, 3603.549556305462, 3637.5998640149564, 3657.487951686766, 4142.627163555295, 32075.6792432075, 32256.677433225603, 32997.83501082503, 33225.840320379095, 33879.153021174425, 4250.978745106286, 4327.7619730914785, 4343.348497725335, 4407.338899165119, 4600.35595016698, 370693.0, 371320.0, 371467.14266428765, 371519.0, 372078.99999999726, 55984.72007639936, 56134.43865561374, 56142.0, 56189.31432057045, 56214.43785562174, 51161.744191278805, 57431.425685743445, 59352.40647593555, 59503.70248148818, 59568.0, 14939.0, 15795.763063554055, 15835.366585336687, 15840.207989600474, 15874.682506349809, 12136.939315303367, 12199.0, 12199.024078073733, 12202.389880506116, 12208.816867746991, 14080.436782528788, 15170.165640889856, 15674.68650626981, 15707.528774136794, 15812.762808557882, 5705.258316418922, 5713.657180569179, 5733.598648094677, 5759.85600359986, 5896.6756828374855, 1000.9099181073739, 1011.0445628880638, 1021.7854250607307, 1079.7624522605015, 1098.8846171152074, 31498.842505787325, 31919.680803192135, 32027.51958720621, 32034.519482207786, 32350.191245218586, 1055.963041293551, 1077.5097330714507, 1080.9135269178446, 1090.7109615951779, 1102.2945314998408, 16428.589285267964, 16907.57731056709, 16925.322987080624, 16944.57638559046, 16975.0, 533593.0, 535178.0, 535801.0, 538155.0, 538582.0, 58570.0, 58678.066096694994, 58736.0, 58813.117803232984, 58841.70579147163, 1235.4810979388678, 1280.5454063807215, 1292.3409061378763, 1320.7094439223356, 1330.035724100039, 29884.402311953203, 30810.0, 31579.84210079027, 31672.0, 32090.35819283648, 50923.490765091876, 55206.44793552174, 56235.0, 56371.15443268272, 59845.40154598398, 370193.0, 376376.0, 378583.0, 383496.0, 384087.0, 23153.76846231516, 26966.32584185411, 27186.592201117393, 27335.72664273332, 27645.0, 42937.0, 45679.172833086304, 48234.27648585344, 48500.2724959133, 49481.50518494913, 38771.0, 40273.79863100783, 40690.79654601708, 41037.0, 42573.0, 41250.0, 41961.79019104885, 42031.36876934431, 42408.575914241694, 42530.0, 39926.800365999145, 40281.395779062754, 40719.0, 40799.59200408077, 41076.178476430905, 34384.82807585946, 37097.814510927274, 37279.25441491101, 38071.0, 38286.23427531378, 28042.43915121727, 28084.43831123407, 28133.718662813928, 28145.71854281431, 28521.714782851905], "value": 19857.085219787572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.1761712318513, 389.66683485619785, 389.79730540119124, 397.6302039103633, 413.1633442279384, 14513.854861451382, 17499.650006999884, 18351.449456516308, 20124.09441575129, 20127.899360503194, 14981.400743970255, 15020.699586008273, 18130.546736331566, 18426.355077572254, 18671.25314987402, 5682.374938756733, 5742.28221472316, 5892.823215303548, 5933.199018132562, 5981.730822113015, 5767.394423585526, 5816.796412125576, 5830.44610761979, 5836.387179346171, 5840.795572154975, 5630.183623374608, 5805.216295800055, 5807.0, 5810.9418905811035, 5819.592628516006, 5624.634398764068, 5791.797287094932, 5825.417458254183, 5827.708614569255, 5834.3873893241025, 5133.897322053575, 5149.897002059975, 5164.8967020659375, 5185.325907632021, 5186.325777648882, 22713.20503782376, 22806.429839253986, 23025.0, 23119.768802312097, 23317.3004809856, 2182.1053368118996, 2186.650135978252, 2300.953980920372, 2330.8135349172194, 2427.9028838846425, 14125.0, 14607.92696036513, 14632.41470341185, 14748.115113093249, 15267.618309542238, 1940.922363105488, 1971.9901400492906, 2024.8848477597573, 2028.7869773673847, 2042.805933436321, 77265.0, 80400.59799700964, 81996.59001705013, 82251.0, 83521.58239208825, 9658.613655453702, 10000.0999910007, 10148.492575371201, 10737.409442480739, 11117.610883619034, 13455.663608409868, 13801.447942082204, 14475.638109047359, 15161.696766064837, 15220.467283645241, 7294.766387640094, 7372.0, 7405.33351998312, 7427.480076394709, 7708.38332933364, 6949.722011119599, 7000.7549735759, 7118.679659415338, 7162.641867906584, 7392.667329970164, 4612.976935115303, 4647.976760116246, 4655.883602909887, 4689.296605509133, 4799.544043315879, 1920.769507659062, 1930.845532357408, 2012.134782043706, 2012.4868158619752, 2018.6770116781538, 897.8339007283543, 966.840471322224, 993.2500961773959, 1024.9180065594735, 1026.440589878518, 18963.43109706711, 19494.31769888047, 19646.508837279183, 19707.40877773669, 19992.400227993185, 905.5064989580562, 917.9265658747285, 977.5894124467599, 1048.1614708233535, 1052.6315789473622, 10251.026152515498, 10579.259451838452, 10840.186985976083, 10916.399598022184, 10944.343339399662, 325369.0, 467930.0, 471524.0, 472332.0, 472693.0, 57198.7140064297, 77722.61138694384, 93230.53384733033, 94586.0, 95710.52144739371, 995.8804943406838, 1034.6637342863598, 1069.556134204312, 1102.52040362441, 1102.6361300770727, 16450.83549164541, 16491.83508164903, 16542.255598497857, 17130.40043598468, 17557.912210438866, 43084.0, 43375.34936976011, 43391.0, 43772.0, 43836.34245486256, 60988.0, 61605.38394616176, 62689.0, 62857.0, 63262.367376325645, 5249.291345668286, 6511.0, 6923.723051077901, 8530.573471326534, 8799.384043116921, 12475.376231188586, 13219.272939988394, 13279.53521626777, 13431.0, 13935.860641393456, 11401.201915866142, 11496.0, 11622.18644694897, 11661.125415593695, 11756.05951523893, 11224.607138750105, 11374.772504550028, 11604.0, 11687.670002245766, 11936.820947685617, 11269.830952535882, 11478.770424591294, 11787.351695656822, 12094.939525302318, 12108.455119519467, 7143.749968751069, 8460.11168827289, 8524.701635442978, 8668.0, 8949.970753363186, 6116.847078822887, 9565.330426870052, 10861.269828585268, 11593.420328983348, 11854.288742675468], "value": 9070.765054390633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.3112846883862, 1457.2786470697006, 1518.1953564610753, 1650.6368598908243, 1785.7678501794765, 8532.91467085329, 8882.378233523656, 8913.777155571106, 9130.452172869633, 9134.040925702806, 9036.186743193111, 9071.501067441304, 9115.49864757438, 9119.77200569986, 9150.679726209568, 2380.428697112689, 2422.8546287222734, 2424.8181386396004, 2429.793467555251, 2431.513697260546, 2321.048370168223, 2368.7275963264187, 2379.119725701484, 2379.4408314046186, 2387.7015373078366, 2403.182917807945, 2413.263954493879, 2420.8184386171106, 2442.829001969854, 2446.4740080882607, 2328.4528135888054, 2332.4402143485613, 2338.1816364272454, 2345.8357914945877, 2385.439421735891, 2322.326525307659, 2346.671465994762, 2346.941326466835, 2354.4702441950594, 2354.693889794316, 8841.955790221073, 9030.413023153475, 9068.8639670405, 9138.360314777969, 9159.587818548114, 5145.4597267287145, 5316.867078323035, 5324.787008519655, 5333.466653334674, 5334.386545547273, 3377.307651931348, 3391.796492210475, 3448.1724386147143, 3448.3620530201742, 3459.7405194610255, 1107.058999850129, 1109.4009235013084, 1122.9943850280697, 1125.116783325094, 1143.3425780176433, 12210.938945305306, 12227.816582751177, 12239.571614993432, 12257.019438444991, 12274.202176858476, 4311.288637374798, 4429.09203613265, 4546.40896683429, 4548.295014272793, 4608.723476591415, 9499.432593621976, 9505.762355941157, 9564.760880977892, 9570.47362395075, 9572.952135239419, 5204.4014938281825, 5209.869753256123, 5211.0, 5216.504432078947, 5216.843494695166, 4052.2098190852503, 4330.501992270866, 4476.462824461086, 4505.211587972091, 4909.337239472626, 3648.3797754381817, 3759.548854137521, 3780.319542482325, 3791.0, 3793.260314238697, 1101.058594901364, 1113.8440618313443, 1117.5585643670704, 1118.4966764955802, 1135.8523391958993, 790.5849429049795, 876.5617191404298, 902.9413088149381, 941.7316064921602, 1019.2050200843354, 5505.587080968863, 5576.302962129734, 5803.970980145073, 5846.412360986162, 5952.375000624872, 940.2055263302499, 957.7653474898694, 964.8745663063897, 973.8295798235281, 1004.2668851738126, 3965.0682089708894, 4164.292070348048, 4195.454590903163, 4197.8320867165585, 4308.935365969451, 11214.32714037144, 11444.256123351955, 11590.304581725124, 11598.304101753922, 11630.418479076012, 11400.486978086006, 11464.426778661034, 11497.942510287563, 11499.827502587468, 11517.424128793527, 8014.318782903402, 8290.29532489733, 8379.162083791573, 8406.579671016425, 8423.06269558005, 5725.8568535786935, 5828.708564571839, 5842.38654941225, 5893.263342082239, 5943.049112142209, 10484.580616775549, 10627.309224900357, 10640.52117654692, 10654.520546575577, 10787.137029037815, 8547.316214702685, 10283.691489255334, 10547.156227501935, 10676.199285053497, 10714.517846697074, 7747.1090824555895, 8211.83576328482, 8216.178382161735, 8232.382571307056, 8237.670493180205, 8655.437396569203, 8733.65065397377, 8814.91185088141, 8854.601542930455, 8861.867071993796, 7835.3731701464885, 7993.760187194393, 8023.0, 8106.959465202636, 8218.58907054633, 7832.84334313322, 7921.0, 7923.564203968606, 7969.920300796918, 7982.6806927724565, 6676.198856137295, 6699.732010719516, 6767.89848152288, 6776.830579235361, 6797.320267973361, 5064.721440320818, 5200.869978250423, 5253.842384728464, 5313.282706834682, 5383.730813459233, 5140.717260550706, 5204.653854597015, 5367.973160134175, 5370.03339398912, 5393.83818485446], "value": 4655.960706157977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.7790480378147, 335.44986222594935, 337.3775384415754, 341.9230673098552, 344.3594913460962, 5187.455317191697, 5233.842984710455, 5244.239585260135, 5244.895102097956, 5272.393674727398, 5201.921971170435, 5205.947940520594, 5217.069684216845, 5223.37319521657, 5224.660397074187, 3905.9804700976456, 3953.3081710700512, 4048.149888523399, 4070.5725898780647, 4086.3257562502154, 3995.8002099895034, 4076.429299898017, 4078.9592104078874, 4082.795575305292, 4086.550479447273, 4043.737157084795, 4071.877843664695, 4072.552019277877, 4078.837531303579, 4092.5088989321325, 3882.9611703883024, 3963.702722295825, 4046.4941882264425, 4051.3517837145914, 4071.42999980003, 3613.259281847215, 3616.2948225096115, 3622.2212224371888, 3627.988769321457, 3628.6371362863765, 5029.346184995964, 5043.470435604282, 5047.2429135629945, 5048.1418158913075, 5050.419201791804, 4495.190865644183, 4634.374359461497, 4652.348671186037, 4690.695104818176, 4691.29630555416, 5354.303940487751, 5363.356397232318, 5377.9512994966, 5378.327709036371, 5379.9731001345135, 3942.448057271984, 3952.940705889414, 3960.3465428204313, 3960.7821569813937, 3981.9845939285296, 5471.562275017989, 5575.163725441175, 5608.691521966291, 5615.1750681028425, 5618.91571626426, 4072.75563466193, 4076.612721791425, 4078.899366826087, 4080.836766529365, 4082.3264161413626, 4109.732867363612, 4119.505659320901, 4120.402541631506, 4126.216018956388, 4126.339785634284, 4559.31436188995, 4571.131485017836, 4640.628749700083, 4649.279361698942, 4669.2062349400685, 5421.2952316199435, 5428.96849598575, 5440.265564148789, 5440.319960004999, 5457.727113644302, 1413.9363728632236, 1427.3790900958115, 1427.5003748687875, 1428.9428422862968, 1431.5991522373752, 884.6284560484612, 939.7462685075128, 941.8022215334856, 949.7768024514234, 951.6145960885852, 5106.723319170207, 5230.8169214077325, 5234.246527413359, 5252.0, 5261.842144735664, 5536.916946245809, 5539.944600554023, 5543.972280138573, 5547.618809754532, 5547.694876781735, 5049.2426136079885, 5211.687298762086, 5229.137192363218, 5235.345581802275, 5303.549198318109, 2931.7068293170937, 2952.0516459136866, 2977.196157037588, 2979.910602681923, 2980.5395356275267, 5801.8549536261935, 5804.390538993429, 5819.592628516048, 5820.798560791548, 5869.589128760946, 5610.747516361774, 5687.658740475585, 5695.867272999833, 5716.628419152742, 5731.197632331477, 5757.107648314518, 5789.2763404574425, 5813.7383817728305, 5820.505257053113, 5832.795852145155, 5394.379646340564, 5567.972160139173, 5621.55027597783, 5643.689597072201, 5659.320881494247, 5488.600406896376, 5522.337319521683, 5522.834314970557, 5542.140968149944, 5551.22282880389, 5733.541316694738, 5754.280714910637, 5755.7409916553015, 5759.193712880116, 5768.134779783066, 3576.6423357664025, 3645.635436456439, 3651.817409129586, 3670.8348124335002, 3693.501377314028, 4876.561109500162, 4877.268409738567, 4981.850544483671, 4992.651983964237, 5029.415734043764, 4851.719691744875, 4860.392450943632, 4883.926741098815, 4927.802887884588, 4936.8645211600815, 4569.086182763527, 4823.493533178966, 4844.8304309349005, 4872.512748725099, 4879.292502587176, 4790.808042962408, 4795.95204047969, 4802.927956080732, 4832.197325551102, 4844.660873738945, 5235.089192444806, 5239.349604874453, 5461.453854614507, 5470.890582188414, 5473.644213126134, 5397.298351214317, 5407.134858422633, 5410.891782164256, 5411.323584551931, 5419.376771671151], "value": 4109.782652245209, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.2354974376392, 816.4978538199006, 829.5603330234974, 836.8407776882025, 846.8179341441596, 15233.31450084746, 16589.170541472937, 16630.750538741915, 16637.41769038084, 16645.583860403494, 15077.396904123849, 15588.688226235468, 15759.60600984976, 16256.0, 16293.266802993865, 791.631891170607, 809.9919000810005, 810.3436216664492, 810.5055915891302, 811.0186674124317, 668.1314291421157, 791.1850793682516, 811.8416908702806, 815.9224873636995, 816.9795755106111, 857.3655494933736, 858.2833334165979, 858.4720396955889, 858.8582883824162, 859.0507489224411, 850.8000619854329, 851.8211175653121, 851.974440766778, 852.0286872964825, 852.2372476633441, 504.4249555506725, 604.6553464525223, 618.2025187508109, 619.4270299972508, 620.9968950155265, 15633.530994070195, 15640.921795391065, 15656.686866262726, 15676.608084797972, 15677.764833527506, 13788.310584470737, 13972.650683732887, 14214.360353784105, 14267.928660356632, 14387.136771793621, 12536.623901282885, 12645.178063425848, 12749.681257968625, 12933.935330323382, 13446.676200489319, 4514.571115743999, 4517.2094883395275, 4593.356930029799, 4611.21609326412, 4747.643926705477, 77060.0, 77897.61051194707, 80676.59661701653, 81266.59366703188, 81509.18490815075, 11467.598634047768, 11484.368359740294, 11529.0, 11631.302121872546, 11720.0, 20856.165753369998, 20936.267230646856, 20944.162233510793, 20954.266600668903, 21011.684824727643, 8211.34309255258, 8314.251717345347, 8346.09609235083, 8348.540830254273, 8671.306295496344, 4638.55933686306, 4710.528947105262, 4717.976410117927, 4796.2805579162705, 4898.730569818694, 3383.3064221834466, 3430.794152350867, 3446.2245994651003, 3474.114100904253, 3477.3740726669444, 628.2963081348919, 628.3841835001724, 629.471244154912, 630.612173513286, 650.7722297195944, 575.32686756495, 616.4852348289229, 689.3795583974463, 710.1939298895791, 712.1418690477961, 9156.633734650539, 9171.678991235274, 9204.355695101278, 9351.812963740824, 9481.478518681539, 697.2121502701914, 701.0920857489564, 709.9006139140524, 718.2745427118543, 725.9963700181465, 4023.7384570002855, 4464.732116072981, 4513.571210734975, 4516.548345165523, 4528.750918699503, 67858.32141678619, 83234.0, 114168.42915785368, 116778.0, 118511.40744296396, 96047.51976240074, 96439.0, 96777.5161124204, 97342.0, 98366.5081674587, 86101.56949215214, 86158.53810964078, 86174.0, 86699.0, 88296.0, 8397.496150231005, 8475.364347674073, 8513.106123856905, 8568.186022327869, 8764.298856091626, 41065.60366057746, 51035.74482127566, 51721.7413912928, 53131.468685312655, 53678.0, 75429.0, 77944.0, 80606.59696701479, 80896.59551702204, 83214.58392707998, 10909.781804364027, 11220.719482012688, 11308.49111789988, 11349.262297950607, 11561.421928903354, 12763.234205947672, 12933.288669122912, 12954.28751418681, 13242.0, 13336.0, 10107.797844043225, 11963.820542691692, 12125.15123941351, 12142.210756300812, 13093.541726039542, 13824.792628110385, 13875.306234688023, 14276.0, 14287.71424571482, 14291.42834286617, 13603.455861765418, 14073.437062517385, 14105.294735263402, 14286.42854285817, 14474.27628618586, 10563.313384629975, 10757.246992710436, 10929.18031147683, 11029.61396351124, 11232.382218977707, 11463.828042579202, 11957.940210298893, 12012.074528989098, 12034.458449369624, 12129.514819407477], "value": 7499.371359232448, "unit": "score"}], "name": "dromaeo_css", "value": 7170.602876665549, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 112.0, 112.0, 110.0, 110.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 122.0, 186.0, 122.0, 124.0, 148.0, 124.0, 165.0, 120.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 115.0, 76.0, 76.0, 74.0, 74.0, 100.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 83.0, 84.0, 112.0, 84.0, 84.0, 127.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 144.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 52.0, 54.0, 53.0, 51.0, 54.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 81.0, 75.0, 75.0, 75.0, 76.0, 75.0, 80.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 125.0, 119.0, 120.0, 117.0, 120.0, 125.0, 190.0, 126.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 159.0, 163.0, 162.0, 159.0, 159.0, 159.0, 159.0, 156.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 63.0, 63.0, 62.0, 67.0, 62.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1484.9, "alertThreshold": 2.0}]} 20:53:57 INFO - Return code: 0 20:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:53:57 INFO - # TBPL SUCCESS # 20:53:57 INFO - Running post-action listener: _resource_record_post_action 20:53:57 INFO - [mozharness: 2016-07-29 03:53:57.662848Z] Finished run-tests step (success) 20:53:57 INFO - Running post-run listener: _resource_record_post_run 20:53:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 618496; Write bytes: 369315840; Read time: 228; Write time: 228728 20:53:57 INFO - TinderboxPrint: CPU usage
13.0% 20:53:57 INFO - TinderboxPrint: I/O read bytes / time
618,496 / 228 20:53:57 INFO - TinderboxPrint: I/O write bytes / time
369,315,840 / 228,728 20:53:57 INFO - TinderboxPrint: CPU idle
8,287.9 (87.0%) 20:53:57 INFO - TinderboxPrint: CPU user
1,196.3 (12.6%) 20:53:57 INFO - TinderboxPrint: Swap in / out
0 / 0 20:53:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74366976; Read time: 0; Write time: 36156 20:53:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 618496; Write bytes: 249282560; Read time: 228; Write time: 163324 20:53:58 INFO - Running post-run listener: _upload_blobber_files 20:53:58 INFO - Blob upload gear active. 20:53:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:53:58 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 20:53:58 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:53:58 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:53:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:54:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:02 INFO - (blobuploader) - INFO - Done attempting. 20:54:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:54:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:03 INFO - (blobuploader) - INFO - Done attempting. 20:54:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:54:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:54:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:04 INFO - (blobuploader) - INFO - Done attempting. 20:54:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:54:04 INFO - Return code: 0 20:54:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:54:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:54:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d858120ca3ffb998acc9098bc61380fd86f1c40d1aa552aeb36d4059397ae955be364ee6a3ef3f08a9310b3ed5117b7001575643f88625160bb3b47d5243ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bbdfd35fad234b02500999de2e882cdccd82e0fb86953b642608da2e54b52506d927c65e6c4333129be43b342c1313fb7eb5f35f06089f22334fa2595f43803", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbde107b3e2aed4bdb9e64745e6603b317b19bf144291e39e33d661626b35aa40f255c841022ea4186dfff14e6510f27a15acb9599835b74374be2fc72dc1eee"} 20:54:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:54:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:54:04 INFO - Contents: 20:54:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d858120ca3ffb998acc9098bc61380fd86f1c40d1aa552aeb36d4059397ae955be364ee6a3ef3f08a9310b3ed5117b7001575643f88625160bb3b47d5243ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bbdfd35fad234b02500999de2e882cdccd82e0fb86953b642608da2e54b52506d927c65e6c4333129be43b342c1313fb7eb5f35f06089f22334fa2595f43803", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbde107b3e2aed4bdb9e64745e6603b317b19bf144291e39e33d661626b35aa40f255c841022ea4186dfff14e6510f27a15acb9599835b74374be2fc72dc1eee"} 20:54:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:54:04 INFO - Copying logs to upload dir... 20:54:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:54:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.864590 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-28 20:54:04.242024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 20:54:04.246517) ========= 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=523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138 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/sha512/0d858120ca3ffb998acc9098bc61380fd86f1c40d1aa552aeb36d4059397ae955be364ee6a3ef3f08a9310b3ed5117b7001575643f88625160bb3b47d5243ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bbdfd35fad234b02500999de2e882cdccd82e0fb86953b642608da2e54b52506d927c65e6c4333129be43b342c1313fb7eb5f35f06089f22334fa2595f43803", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbde107b3e2aed4bdb9e64745e6603b317b19bf144291e39e33d661626b35aa40f255c841022ea4186dfff14e6510f27a15acb9599835b74374be2fc72dc1eee"} build_url:https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/ATTy0ytbSSmpMRkuWCmNbg/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/sha512/0d858120ca3ffb998acc9098bc61380fd86f1c40d1aa552aeb36d4059397ae955be364ee6a3ef3f08a9310b3ed5117b7001575643f88625160bb3b47d5243ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bbdfd35fad234b02500999de2e882cdccd82e0fb86953b642608da2e54b52506d927c65e6c4333129be43b342c1313fb7eb5f35f06089f22334fa2595f43803", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbde107b3e2aed4bdb9e64745e6603b317b19bf144291e39e33d661626b35aa40f255c841022ea4186dfff14e6510f27a15acb9599835b74374be2fc72dc1eee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 20:54:04.279106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:54:04.279522) ========= 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=523ca41ca1e0623de333ad52000001bf-1469759752.316643-451571138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:54:04.361973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 20:54:04.362326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 20:54:04.362647) ========= ========= Total master_lag: 0.19 =========