builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1464601937.84 results: success (0) buildid: 20160530011338 builduid: e1797356197c4d4dbf1d500ea2d2bfce revision: be56cb9803a91540033261d76ade0e1f06c4691c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:17.835848) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:17.836357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:17.836671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:17.881361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:17.881768) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 02:52:18-- 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% 222M=0s 2016-05-30 02:52:18 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.346570 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:18.256112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:18.256451) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022812 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:18.410691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 02:52:18.411067) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be56cb9803a91540033261d76ade0e1f06c4691c --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 be56cb9803a91540033261d76ade0e1f06c4691c --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=9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 02:52:18,842 truncating revision to first 12 chars 2016-05-30 02:52:18,842 Setting DEBUG logging. 2016-05-30 02:52:18,842 attempt 1/10 2016-05-30 02:52:18,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be56cb9803a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 02:52:19,827 unpacking tar archive at: fx-team-be56cb9803a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.317338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 02:52:19.746949) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:19.747281) ========= script_repo_revision: be56cb9803a91540033261d76ade0e1f06c4691c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:19.747744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:19.748124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 02:52:19.760132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-30 02:52:19.760548) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:52:20 INFO - MultiFileLogger online at 20160530 02:52:20 in /builds/slave/test 02:52:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:52:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:20 INFO - {'append_to_log': False, 02:52:20 INFO - 'base_work_dir': '/builds/slave/test', 02:52:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:52:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:20 INFO - 'branch': 'Fx-Team-Non-PGO', 02:52:20 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:20 INFO - 'config_files': ('talos/linux_config.py',), 02:52:20 INFO - 'default_actions': ('clobber', 02:52:20 INFO - 'read-buildbot-config', 02:52:20 INFO - 'download-and-extract', 02:52:20 INFO - 'populate-webroot', 02:52:20 INFO - 'create-virtualenv', 02:52:20 INFO - 'install', 02:52:20 INFO - 'run-tests'), 02:52:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:20 INFO - 'download_minidump_stackwalk': True, 02:52:20 INFO - 'download_symbols': 'ondemand', 02:52:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:20 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:20 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:20 INFO - 'installer_path': 'installer.exe', 02:52:20 INFO - 'log_level': 'info', 02:52:20 INFO - 'log_name': 'talos', 02:52:20 INFO - 'log_to_console': True, 02:52:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:52:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:52:20 INFO - 'opt_config_files': (), 02:52:20 INFO - 'pip_index': False, 02:52:20 INFO - 'sps_profile': False, 02:52:20 INFO - 'sps_profile_interval': 0, 02:52:20 INFO - 'suite': 'dromaeojs', 02:52:20 INFO - 'system_bits': '32', 02:52:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:20 INFO - 'title': 'talos-linux64-ix-013', 02:52:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:20 INFO - 'use_talos_json': True, 02:52:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:20 INFO - 'work_dir': 'build'} 02:52:20 INFO - ##### 02:52:20 INFO - ##### Running clobber step. 02:52:20 INFO - ##### 02:52:20 INFO - Running pre-action listener: _resource_record_pre_action 02:52:20 INFO - Running main action method: clobber 02:52:20 INFO - rmtree: /builds/slave/test/build 02:52:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:20 INFO - Running post-action listener: _resource_record_post_action 02:52:20 INFO - ##### 02:52:20 INFO - ##### Finished clobber step (success) 02:52:20 INFO - ##### 02:52:20 INFO - ##### 02:52:20 INFO - ##### Running read-buildbot-config step. 02:52:20 INFO - ##### 02:52:20 INFO - Running pre-action listener: _resource_record_pre_action 02:52:20 INFO - Running main action method: read_buildbot_config 02:52:20 INFO - Using buildbot properties: 02:52:20 INFO - { 02:52:20 INFO - "project": "", 02:52:20 INFO - "product": "firefox", 02:52:20 INFO - "script_repo_revision": "production", 02:52:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:52:20 INFO - "repository": "", 02:52:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:52:20 INFO - "buildid": "20160530011338", 02:52:20 INFO - "pgo_build": "False", 02:52:20 INFO - "basedir": "/builds/slave/test", 02:52:20 INFO - "buildnumber": 1802, 02:52:20 INFO - "slavename": "talos-linux64-ix-013", 02:52:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:52:20 INFO - "platform": "ubuntu64_hw", 02:52:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:52:20 INFO - "branch": "fx-team", 02:52:20 INFO - "repo_path": "integration/fx-team", 02:52:20 INFO - "revision": "be56cb9803a91540033261d76ade0e1f06c4691c", 02:52:20 INFO - "stage_platform": "linux64", 02:52:20 INFO - "builduid": "e1797356197c4d4dbf1d500ea2d2bfce", 02:52:20 INFO - "slavebuilddir": "test" 02:52:20 INFO - } 02:52:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:52:20 INFO - Running post-action listener: _resource_record_post_action 02:52:20 INFO - ##### 02:52:20 INFO - ##### Finished read-buildbot-config step (success) 02:52:20 INFO - ##### 02:52:20 INFO - ##### 02:52:20 INFO - ##### Running download-and-extract step. 02:52:20 INFO - ##### 02:52:20 INFO - Running pre-action listener: _resource_record_pre_action 02:52:20 INFO - Running main action method: download_and_extract 02:52:20 INFO - mkdir: /builds/slave/test/build/tests 02:52: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')]} 02:52:20 INFO - https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:52:22 INFO - Downloaded 1361 bytes. 02:52:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:52:22 INFO - Using the following test package requirements: 02:52:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:52:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:52:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:52:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'jsshell-linux-x86_64.zip'], 02:52:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:52:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:52:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:52:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:52:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:52:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:52:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:52:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:52: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')]} 02:52:22 INFO - https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:52:24 INFO - Downloaded 22837897 bytes. 02:52:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:52:25 INFO - Return code: 0 02:52:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:25 INFO - https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:52:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:52:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:52:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:52:26 INFO - Downloaded 22837897 bytes. 02:52:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:52:28 INFO - Return code: 0 02:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:28 INFO - https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:52:29 INFO - Downloaded 10834034 bytes. 02:52:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:52:29 INFO - Return code: 0 02:52:29 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')]} 02:52:29 INFO - https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:52:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:52:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:52:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:52:32 INFO - Downloaded 54850088 bytes. 02:52:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:52:32 INFO - mkdir: /builds/slave/test/properties 02:52:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:32 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:32 INFO - Contents: 02:52:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - Running post-action listener: set_extra_try_arguments 02:52:33 INFO - ##### 02:52:33 INFO - ##### Finished download-and-extract step (success) 02:52:33 INFO - ##### 02:52:33 INFO - ##### 02:52:33 INFO - ##### Running populate-webroot step. 02:52:33 INFO - ##### 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: populate_webroot 02:52:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:33 INFO - '--tppagecycles', 02:52:33 INFO - '7'], 02:52:33 INFO - 'tests': ['tsvgm']}}, 02:52:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['damp', 'tps']}, 02:52:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'tests': ['damp', 'tps']}, 02:52:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['dromaeo_dom']}, 02:52:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tsvgx', 02:52:33 INFO - 'tsvgr_opacity', 02:52:33 INFO - 'tart', 02:52:33 INFO - 'tscrollx', 02:52:33 INFO - 'cart']}, 02:52:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:33 INFO - 'tsvgr_opacity', 02:52:33 INFO - 'tart', 02:52:33 INFO - 'tscrollx', 02:52:33 INFO - 'cart']}, 02:52:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tp5o']}, 02:52:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'tests': ['tp5o']}, 02:52:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s', 02:52:33 INFO - '--xperf_path', 02:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:33 INFO - 'tests': ['tp5n']}, 02:52:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--xperf_path', 02:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:33 INFO - 'tests': ['tp5n']}}, 02:52:33 INFO - 'talos.zip': {'path': '', 02:52:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - ##### 02:52:33 INFO - ##### Finished populate-webroot step (success) 02:52:33 INFO - ##### 02:52:33 INFO - ##### 02:52:33 INFO - ##### Running create-virtualenv step. 02:52:33 INFO - ##### 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: create_virtualenv 02:52:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:52:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:33 INFO - Using real prefix '/usr' 02:52:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:33 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:35 INFO - Installing pip.................done. 02:52:35 INFO - Return code: 0 02:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:52:35 INFO - Using env: {'DISPLAY': ':0', 02:52:35 INFO - 'HOME': '/home/cltbld', 02:52:35 INFO - 'LANG': 'en_US.UTF-8', 02:52:35 INFO - 'LANGUAGE': 'en_US:en', 02:52:35 INFO - 'LOGNAME': 'cltbld', 02:52:35 INFO - 'MAIL': '/var/mail/cltbld', 02:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:35 INFO - 'MOZ_NO_REMOTE': '1', 02:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:35 INFO - 'NO_EM_RESTART': '1', 02:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:35 INFO - 'PWD': '/builds/slave/test', 02:52:35 INFO - 'SHELL': '/bin/bash', 02:52:35 INFO - 'SHLVL': '1', 02:52:35 INFO - 'TERM': 'linux', 02:52:35 INFO - 'TMOUT': '86400', 02:52:35 INFO - 'USER': 'cltbld', 02:52:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:35 INFO - '_': '/tools/buildbot/bin/python'} 02:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:35 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 02:52:35 INFO - Cleaning up... 02:52:35 INFO - Return code: 0 02:52:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:52:35 INFO - Using env: {'DISPLAY': ':0', 02:52:35 INFO - 'HOME': '/home/cltbld', 02:52:35 INFO - 'LANG': 'en_US.UTF-8', 02:52:35 INFO - 'LANGUAGE': 'en_US:en', 02:52:35 INFO - 'LOGNAME': 'cltbld', 02:52:35 INFO - 'MAIL': '/var/mail/cltbld', 02:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:35 INFO - 'MOZ_NO_REMOTE': '1', 02:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:35 INFO - 'NO_EM_RESTART': '1', 02:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:35 INFO - 'PWD': '/builds/slave/test', 02:52:35 INFO - 'SHELL': '/bin/bash', 02:52:35 INFO - 'SHLVL': '1', 02:52:35 INFO - 'TERM': 'linux', 02:52:35 INFO - 'TMOUT': '86400', 02:52:35 INFO - 'USER': 'cltbld', 02:52:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:35 INFO - '_': '/tools/buildbot/bin/python'} 02:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:36 INFO - Downloading/unpacking psutil>=3.1.1 02:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:38 INFO - Installing collected packages: psutil 02:52:38 INFO - Running setup.py install for psutil 02:52:38 INFO - building 'psutil._psutil_linux' extension 02:52:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:52:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:52:38 INFO - building 'psutil._psutil_posix' extension 02:52:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:52:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:52:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:38 INFO - Successfully installed psutil 02:52:38 INFO - Cleaning up... 02:52:38 INFO - Return code: 0 02:52:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:52:38 INFO - Using env: {'DISPLAY': ':0', 02:52:38 INFO - 'HOME': '/home/cltbld', 02:52:38 INFO - 'LANG': 'en_US.UTF-8', 02:52:38 INFO - 'LANGUAGE': 'en_US:en', 02:52:38 INFO - 'LOGNAME': 'cltbld', 02:52:38 INFO - 'MAIL': '/var/mail/cltbld', 02:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:38 INFO - 'MOZ_NO_REMOTE': '1', 02:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:38 INFO - 'NO_EM_RESTART': '1', 02:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:38 INFO - 'PWD': '/builds/slave/test', 02:52:38 INFO - 'SHELL': '/bin/bash', 02:52:38 INFO - 'SHLVL': '1', 02:52:38 INFO - 'TERM': 'linux', 02:52:38 INFO - 'TMOUT': '86400', 02:52:38 INFO - 'USER': 'cltbld', 02:52:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:38 INFO - '_': '/tools/buildbot/bin/python'} 02:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:41 INFO - Installing collected packages: mozsystemmonitor 02:52:41 INFO - Running setup.py install for mozsystemmonitor 02:52:41 INFO - Successfully installed mozsystemmonitor 02:52:41 INFO - Cleaning up... 02:52:41 INFO - Return code: 0 02:52:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:52:41 INFO - Using env: {'DISPLAY': ':0', 02:52:41 INFO - 'HOME': '/home/cltbld', 02:52:41 INFO - 'LANG': 'en_US.UTF-8', 02:52:41 INFO - 'LANGUAGE': 'en_US:en', 02:52:41 INFO - 'LOGNAME': 'cltbld', 02:52:41 INFO - 'MAIL': '/var/mail/cltbld', 02:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:41 INFO - 'MOZ_NO_REMOTE': '1', 02:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:41 INFO - 'NO_EM_RESTART': '1', 02:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:41 INFO - 'PWD': '/builds/slave/test', 02:52:41 INFO - 'SHELL': '/bin/bash', 02:52:41 INFO - 'SHLVL': '1', 02:52:41 INFO - 'TERM': 'linux', 02:52:41 INFO - 'TMOUT': '86400', 02:52:41 INFO - 'USER': 'cltbld', 02:52:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:41 INFO - '_': '/tools/buildbot/bin/python'} 02:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:42 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 02:52:42 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 02:52:42 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 02:52:42 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 02:52:42 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 02:52:42 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 02:52:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:44 INFO - Downloading docopt-0.6.1.tar.gz 02:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:44 INFO - Running setup.py install for blobuploader 02:52:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:44 INFO - Running setup.py install for requests 02:52:45 INFO - Running setup.py install for docopt 02:52:45 INFO - Successfully installed blobuploader requests docopt 02:52:45 INFO - Cleaning up... 02:52:45 INFO - Return code: 0 02:52:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:45 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')]} 02:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:45 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')]} 02:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:45 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 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:45 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 02:52:45 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 02:52:45 INFO - Using env: {'DISPLAY': ':0', 02:52:45 INFO - 'HOME': '/home/cltbld', 02:52:45 INFO - 'LANG': 'en_US.UTF-8', 02:52:45 INFO - 'LANGUAGE': 'en_US:en', 02:52:45 INFO - 'LOGNAME': 'cltbld', 02:52:45 INFO - 'MAIL': '/var/mail/cltbld', 02:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:45 INFO - 'MOZ_NO_REMOTE': '1', 02:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:45 INFO - 'NO_EM_RESTART': '1', 02:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:45 INFO - 'PWD': '/builds/slave/test', 02:52:45 INFO - 'SHELL': '/bin/bash', 02:52:45 INFO - 'SHLVL': '1', 02:52:45 INFO - 'TERM': 'linux', 02:52:45 INFO - 'TMOUT': '86400', 02:52:45 INFO - 'USER': 'cltbld', 02:52:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:45 INFO - '_': '/tools/buildbot/bin/python'} 02:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:45 INFO - Running setup.py (path:/tmp/pip-U273jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:45 INFO - Running setup.py (path:/tmp/pip-YtF63Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:45 INFO - Running setup.py (path:/tmp/pip-tbYxnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:45 INFO - Running setup.py (path:/tmp/pip-1FPq_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:45 INFO - Running setup.py (path:/tmp/pip-7rzkXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:45 INFO - Running setup.py (path:/tmp/pip-hwttrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:45 INFO - Running setup.py (path:/tmp/pip-oxkbEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:46 INFO - Running setup.py (path:/tmp/pip-3EWKbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:46 INFO - Running setup.py (path:/tmp/pip-JcU_DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:46 INFO - Running setup.py (path:/tmp/pip-z80UTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:46 INFO - Running setup.py (path:/tmp/pip-VrcTwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:46 INFO - Running setup.py (path:/tmp/pip-OPgSUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:46 INFO - Running setup.py (path:/tmp/pip-Ag9NC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:46 INFO - Running setup.py (path:/tmp/pip-G22zxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:46 INFO - Running setup.py (path:/tmp/pip-ZCtGlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:46 INFO - Running setup.py (path:/tmp/pip-FYfuWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:46 INFO - Running setup.py (path:/tmp/pip-4NjPAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:46 INFO - Running setup.py install for manifestparser 02:52:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:46 INFO - Running setup.py install for mozcrash 02:52:47 INFO - Running setup.py install for mozdebug 02:52:47 INFO - Running setup.py install for mozdevice 02:52:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Running setup.py install for mozfile 02:52:47 INFO - Running setup.py install for mozhttpd 02:52:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Running setup.py install for mozinfo 02:52:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Running setup.py install for mozInstall 02:52:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Running setup.py install for mozleak 02:52:47 INFO - Running setup.py install for mozlog 02:52:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Running setup.py install for moznetwork 02:52:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:47 INFO - Running setup.py install for mozprocess 02:52:48 INFO - Running setup.py install for mozprofile 02:52:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:48 INFO - Running setup.py install for mozrunner 02:52:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:48 INFO - Running setup.py install for mozscreenshot 02:52:48 INFO - Running setup.py install for moztest 02:52:48 INFO - Running setup.py install for mozversion 02:52:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:48 INFO - Cleaning up... 02:52:48 INFO - Return code: 0 02:52:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:48 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')]} 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 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')]} 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 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 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:48 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 02:52:48 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 02:52:48 INFO - Using env: {'DISPLAY': ':0', 02:52:48 INFO - 'HOME': '/home/cltbld', 02:52:48 INFO - 'LANG': 'en_US.UTF-8', 02:52:48 INFO - 'LANGUAGE': 'en_US:en', 02:52:48 INFO - 'LOGNAME': 'cltbld', 02:52:48 INFO - 'MAIL': '/var/mail/cltbld', 02:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:48 INFO - 'MOZ_NO_REMOTE': '1', 02:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:48 INFO - 'NO_EM_RESTART': '1', 02:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:48 INFO - 'PWD': '/builds/slave/test', 02:52:48 INFO - 'SHELL': '/bin/bash', 02:52:48 INFO - 'SHLVL': '1', 02:52:48 INFO - 'TERM': 'linux', 02:52:48 INFO - 'TMOUT': '86400', 02:52:48 INFO - 'USER': 'cltbld', 02:52:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:48 INFO - '_': '/tools/buildbot/bin/python'} 02:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:48 INFO - Running setup.py (path:/tmp/pip-sxSVHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:48 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)) 02:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:48 INFO - Running setup.py (path:/tmp/pip-3mnP_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:48 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)) 02:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:48 INFO - Running setup.py (path:/tmp/pip-vLUzHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:49 INFO - Running setup.py (path:/tmp/pip-j2SBzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:49 INFO - Running setup.py (path:/tmp/pip-k5Gykb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:49 INFO - Running setup.py (path:/tmp/pip-M9NjmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:49 INFO - Running setup.py (path:/tmp/pip-bG_FOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:49 INFO - Running setup.py (path:/tmp/pip-Lb5F6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:49 INFO - Running setup.py (path:/tmp/pip-loYUAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:49 INFO - Running setup.py (path:/tmp/pip-uCMDTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:49 INFO - Running setup.py (path:/tmp/pip-7Eoi5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:49 INFO - Running setup.py (path:/tmp/pip-NjkVbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:49 INFO - Running setup.py (path:/tmp/pip-S_vLlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:49 INFO - Running setup.py (path:/tmp/pip-IlKLHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:49 INFO - Running setup.py (path:/tmp/pip-PgVU3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:49 INFO - Running setup.py (path:/tmp/pip-UgyUZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:49 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)) 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:49 INFO - Running setup.py (path:/tmp/pip-TPPblX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:50 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)) 02:52:50 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)) 02:52:50 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)) 02:52:50 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)) 02:52:50 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)) 02:52:50 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)) 02:52:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:51 INFO - Downloading blessings-1.6.tar.gz 02:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:52 INFO - Installing collected packages: blessings 02:52:52 INFO - Running setup.py install for blessings 02:52:52 INFO - Successfully installed blessings 02:52:52 INFO - Cleaning up... 02:52:52 INFO - Return code: 0 02:52:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:52 INFO - Reading from file tmpfile_stdout 02:52:52 INFO - Current package versions: 02:52:52 INFO - argparse == 1.2.1 02:52:52 INFO - blessings == 1.6 02:52:52 INFO - blobuploader == 1.2.4 02:52:52 INFO - docopt == 0.6.1 02:52:52 INFO - manifestparser == 1.1 02:52:52 INFO - mozInstall == 1.12 02:52:52 INFO - mozcrash == 0.17 02:52:52 INFO - mozdebug == 0.1 02:52:52 INFO - mozdevice == 0.48 02:52:52 INFO - mozfile == 1.2 02:52:52 INFO - mozhttpd == 0.7 02:52:52 INFO - mozinfo == 0.9 02:52:52 INFO - mozleak == 0.1 02:52:52 INFO - mozlog == 3.2 02:52:52 INFO - moznetwork == 0.27 02:52:52 INFO - mozprocess == 0.22 02:52:52 INFO - mozprofile == 0.28 02:52:52 INFO - mozrunner == 6.11 02:52:52 INFO - mozscreenshot == 0.1 02:52:52 INFO - mozsystemmonitor == 0.3 02:52:52 INFO - moztest == 0.7 02:52:52 INFO - mozversion == 1.4 02:52:52 INFO - psutil == 3.1.1 02:52:52 INFO - requests == 1.2.3 02:52:52 INFO - wsgiref == 0.1.2 02:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:52 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 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:52 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 02:52:52 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 02:52:52 INFO - Using env: {'DISPLAY': ':0', 02:52:52 INFO - 'HOME': '/home/cltbld', 02:52:52 INFO - 'LANG': 'en_US.UTF-8', 02:52:52 INFO - 'LANGUAGE': 'en_US:en', 02:52:52 INFO - 'LOGNAME': 'cltbld', 02:52:52 INFO - 'MAIL': '/var/mail/cltbld', 02:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:52 INFO - 'MOZ_NO_REMOTE': '1', 02:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:52 INFO - 'NO_EM_RESTART': '1', 02:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:52 INFO - 'PWD': '/builds/slave/test', 02:52:52 INFO - 'SHELL': '/bin/bash', 02:52:52 INFO - 'SHLVL': '1', 02:52:52 INFO - 'TERM': 'linux', 02:52:52 INFO - 'TMOUT': '86400', 02:52:52 INFO - 'USER': 'cltbld', 02:52:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:52 INFO - '_': '/tools/buildbot/bin/python'} 02:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 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)) 02:52:52 INFO - Cleaning up... 02:52:52 INFO - Return code: 0 02:52:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52: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', 'jsonschema'] in /builds/slave/test/build 02:52: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 jsonschema 02:52:52 INFO - Using env: {'DISPLAY': ':0', 02:52:52 INFO - 'HOME': '/home/cltbld', 02:52:52 INFO - 'LANG': 'en_US.UTF-8', 02:52:52 INFO - 'LANGUAGE': 'en_US:en', 02:52:52 INFO - 'LOGNAME': 'cltbld', 02:52:52 INFO - 'MAIL': '/var/mail/cltbld', 02:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:52 INFO - 'MOZ_NO_REMOTE': '1', 02:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:52 INFO - 'NO_EM_RESTART': '1', 02:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:52 INFO - 'PWD': '/builds/slave/test', 02:52:52 INFO - 'SHELL': '/bin/bash', 02:52:52 INFO - 'SHLVL': '1', 02:52:52 INFO - 'TERM': 'linux', 02:52:52 INFO - 'TMOUT': '86400', 02:52:52 INFO - 'USER': 'cltbld', 02:52:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:52 INFO - '_': '/tools/buildbot/bin/python'} 02:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:52 INFO - Downloading/unpacking jsonschema 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:54 INFO - Downloading/unpacking functools32 (from jsonschema) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:54 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:54 INFO - warning: no files found matching '*.txt' 02:52:54 INFO - no previously-included directories found matching 'build' 02:52:54 INFO - no previously-included directories found matching 'dist' 02:52:54 INFO - no previously-included directories found matching '.git*' 02:52:54 INFO - Installing collected packages: jsonschema, functools32 02:52:55 INFO - Running setup.py install for functools32 02:52:55 INFO - warning: no files found matching '*.txt' 02:52:55 INFO - no previously-included directories found matching 'build' 02:52:55 INFO - no previously-included directories found matching 'dist' 02:52:55 INFO - no previously-included directories found matching '.git*' 02:52:55 INFO - Successfully installed jsonschema functools32 02:52:55 INFO - Cleaning up... 02:52:55 INFO - Return code: 0 02:52:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6a36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', '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 02:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:52:55 INFO - Using env: {'DISPLAY': ':0', 02:52:55 INFO - 'HOME': '/home/cltbld', 02:52:55 INFO - 'LANG': 'en_US.UTF-8', 02:52:55 INFO - 'LANGUAGE': 'en_US:en', 02:52:55 INFO - 'LOGNAME': 'cltbld', 02:52:55 INFO - 'MAIL': '/var/mail/cltbld', 02:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:55 INFO - 'MOZ_NO_REMOTE': '1', 02:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:55 INFO - 'NO_EM_RESTART': '1', 02:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:55 INFO - 'PWD': '/builds/slave/test', 02:52:55 INFO - 'SHELL': '/bin/bash', 02:52:55 INFO - 'SHLVL': '1', 02:52:55 INFO - 'TERM': 'linux', 02:52:55 INFO - 'TMOUT': '86400', 02:52:55 INFO - 'USER': 'cltbld', 02:52:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:55 INFO - '_': '/tools/buildbot/bin/python'} 02:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:55 INFO - Downloading/unpacking flake8 02:52:55 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 02:52:55 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 02:52:55 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 02:52:55 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 02:52:55 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 02:52:55 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 02:52:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:52:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:52:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 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 02:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:52:58 INFO - no previously-included directories found matching 'docs/_build' 02:52:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:52:58 INFO - Running setup.py install for pep8 02:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:52:58 INFO - no previously-included directories found matching 'docs/_build' 02:52:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:52:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Running post-action listener: _resource_record_post_action 02:52:58 INFO - Running post-action listener: _start_resource_monitoring 02:52:58 INFO - Starting resource monitoring. 02:52:58 INFO - ##### 02:52:58 INFO - ##### Finished create-virtualenv step (success) 02:52:58 INFO - ##### 02:52:58 INFO - ##### 02:52:58 INFO - ##### Running install step. 02:52:58 INFO - ##### 02:52:58 INFO - Running pre-action listener: _resource_record_pre_action 02:52:58 INFO - Running main action method: install 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Output received: 02:52:58 INFO - Usage: mozinstall [options] installer 02:52:58 INFO - Options: 02:52:58 INFO - -h, --help show this help message and exit 02:52:58 INFO - -d DEST, --destination=DEST 02:52:58 INFO - Directory to install application into. [default: 02:52:58 INFO - "/builds/slave/test"] 02:52:58 INFO - --app=APP Application being installed. [default: firefox] 02:52:58 INFO - mkdir: /builds/slave/test/build/application 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:53:14 INFO - Reading from file tmpfile_stdout 02:53:14 INFO - Output received: 02:53:14 INFO - /builds/slave/test/build/application/firefox/firefox 02:53:14 INFO - Running post-action listener: _resource_record_post_action 02:53:14 INFO - ##### 02:53:14 INFO - ##### Finished install step (success) 02:53:14 INFO - ##### 02:53:14 INFO - ##### 02:53:14 INFO - ##### Running run-tests step. 02:53:14 INFO - ##### 02:53:14 INFO - Running pre-action listener: _resource_record_pre_action 02:53:14 INFO - Running main action method: run_tests 02:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:14 INFO - Python 2.7.3 02:53:14 INFO - Return code: 0 02:53:14 INFO - grabbing minidump binary from tooltool 02:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aab20>, '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 0x12aba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12abeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:53:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:53:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:53:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:14 INFO - Return code: 0 02:53:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:53:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:53:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:53:15 INFO - Return code: 0 02:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 02:53:15 INFO - Using env: {'DISPLAY': ':0', 02:53:15 INFO - 'HOME': '/home/cltbld', 02:53:15 INFO - 'LANG': 'en_US.UTF-8', 02:53:15 INFO - 'LANGUAGE': 'en_US:en', 02:53:15 INFO - 'LOGNAME': 'cltbld', 02:53:15 INFO - 'MAIL': '/var/mail/cltbld', 02:53:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:15 INFO - 'MOZ_NO_REMOTE': '1', 02:53:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:15 INFO - 'NO_EM_RESTART': '1', 02:53:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:15 INFO - 'PWD': '/builds/slave/test', 02:53:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:15 INFO - 'SHELL': '/bin/bash', 02:53:15 INFO - 'SHLVL': '1', 02:53:15 INFO - 'TERM': 'linux', 02:53:15 INFO - 'TMOUT': '86400', 02:53:15 INFO - 'USER': 'cltbld', 02:53:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218', 02:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:15 INFO - '_': '/tools/buildbot/bin/python'} 02:53:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:53:15 INFO - mozversion application_buildid: 20160530011338 02:53:15 INFO - mozversion application_changeset: be56cb9803a91540033261d76ade0e1f06c4691c 02:53:15 INFO - mozversion application_display_name: Nightly 02:53:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:15 INFO - mozversion application_name: Firefox 02:53:15 INFO - mozversion application_remotingname: firefox 02:53:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:53:15 INFO - mozversion application_vendor: Mozilla 02:53:15 INFO - mozversion application_version: 49.0a1 02:53:15 INFO - mozversion platform_buildid: 20160530011338 02:53:15 INFO - mozversion platform_changeset: be56cb9803a91540033261d76ade0e1f06c4691c 02:53:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:53:15 INFO - mozversion platform_version: 49.0a1 02:53:15 INFO - using testdate: 1464601995 02:53:15 INFO - actual date: 1464601995 02:53:15 INFO - starting webserver on 'localhost:42485' 02:53:15 INFO - SUITE-START | Running 2 tests 02:53:15 INFO - TEST-START | dromaeo_css 02:53:15 INFO - operating with platform_type : linux_ 02:53:15 INFO - Initialising browser for dromaeo_css test... 02:53:15 INFO - TEST-INFO | started process 27176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptaKmr9/profile http://localhost:42485/getInfo.html) 02:53:20 INFO - PROCESS | 27176 | __metrics Screen width/height:1600/1200 02:53:20 INFO - PROCESS | 27176 | colorDepth:24 02:53:20 INFO - PROCESS | 27176 | Browser inner width/height: 1024/697 02:53:20 INFO - PROCESS | 27176 | __metrics 02:53:21 ERROR - PROCESS | 27176 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:53:22 INFO - TEST-INFO | 27176: exit 0 02:53:22 INFO - Browser initialized. 02:53:22 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:22 INFO - TEST-INFO | started process 27259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptaKmr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:34 INFO - PROCESS | 27259 | RSS: Main: 156344320 02:53:34 INFO - PROCESS | 27259 | 02:54:25 INFO - PROCESS | 27259 | 1464602065617 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] 02:56:37 INFO - PROCESS | 27259 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42485/tests/dromaeo/cssquery-ext.html) 02:56:38 INFO - PROCESS | 27259 | RSS: Main: 232443904 02:56:38 INFO - PROCESS | 27259 | 02:59:40 INFO - PROCESS | 27259 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-ext.html (next: http://localhost:42485/tests/dromaeo/cssquery-jquery.html) 02:59:41 INFO - PROCESS | 27259 | RSS: Main: 237166592 02:59:41 INFO - PROCESS | 27259 | 03:02:43 INFO - PROCESS | 27259 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42485/tests/dromaeo/cssquery-mootools.html) 03:02:44 INFO - PROCESS | 27259 | RSS: Main: 241733632 03:02:44 INFO - PROCESS | 27259 | 03:05:46 INFO - PROCESS | 27259 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42485/tests/dromaeo/cssquery-prototype.html) 03:05:47 INFO - PROCESS | 27259 | RSS: Main: 235700224 03:05:47 INFO - PROCESS | 27259 | 03:08:49 INFO - PROCESS | 27259 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42485/tests/dromaeo/cssquery-yui.html) 03:08:50 INFO - PROCESS | 27259 | RSS: Main: 223232000 03:08:50 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-yui.html (next: http://localhost:42485/tests/dromaeo/cssquery-dojo.html) 03:11:53 INFO - PROCESS | 27259 | RSS: Main: 276312064 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | __start_tp_report 03:11:53 INFO - PROCESS | 27259 | _x_x_mozilla_page_load 03:11:53 INFO - PROCESS | 27259 | _x_x_mozilla_page_load_details 03:11:53 INFO - PROCESS | 27259 | |i|pagename|runs| 03:11:53 INFO - PROCESS | 27259 | |0;dojo.html;2645.047782798193;2673.2782148819833;2679.11589175572;2692.2057992892096;2700.2709268497506;4643.396358473394;4727.149113159629;4740.407449068866;4775.856724298273;4811.687240329376;4734.857954261369;4749.952500474994;4752.500987396325;4780.043991201756;4853.344798452208;4330.307150855863;4342.153280110364;4398.626116780078;4445.57767012135;4533.954660453386;4419.558044195587;4465.129299786527;4482.372467854503;4494.168578812913;4520.141173177086;4275.593818587229;4317.784110794479;4320;4358.5859343362645;4405.691601587891;4339.132173565268;4346.73919564824;4348.282533381988;4351.782410879475;4405.7797110144365;4360.934585981213;4368.191884501377;4372.846950356754;4374.12517496502;4418.867433976986;4593.219152744042;4625.074985002979;4676.602488788457;4780.450248221464;4782.426108866958;5027.723475208862;5050.7222102784335;5100.948990510122;5104.285400043997;5105.2086926526445;5088.77100530477;5138.640295179339;5147.305113809625;5148.279240906276;5152.201408781645;4670.509596492388;4691.83578574755;4783.617310615143;4788.521147885219;4788.545088216614;5269.631125821233;5272.499112584298;5274.287971123849;5300.337457817773;5312.681239125664;5058.620603454756;5066.138756411419;5066.392032955995;5069.087564238473;5088.847334579968;4991.251312303184;5067.97466012675;5099.898002039939;5108.386993560722;5123.820666276737;5097.362829646294;5098.694078355311;5105.285260063594;5129.846104616868;5139.871503212449;5085.1355269604255;5087.135187018216;5088.847334579968;5089.847304580869;5150.072986862401;4317.158154159909;4372.081862808782;4375.037491751809;4386.2762644163995;4437.955620443754;3824.101336185994;3851.114243723959;3868.187680587052;3872.9806350968065;3880.049387899983;4417.3815665806815;4417.801198946056;4423.845165419195;4427.623651989553;4427.889302767392;5049.545540901337;5108.438071812097;5112.872178195575;5115.462876397924;5171.172612382001;4367.6287515561535;4389.341598760211;4405.449318835145;4408.382826404306;4445.444319460067;4479.664025198058;4590.839320623762;4591.494935557086;4592.908141837144;4645.117427688729;4789.042191561702;4817.8313759018965;4848.7090774553635;4862.756862156807;4864.343313652612;5152.716600587004;5163.406208285945;5164.7934082636275;5171.663841850268;5220.843374698765;4687.789049492712;4785.688930219525;4843.297721830244;4858.58702010333;4905.362302900743;5019.7239151847;5030.572401345927;5038.093143234253;5055.266986286894;5095.210242412432;5109.31024311728;5118.795248190179;5121.8975620486635;5130.461301563282;5175.689458632494;4841.95158048415;4864.221724524059;4900.779464924016;4964.156093464192;4979.427365852974;4922.433920099091;4939.481354457874;4940.925886111783;4943.777530011086;4981.37732783402;4880.95119048805;4885.65800393969;4923.212286034217;4927.926081108858;4935.876603084952;4879.268109783419;4922.532359425849;4957.900841983213;4989.650724449254;5024.698518088926;4873.46391896884;4882.804687812448;4897.559219670246;4901.117798796251;4933.33399991011 03:11:53 INFO - PROCESS | 27259 | |1;ext.html;570.9343425506065;588.9911651325231;591.2550186764676;599.4934280532949;614.9077638354248;27413.177604671866;40033;40742.79628601853;40818.38772418416;40896.38655420171;42048.78975605125;42573.36139957903;42583.78708106463;42613.36079958803;42621;7725.420593455499;7878.606069696492;7880.960595197016;7899.407544434191;7901;7674.501157424749;7785.338246249075;7811.179826118261;7812.531248125102;7816.843663126734;7813.21867813217;7827.3346765525;7852.411069169807;7854.764357069297;7867.842643147163;7785.805354866117;7805.219478052206;7805.414593905423;7820.491668041616;7836.177201393829;7562.810929726801;7638.8472230555635;7647.426443016796;7652.081750189957;7659.272369124924;38002;38331.61668383336;38499.42250866239;38518.80740596279;38541.22917541634;2968.7921845470823;3061.7550595952493;3117.3297740985795;3396.8980930571875;3801.5628202756484;29446.26384340387;29667.258318541994;30385;30394.240143996354;30423.543646845315;3477.5826900772067;3487.34527711673;3516.7010804081683;3522.7710198836994;3529.982350088259;174654;176644;176757;176871;176929;51089;51162;51347;51392.74303628458;51478.22782658263;47367;52160;52958.205626915624;53328.73335633297;59524.40475595189;13394;13536.187828730308;13538.86461135376;13544.525941591997;13550.051496395157;9208.907910920805;10174.084332409971;10254.6410875619;10310.07209351162;10323.174146068297;14793;15079.54761357161;15297.235138243042;15659.608509787118;15748.92125539365;5925.762969481259;5980.611260268069;6032.758689652364;6099.146119543268;6169.84575385619;765.7205120131223;847.8685803700437;860.3633311349681;880;923.2752289452882;27842;28079;28300.858495707802;28560.42879142447;28814.135575932756;958.91849192818;977.3451787302524;1048.0410424461531;1056.7675111475462;1106.1316866260108;14821;15132.167730774692;15208.543743687707;15289.847101529065;15426.305816238297;376902;377410;379739;379987;382969;50048;50071;50227;50268.74865625649;50280.24579631309;1090.7164137324194;1185.853604974998;1216.580279803484;1226.6565361698738;1227.7605866856056;28253.858730706215;29187.7081229185;29417.55873661854;29454.263643409085;29904;42011.579884200764;42153.156936860476;42613.14773704571;42629.57370426256;42753.78623106865;302511;304597;305211;305811;306667;30626.84686576553;38229.61770382261;39013.41479877747;39697.61058362944;39759.60240397674;42561.78719106385;42596.78701606596;42954.78522607367;43345.78327108471;43423.34864977091;36121.45817812682;36633.63366366409;36853;37384.626153739206;37419.81290093532;36021.81989090038;36144.81927590345;36737;37001.629983699815;37059.25881482301;35517;36056.45915311325;36092.63907360998;36339.091522712144;36462.4530632046;32026.35947281088;32340.676593234708;32694.085836095084;32717.345653087283;33031.50452743259;24856;24882;25063;25065.480994420082;25421.364465888502 03:11:53 INFO - PROCESS | 27259 | |2;jquery.html;372.6031776158391;373.19576313045377;376.9020054785755;383.12073790650453;383.3636163967814;15837.604059898495;17321;17427.825721742778;17730.695009648745;17809.465716028506;11859.466324015419;15698;16359.100249486273;16380.590485237844;17072.743908841378;1433.0899878577075;4635.860924172272;4798.0164066366315;4808.735519546441;4813.951860481403;3509.3858574749443;3666.8716594919183;4736.763161841911;5318.734063296839;5636.464535869086;5584.078627026536;5603.075492543725;5613.747381367848;5622.690752008638;5640.802571909984;5209.895802083956;5492.588055895823;5519.834404967857;5584.5811564132855;5594.58040646951;3430.1081718753053;5075.873103172414;5379.327584051994;5389.299391079174;5408.026555220059;11060.612878549293;11185.32888026721;11246.943765281203;11294.94352528232;12427.005839532816;1740.1995082262174;1797.0565453137076;1802.288096202006;1858.5818190907073;1869.1401955100534;9353.158215760614;9728.075832795874;9967.700968970943;10728.570857165703;13570.389332480063;1648.282996896342;1733.1767410480047;1778.1020584604692;1781.9910900445416;1818.2817786974072;46986.53013469856;68598.31401685969;68622.65688671525;69205;69547.30452695458;10040.347377420445;10252.23108266883;10346.637867674595;10795.622153224756;11099.167562432689;14059.43762249519;14236.501722439665;14237.85762142386;14248.145111293356;14266.714665706628;6695.732170713214;6832.658367081626;6914.9308506915295;6924;6939.063226464464;6351.714172862232;6355.269144048401;6363.522735794834;6495.220573531206;6504.577202481823;4154.065335299533;4247.548257498388;4254.595813397722;4256.638185754246;4427.512973572904;1576.1961399686243;1711.144427786107;1726.464795913271;1774.9112544372729;1799.8057693340158;778.4473024152915;833.4332653795356;839.6935118681637;871.4858233642054;897.6588896219395;16315.51053468398;16553.121615483928;16762.245698943578;16935.15324233808;17071.487855364358;800.1598321762126;828.6975254032355;834.486790623762;839.4040231435627;853.159637756809;9208.815823683488;9291.117343852324;9448.527573621292;9471.668491602899;9628.71113866585;367862;368990;376294;392015;395636;79380.60309698415;82141.58929205436;82993.58503207445;83777;84319.5784021076;949.9620015199453;968.6754937096151;969.6363863551027;990.4156547636928;995.0447570332561;15238.695226095639;15454.690906182039;15599.376024959329;15631.374745010527;15986.920065399598;36267.45598815967;36816.44775328426;36962.630373695916;37454.876353709435;37582;48796.75601621969;50734.23898641449;50890.74554627203;50892.49107508877;51018;7113.146422429341;7153.535020223669;7160.964195178991;7178;7341.3392794648735;9370.625174992923;9595.568199431182;11251;11336.546538138382;11588.188826782045;9422.575984080595;9536.046395360408;9574.186194173573;9578.90421095808;9873.950630246803;4842.7820748065715;8564.52895090776;9461.479618621042;9569.330196830622;9572.617095316109;9561.521923903916;9663.27525435581;9915.26808662366;10031.29780915329;10083.798324033625;7191.065161529177;7220.36395492382;7414.406847452083;7424.665890034853;7431.4054875608745;6955.130608673916;8229.382796290183;9826.16477599412;9873.308868379145;10078.496075196064 03:11:53 INFO - PROCESS | 27259 | |3;mootools.html;1275.8341415615969;1434.670025894044;1465.7141857337817;1590.3161640494582;1767.3284152022222;6860.828479288014;7619.123800762907;7863.56750378729;7869.488483248585;8017.358611311096;7807.960960195205;7908;7935.246151615587;7953.965984422017;7989.840203195947;2112.408525612831;2142.6036183306137;2144.592527419793;2148.6562150055993;2153.4616345913523;2182.3671135370723;2216.357256395643;2226.666000099982;2227.8440509164366;2234.7988681018705;2155.698202251686;2162.2216002239184;2171.869687818736;2178.814800741939;2199.9010044547954;2130.1053557505807;2133.2426988419043;2136.1455417832913;2137.7648458669532;2139.21918499748;2101.0440249686358;2155.8490905636613;2162.762096169436;2163.383435720812;2165.0906619219963;7546.132194797614;7831.490953088088;7886.802829929297;7896.289333959971;7908.209179082103;4671.532846715335;4805.351277577517;4849.878753031167;4861.319415281863;4869.902601947977;2933.41331733652;3018.5321275202377;3101.2091916561358;3102.348506813572;3106.9067927962196;949.5632009275741;963.8939716631165;964.2767924056957;984.0651381187829;987.6987518806761;10473.68578942633;10669.359838409642;10674.839877401846;10679.519421626046;10705.197110216764;4313.956860431418;4330.415393921843;4426.800793964279;4430.379746835446;4444.466664000341;9173.40372875761;9204.171624553823;9205.309601779893;9219.354645174908;9231.353805233703;4658.883527911829;4673.299005149255;4674.041821426599;4682.063587282557;4684.039771846763;3640.472131540912;3661.2860492204295;4234.830606775756;4317.611414972667;4328.632066274339;3718.4050551911564;3828.789416582059;3887.8444862205197;3892.260470510594;3896.922061558753;1153.3887039868882;1255.522901297501;1256.5288016993627;1259.6850787303174;1263.92416455013;837.417994493821;848.9448185868023;852.7680092449671;872.7861673889938;881.7751473374249;5115.897682046412;5351.652142610717;5354.518093371616;5442.156465747816;5482.095454250004;410.6160739708382;412.2558781399543;412.66986410871783;417.89761508430627;427.1478400590779;3494.405950988338;3750.287445385368;3757.6993840492696;3774.8490060397826;3810.2760475509563;9187.310951678652;9387.342885997914;9519.23846092311;9543.713688589354;9546.95226523863;9335;9402.200812930841;9416.95291523538;9430.622775089058;9435.05649435051;7229.421646268286;7295.489315747846;7300.306470885257;7301.379382752525;7307.123145222501;5452.591055670761;5505.119180931032;5622.634528755618;5654.660720356792;5716.171155182392;8792.120787921156;8845.115488451362;8924.910750892668;8976.955115224382;9020.819583608421;8723.651053958025;9032;9086.273098152264;9088.091190881123;9089.909100908906;6167.969160154171;6207.6275423474735;6849.486288528281;6907.378335949788;6943.340382663639;7390.889136663062;7406.629668516661;7440.218777028334;7453.478256521991;7476.439267054884;6757.22291936414;6853.7943861684225;6926.06498122747;6987.615681137586;7056.6118863463;6459.289478157493;6477.773277935438;6605.405513503808;6622.205335359788;6780.830479238059;6297.905531416941;6460.160179176865;6510;6547.312532184052;6558.376954189344;4611.2391455410825;4657.417822772153;4754.096721622881;4799.9760001199775;4820.132376172322;4744.715317080986;4813.446453657874;4864.270359446112;4904.779284932115;5003.3495645565845 03:11:53 INFO - PROCESS | 27259 | |4;prototype.html;307.50798722044726;312.70449425293094;320.63127403485987;320.9165616939595;322.37298454506;4790.281457781334;4808.951910480894;4830.661853670244;4838.4193896732395;4881.4630390657085;4748.786304616292;4789.808407663698;4791.113643975867;4800.207965685667;4804.1352556539805;3575.892723218301;3674.1916778308864;3735.8318875650525;3804.7146464015173;3855.4987851579253;3764.8305826237884;3776.2258736958856;3778.641029102245;3818.6372294632106;3820.617938206185;3596.136927137481;3777.376732839078;3785.4889589905424;3796.1458671798764;3797.506324177853;3650.1604630934903;3746.157114649182;3770.3401904666575;3793.6775374093236;3804.4863943367845;3353.128186671483;3363.041533163061;3370.9831450842835;3373.797572145679;3379.6650323122476;4540;4571.474280457756;4580.839670611513;4585;4601.654875884322;4210.7473551587;4287.006541957973;4303.505096913832;4325.091730736549;4325.178216138955;4914.508549145093;4929.880151534839;4943.530364615356;4975.850724478235;4978.079055374767;3657.4696668982847;3662.7802331859907;3686.6866316362875;3693.741438099334;3695.427208782643;5055.9241611375855;5212.566544200337;5215.478452154754;5250.396204436501;5280.735963201824;3706.258748250361;3718.9442158367647;3720.3675375186285;3722.6091260417807;3722.8696995605023;3775.6224377562025;3779.055236190952;3781.262653782486;3785.6592906638534;3786.2995345861104;4272.6795490338345;4280.165367753259;4302.82788688449;4303.139372125587;4305.397244385788;4747.928781068286;4983.8006479741125;4984.750762461862;5017.422996355393;5070.036693028313;1257.5787111317627;1268.8096785482066;1269.2891980490954;1272.41468924294;1275.5981865712272;798.964046617892;828.3869936247254;909.777104609375;926.7914719188263;930.065284389198;4311.956880431156;4390.363397307373;4413.867583972486;4465.553444655508;4470.441194850644;5153.433122356538;5156.782583489061;5175.792968281302;5178.275041494194;5190.169572868323;4271.295236285978;4433.911321773547;4447.62195213404;4458.977705111453;4459.888502787457;2735.809922683639;2736.8631568421897;2749.175247425764;2750.4911591355662;2760.254731222559;4829.1790395632825;4846.39420072491;4849.563539281482;4870.394339028603;4872.561469467765;4976.850694479172;5107.336046313955;5110.182370820651;5192.143296356059;5239.502247286502;4705.20011598036;4725.976370118127;4734.313524538991;4756;4802.927956080732;5088.6946783193125;5093.185090385668;5128.05134049059;5132.10188217053;5147.897042059213;4743.739094349844;4956.330895329084;4964.751762411793;4982.6512144149565;5012.874678133076;4731.787069581808;4749.976250118727;4762.833300834454;4781.354517140142;4787.3537072496165;3788.5035411011945;3808.8666896658483;3815.1034506890305;3821.5032045833864;3833.597472265372;4839.830605928775;5028.34631497903;5088.015673887113;5115.693058416358;5117.488251174853;4847.981923795901;4858.271259311132;4899.1426500363;4903.436104847846;4921.975390123026;4896.209160778322;4897.265410188358;4927.433345165352;4941.407031156285;4955.207166853286;4621.676482646182;4806.735629540269;4851.490593487774;4878.585320247818;4897.926531102107;4908.803647854189;4942.357493525818;4951.900961980812;4956.454789973028;4963.858312588052;4777.641676874179;4835.323054772405;4841.878953026203;4844.346013288302;4874.268859671078 03:11:53 INFO - PROCESS | 27259 | |5;yui.html;590.988180236395;593.2587854646612;606.2391698418489;693.6081114170494;742.547046301756;11855.347955862435;12514.49942002321;12517.749645007118;12523.561675341354;12526.373681315932;10990.340579565232;12126.636200913965;12169.57406490773;12598.118131730782;12661.62015139545;791.2522666080541;798.7843282313772;803.2088392932957;803.5540275147291;803.6544285957036;793.095870707394;799.2007992007992;799.6921185343656;800.8558459477292;801.0267524957176;841.4110122913954;842.0821304777791;842.3429724814624;842.6966292134857;843.4770442325766;831.7296878514506;832.1844592299519;832.1927730101822;832.8042909916165;833.5332213960202;616.4020899727258;617.2346290599669;617.2685367839125;617.4350469320566;617.6139912554653;11144.108471322355;11197.832032519518;11236.831447528293;11240.381779002151;11269.830952535718;10119.24105692076;10275.537600807982;10428.634997775118;10673.092787113104;10813.945930270298;8891.510966896818;8901.777455563599;9039.050899655507;9240.168384845329;9241.537923103819;3087.428825667259;3106.534019897011;3154.1010811918723;3184.570083038783;3249.723773479257;36570.634293657255;37621.62378376209;44269.77865110686;44703;46733.766331168124;10319.380837149794;10412.334026555714;10506.369617822955;10541.104006159409;10563.524641391155;15120.319585618674;18143.63712725738;18146;18159;18184.545386365182;6554.770583029666;6749.831254218684;6860.936554834008;7096.290370962965;7264.091988501437;3777.1879046005242;3819.7708137511836;3860.768353898775;3879.573246942834;3884.3979183226643;2771.792115591298;2883.423315336941;2885.2786803299177;2887.595736596878;2888.725571070745;524.3576618642132;533.7731464127808;543.2503145658966;544.0995153021755;550.8512701570553;543.5883751155135;590.3240789296232;608.7473698415197;611.4283145259197;629.2700467457727;7625.237476252441;7703.3067023968115;7715.807104822425;7862.135165131831;7982.880256796153;579.6058680097574;593.7654626422539;606.0061499141411;608.9025755879038;610.2250142319318;3536.2043540203763;3575.6960658344333;3712.294664013829;3718.5537735471376;3761.473393724826;56195;57450.13824792631;57478.7126064367;57852.710736446046;59600.10599841006;49436.50563494319;50354.24468632974;51528.74235628798;52353.73823130936;52793.47206527885;47000.7649961748;47132.7643361781;47229;47810;48732.26901596479;7178.8564228714085;7323.597202153933;7343.522671026366;7367.852642947219;7396.667149978156;30829.38341233118;30883.227919302197;31514;32085.03744887657;32277.677223227467;37907.62092379041;40731.59268407278;41892.58107418887;42038.36942445927;42828.14343713046;8876.245519130945;9103.271738261055;9177.219936305222;9202.585883635118;9544.95227523858;9597.376170548892;9708.077732615391;9787.706368808947;9881.407115573089;10081.243906706879;8930.419522731001;8970.37207395476;8997.280217582447;9031.774205644911;9425.858612120686;8596.054434012129;8905.55472226399;9094.363394562317;9144.222741067084;9325.440473571607;9056.818863622559;9121.270298376247;9122.635094596142;9162.129597688208;9225.58484868169;7844.137144913941;7973.920260797549;8010.879836802569;8086.595670216348;8152.2662960333855;7796.337311328601;8099.716509922125;8146.348292136497;8303.543305118277;8320.500769953822 03:11:53 INFO - PROCESS | 27259 | __end_tp_report 03:11:53 INFO - PROCESS | 27259 | __start_cc_report 03:11:53 INFO - PROCESS | 27259 | _x_x_mozilla_cycle_collect,1055 03:11:53 INFO - PROCESS | 27259 | __end_cc_report 03:11:53 INFO - PROCESS | 27259 | __startTimestamp1464603113374__endTimestamp 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | ------- Summary: start ------- 03:11:53 INFO - PROCESS | 27259 | Number of tests: 6 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | [#0] dojo.html Cycles:165 Average:4722.07 Median:4858.59 stddev:490.22 (10.1%) stddev-sans-first:463.86 03:11:53 INFO - PROCESS | 27259 | Values: 2645.0 2673.3 2679.1 2692.2 2700.3 4643.4 4727.1 4740.4 4775.9 4811.7 4734.9 4750.0 4752.5 4780.0 4853.3 4330.3 4342.2 4398.6 4445.6 4534.0 4419.6 4465.1 4482.4 4494.2 4520.1 4275.6 4317.8 4320.0 4358.6 4405.7 4339.1 4346.7 4348.3 4351.8 4405.8 4360.9 4368.2 4372.8 4374.1 4418.9 4593.2 4625.1 4676.6 4780.5 4782.4 5027.7 5050.7 5100.9 5104.3 5105.2 5088.8 5138.6 5147.3 5148.3 5152.2 4670.5 4691.8 4783.6 4788.5 4788.5 5269.6 5272.5 5274.3 5300.3 5312.7 5058.6 5066.1 5066.4 5069.1 5088.8 4991.3 5068.0 5099.9 5108.4 5123.8 5097.4 5098.7 5105.3 5129.8 5139.9 5085.1 5087.1 5088.8 5089.8 5150.1 4317.2 4372.1 4375.0 4386.3 4438.0 3824.1 3851.1 3868.2 3873.0 3880.0 4417.4 4417.8 4423.8 4427.6 4427.9 5049.5 5108.4 5112.9 5115.5 5171.2 4367.6 4389.3 4405.4 4408.4 4445.4 4479.7 4590.8 4591.5 4592.9 4645.1 4789.0 4817.8 4848.7 4862.8 4864.3 5152.7 5163.4 5164.8 5171.7 5220.8 4687.8 4785.7 4843.3 4858.6 4905.4 5019.7 5030.6 5038.1 5055.3 5095.2 5109.3 5118.8 5121.9 5130.5 5175.7 4842.0 4864.2 4900.8 4964.2 4979.4 4922.4 4939.5 4940.9 4943.8 4981.4 4881.0 4885.7 4923.2 4927.9 4935.9 4879.3 4922.5 4957.9 4989.7 5024.7 4873.5 4882.8 4897.6 4901.1 4933.3 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | [#1] ext.html Cycles:180 Average:45035.41 Median:379863.00 stddev:78783.52 (20.7%) stddev-sans-first:78933.79 03:11:53 INFO - PROCESS | 27259 | Values: 570.9 589.0 591.3 599.5 614.9 27413.2 40033.0 40742.8 40818.4 40896.4 42048.8 42573.4 42583.8 42613.4 42621.0 7725.4 7878.6 7881.0 7899.4 7901.0 7674.5 7785.3 7811.2 7812.5 7816.8 7813.2 7827.3 7852.4 7854.8 7867.8 7785.8 7805.2 7805.4 7820.5 7836.2 7562.8 7638.8 7647.4 7652.1 7659.3 38002.0 38331.6 38499.4 38518.8 38541.2 2968.8 3061.8 3117.3 3396.9 3801.6 29446.3 29667.3 30385.0 30394.2 30423.5 3477.6 3487.3 3516.7 3522.8 3530.0 174654.0 176644.0 176757.0 176871.0 176929.0 51089.0 51162.0 51347.0 51392.7 51478.2 47367.0 52160.0 52958.2 53328.7 59524.4 13394.0 13536.2 13538.9 13544.5 13550.1 9208.9 10174.1 10254.6 10310.1 10323.2 14793.0 15079.5 15297.2 15659.6 15748.9 5925.8 5980.6 6032.8 6099.1 6169.8 765.7 847.9 860.4 880.0 923.3 27842.0 28079.0 28300.9 28560.4 28814.1 958.9 977.3 1048.0 1056.8 1106.1 14821.0 15132.2 15208.5 15289.8 15426.3 376902.0 377410.0 379739.0 379987.0 382969.0 50048.0 50071.0 50227.0 50268.7 50280.2 1090.7 1185.9 1216.6 1226.7 1227.8 28253.9 29187.7 29417.6 29454.3 29904.0 42011.6 42153.2 42613.1 42629.6 42753.8 302511.0 304597.0 305211.0 305811.0 306667.0 30626.8 38229.6 39013.4 39697.6 39759.6 42561.8 42596.8 42954.8 43345.8 43423.3 36121.5 36633.6 36853.0 37384.6 37419.8 36021.8 36144.8 36737.0 37001.6 37059.3 35517.0 36056.5 36092.6 36339.1 36462.5 32026.4 32340.7 32694.1 32717.3 33031.5 24856.0 24882.0 25063.0 25065.5 25421.4 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | [#2] jquery.html Cycles:180 Average:23571.04 Median:27905.06 stddev:63014.54 (225.8%) stddev-sans-first:63167.24 03:11:53 INFO - PROCESS | 27259 | Values: 372.6 373.2 376.9 383.1 383.4 15837.6 17321.0 17427.8 17730.7 17809.5 11859.5 15698.0 16359.1 16380.6 17072.7 1433.1 4635.9 4798.0 4808.7 4814.0 3509.4 3666.9 4736.8 5318.7 5636.5 5584.1 5603.1 5613.7 5622.7 5640.8 5209.9 5492.6 5519.8 5584.6 5594.6 3430.1 5075.9 5379.3 5389.3 5408.0 11060.6 11185.3 11246.9 11294.9 12427.0 1740.2 1797.1 1802.3 1858.6 1869.1 9353.2 9728.1 9967.7 10728.6 13570.4 1648.3 1733.2 1778.1 1782.0 1818.3 46986.5 68598.3 68622.7 69205.0 69547.3 10040.3 10252.2 10346.6 10795.6 11099.2 14059.4 14236.5 14237.9 14248.1 14266.7 6695.7 6832.7 6914.9 6924.0 6939.1 6351.7 6355.3 6363.5 6495.2 6504.6 4154.1 4247.5 4254.6 4256.6 4427.5 1576.2 1711.1 1726.5 1774.9 1799.8 778.4 833.4 839.7 871.5 897.7 16315.5 16553.1 16762.2 16935.2 17071.5 800.2 828.7 834.5 839.4 853.2 9208.8 9291.1 9448.5 9471.7 9628.7 367862.0 368990.0 376294.0 392015.0 395636.0 79380.6 82141.6 82993.6 83777.0 84319.6 950.0 968.7 969.6 990.4 995.0 15238.7 15454.7 15599.4 15631.4 15986.9 36267.5 36816.4 36962.6 37454.9 37582.0 48796.8 50734.2 50890.7 50892.5 51018.0 7113.1 7153.5 7161.0 7178.0 7341.3 9370.6 9595.6 11251.0 11336.5 11588.2 9422.6 9536.0 9574.2 9578.9 9874.0 4842.8 8564.5 9461.5 9569.3 9572.6 9561.5 9663.3 9915.3 10031.3 10083.8 7191.1 7220.4 7414.4 7424.7 7431.4 6955.1 8229.4 9826.2 9873.3 10078.5 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | [#3] mootools.html Cycles:180 Average:5171.26 Median:5233.77 stddev:2869.74 (54.8%) stddev-sans-first:2862.86 03:11:53 INFO - PROCESS | 27259 | Values: 1275.8 1434.7 1465.7 1590.3 1767.3 6860.8 7619.1 7863.6 7869.5 8017.4 7808.0 7908.0 7935.2 7954.0 7989.8 2112.4 2142.6 2144.6 2148.7 2153.5 2182.4 2216.4 2226.7 2227.8 2234.8 2155.7 2162.2 2171.9 2178.8 2199.9 2130.1 2133.2 2136.1 2137.8 2139.2 2101.0 2155.8 2162.8 2163.4 2165.1 7546.1 7831.5 7886.8 7896.3 7908.2 4671.5 4805.4 4849.9 4861.3 4869.9 2933.4 3018.5 3101.2 3102.3 3106.9 949.6 963.9 964.3 984.1 987.7 10473.7 10669.4 10674.8 10679.5 10705.2 4314.0 4330.4 4426.8 4430.4 4444.5 9173.4 9204.2 9205.3 9219.4 9231.4 4658.9 4673.3 4674.0 4682.1 4684.0 3640.5 3661.3 4234.8 4317.6 4328.6 3718.4 3828.8 3887.8 3892.3 3896.9 1153.4 1255.5 1256.5 1259.7 1263.9 837.4 848.9 852.8 872.8 881.8 5115.9 5351.7 5354.5 5442.2 5482.1 410.6 412.3 412.7 417.9 427.1 3494.4 3750.3 3757.7 3774.8 3810.3 9187.3 9387.3 9519.2 9543.7 9547.0 9335.0 9402.2 9417.0 9430.6 9435.1 7229.4 7295.5 7300.3 7301.4 7307.1 5452.6 5505.1 5622.6 5654.7 5716.2 8792.1 8845.1 8924.9 8977.0 9020.8 8723.7 9032.0 9086.3 9088.1 9089.9 6168.0 6207.6 6849.5 6907.4 6943.3 7390.9 7406.6 7440.2 7453.5 7476.4 6757.2 6853.8 6926.1 6987.6 7056.6 6459.3 6477.8 6605.4 6622.2 6780.8 6297.9 6460.2 6510.0 6547.3 6558.4 4611.2 4657.4 4754.1 4800.0 4820.1 4744.7 4813.4 4864.3 4904.8 5003.3 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | [#4] prototype.html Cycles:180 Average:4151.51 Median:4745.83 stddev:1176.07 (24.8%) stddev-sans-first:1143.43 03:11:53 INFO - PROCESS | 27259 | Values: 307.5 312.7 320.6 320.9 322.4 4790.3 4809.0 4830.7 4838.4 4881.5 4748.8 4789.8 4791.1 4800.2 4804.1 3575.9 3674.2 3735.8 3804.7 3855.5 3764.8 3776.2 3778.6 3818.6 3820.6 3596.1 3777.4 3785.5 3796.1 3797.5 3650.2 3746.2 3770.3 3793.7 3804.5 3353.1 3363.0 3371.0 3373.8 3379.7 4540.0 4571.5 4580.8 4585.0 4601.7 4210.7 4287.0 4303.5 4325.1 4325.2 4914.5 4929.9 4943.5 4975.9 4978.1 3657.5 3662.8 3686.7 3693.7 3695.4 5055.9 5212.6 5215.5 5250.4 5280.7 3706.3 3718.9 3720.4 3722.6 3722.9 3775.6 3779.1 3781.3 3785.7 3786.3 4272.7 4280.2 4302.8 4303.1 4305.4 4747.9 4983.8 4984.8 5017.4 5070.0 1257.6 1268.8 1269.3 1272.4 1275.6 799.0 828.4 909.8 926.8 930.1 4312.0 4390.4 4413.9 4465.6 4470.4 5153.4 5156.8 5175.8 5178.3 5190.2 4271.3 4433.9 4447.6 4459.0 4459.9 2735.8 2736.9 2749.2 2750.5 2760.3 4829.2 4846.4 4849.6 4870.4 4872.6 4976.9 5107.3 5110.2 5192.1 5239.5 4705.2 4726.0 4734.3 4756.0 4802.9 5088.7 5093.2 5128.1 5132.1 5147.9 4743.7 4956.3 4964.8 4982.7 5012.9 4731.8 4750.0 4762.8 4781.4 4787.4 3788.5 3808.9 3815.1 3821.5 3833.6 4839.8 5028.3 5088.0 5115.7 5117.5 4848.0 4858.3 4899.1 4903.4 4922.0 4896.2 4897.3 4927.4 4941.4 4955.2 4621.7 4806.7 4851.5 4878.6 4897.9 4908.8 4942.4 4951.9 4956.5 4963.9 4777.6 4835.3 4841.9 4844.3 4874.3 03:11:53 INFO - PROCESS | 27259 | 03:11:53 INFO - PROCESS | 27259 | [#5] yui.html Cycles:180 Average:12738.57 Median:30096.94 stddev:15551.91 (51.7%) stddev-sans-first:15568.79 03:11:53 INFO - PROCESS | 27259 | Values: 591.0 593.3 606.2 693.6 742.5 11855.3 12514.5 12517.7 12523.6 12526.4 10990.3 12126.6 12169.6 12598.1 12661.6 791.3 798.8 803.2 803.6 803.7 793.1 799.2 799.7 800.9 801.0 841.4 842.1 842.3 842.7 843.5 831.7 832.2 832.2 832.8 833.5 616.4 617.2 617.3 617.4 617.6 11144.1 11197.8 11236.8 11240.4 11269.8 10119.2 10275.5 10428.6 10673.1 10813.9 8891.5 8901.8 9039.1 9240.2 9241.5 3087.4 3106.5 3154.1 3184.6 3249.7 36570.6 37621.6 44269.8 44703.0 46733.8 10319.4 10412.3 10506.4 10541.1 10563.5 15120.3 18143.6 18146.0 18159.0 18184.5 6554.8 6749.8 6860.9 7096.3 7264.1 3777.2 3819.8 3860.8 3879.6 3884.4 2771.8 2883.4 2885.3 2887.6 2888.7 524.4 533.8 543.3 544.1 550.9 543.6 590.3 608.7 611.4 629.3 7625.2 7703.3 7715.8 7862.1 7982.9 579.6 593.8 606.0 608.9 610.2 3536.2 3575.7 3712.3 3718.6 3761.5 56195.0 57450.1 57478.7 57852.7 59600.1 49436.5 50354.2 51528.7 52353.7 52793.5 47000.8 47132.8 47229.0 47810.0 48732.3 7178.9 7323.6 7343.5 7367.9 7396.7 30829.4 30883.2 31514.0 32085.0 32277.7 37907.6 40731.6 41892.6 42038.4 42828.1 8876.2 9103.3 9177.2 9202.6 9545.0 9597.4 9708.1 9787.7 9881.4 10081.2 8930.4 8970.4 8997.3 9031.8 9425.9 8596.1 8905.6 9094.4 9144.2 9325.4 9056.8 9121.3 9122.6 9162.1 9225.6 7844.1 7973.9 8010.9 8086.6 8152.3 7796.3 8099.7 8146.3 8303.5 8320.5 03:11:53 INFO - PROCESS | 27259 | -------- Summary: end -------- 03:11:53 INFO - PROCESS | 27259 | 03:11:54 INFO - TEST-INFO | 27259: exit 0 03:11:54 INFO - TEST-OK | dromaeo_css | took 1118451ms 03:11:54 INFO - TEST-START | kraken 03:11:54 INFO - operating with platform_type : linux_ 03:11:54 INFO - Initialising browser for kraken test... 03:11:54 INFO - TEST-INFO | started process 27435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqbWpO/profile http://localhost:42485/getInfo.html) 03:11:58 INFO - PROCESS | 27435 | __metrics Screen width/height:1600/1200 03:11:58 INFO - PROCESS | 27435 | colorDepth:24 03:11:58 INFO - PROCESS | 27435 | Browser inner width/height: 1024/697 03:11:58 INFO - PROCESS | 27435 | __metrics 03:11:59 ERROR - PROCESS | 27435 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:12:00 INFO - TEST-INFO | 27435: exit 0 03:12:00 INFO - Browser initialized. 03:12:00 INFO - Running cycle 1/1 for kraken test... 03:12:00 INFO - TEST-INFO | started process 27517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqbWpO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:12 INFO - PROCESS | 27517 | RSS: Main: 156868608 03:12:12 INFO - PROCESS | 27517 | 03:12:15 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:16 INFO - PROCESS | 27517 | RSS: Main: 213671936 03:12:16 INFO - PROCESS | 27517 | 03:12:18 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-dft) 03:12:19 INFO - PROCESS | 27517 | RSS: Main: 201871360 03:12:19 INFO - PROCESS | 27517 | 03:12:22 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-fft) 03:12:23 INFO - PROCESS | 27517 | RSS: Main: 270184448 03:12:23 INFO - PROCESS | 27517 | 03:12:25 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-oscillator) 03:12:26 INFO - PROCESS | 27517 | RSS: Main: 180539392 03:12:26 INFO - PROCESS | 27517 | 03:12:28 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:28 INFO - PROCESS | 27517 | RSS: Main: 183963648 03:12:28 INFO - PROCESS | 27517 | 03:12:32 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42485/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:32 INFO - PROCESS | 27517 | RSS: Main: 219897856 03:12:32 INFO - PROCESS | 27517 | 03:12:36 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42485/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:36 INFO - PROCESS | 27517 | RSS: Main: 216227840 03:12:36 INFO - PROCESS | 27517 | 03:12:39 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42485/tests/kraken/driver.html?testName=json-parse-financial) 03:12:40 INFO - PROCESS | 27517 | RSS: Main: 219512832 03:12:40 INFO - PROCESS | 27517 | 03:12:41 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:42 INFO - PROCESS | 27517 | RSS: Main: 209141760 03:12:42 INFO - PROCESS | 27517 | 03:12:44 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:45 INFO - PROCESS | 27517 | RSS: Main: 212082688 03:12:45 INFO - PROCESS | 27517 | 03:12:47 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:47 INFO - PROCESS | 27517 | RSS: Main: 219791360 03:12:47 INFO - PROCESS | 27517 | 03:12:50 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:51 INFO - PROCESS | 27517 | RSS: Main: 222973952 03:12:51 INFO - PROCESS | 27517 | 03:12:54 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:54 INFO - PROCESS | 27517 | RSS: Main: 223555584 03:12:54 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42485/tests/kraken/driver.html?testName=ai-astar) 03:12:56 INFO - PROCESS | 27517 | RSS: Main: 265363456 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | __start_tp_report 03:12:56 INFO - PROCESS | 27517 | _x_x_mozilla_page_load 03:12:56 INFO - PROCESS | 27517 | _x_x_mozilla_page_load_details 03:12:56 INFO - PROCESS | 27517 | |i|pagename|runs| 03:12:56 INFO - PROCESS | 27517 | |0;ai-astar;113;109;114;114;114;114;113;112;113;112 03:12:56 INFO - PROCESS | 27517 | |1;audio-beat-detection;165;128;130;179;131;130;155;129;196;128 03:12:56 INFO - PROCESS | 27517 | |2;audio-dft;162;161;162;161;162;162;161;160;163;160 03:12:56 INFO - PROCESS | 27517 | |3;audio-fft;74;77;76;132;86;76;76;78;106;75 03:12:56 INFO - PROCESS | 27517 | |4;audio-oscillator;85;86;115;85;85;83;125;85;85;133 03:12:56 INFO - PROCESS | 27517 | |5;imaging-gaussian-blur;117;117;117;117;119;117;117;117;117;117 03:12:56 INFO - PROCESS | 27517 | |6;imaging-darkroom;146;148;146;146;146;148;145;146;147;146 03:12:56 INFO - PROCESS | 27517 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 03:12:56 INFO - PROCESS | 27517 | |8;json-parse-financial;63;63;64;63;62;64;64;67;63;63 03:12:56 INFO - PROCESS | 27517 | |9;json-stringify-tinderbox;64;64;64;65;65;65;65;74;65;64 03:12:56 INFO - PROCESS | 27517 | |10;stanford-crypto-aes;83;82;88;83;88;86;84;84;110;84 03:12:56 INFO - PROCESS | 27517 | |11;stanford-crypto-ccm;139;131;130;129;127;129;128;134;133;130 03:12:56 INFO - PROCESS | 27517 | |12;stanford-crypto-pbkdf2;176;171;172;170;168;173;167;169;167;166 03:12:56 INFO - PROCESS | 27517 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;70;66;67;66;65 03:12:56 INFO - PROCESS | 27517 | __end_tp_report 03:12:56 INFO - PROCESS | 27517 | __start_cc_report 03:12:56 INFO - PROCESS | 27517 | _x_x_mozilla_cycle_collect,1853 03:12:56 INFO - PROCESS | 27517 | __end_cc_report 03:12:56 INFO - PROCESS | 27517 | __startTimestamp1464603176697__endTimestamp 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | ------- Summary: start ------- 03:12:56 INFO - PROCESS | 27517 | Number of tests: 14 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.50 stddev:1.55 (1.4%) stddev-sans-first:1.64 03:12:56 INFO - PROCESS | 27517 | Values: 113.0 109.0 114.0 114.0 114.0 114.0 113.0 112.0 113.0 112.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:143.00 stddev:25.15 (17.6%) stddev-sans-first:25.83 03:12:56 INFO - PROCESS | 27517 | Values: 165.0 128.0 130.0 179.0 131.0 130.0 155.0 129.0 196.0 128.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 03:12:56 INFO - PROCESS | 27517 | Values: 162.0 161.0 162.0 161.0 162.0 162.0 161.0 160.0 163.0 160.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#3] audio-fft Cycles:10 Average:85.60 Median:76.00 stddev:18.93 (24.9%) stddev-sans-first:19.61 03:12:56 INFO - PROCESS | 27517 | Values: 74.0 77.0 76.0 132.0 86.0 76.0 76.0 78.0 106.0 75.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:19.55 (23.0%) stddev-sans-first:20.27 03:12:56 INFO - PROCESS | 27517 | Values: 85.0 86.0 115.0 85.0 85.0 83.0 125.0 85.0 85.0 133.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 03:12:56 INFO - PROCESS | 27517 | Values: 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:12:56 INFO - PROCESS | 27517 | Values: 146.0 148.0 146.0 146.0 146.0 148.0 145.0 146.0 147.0 146.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:12:56 INFO - PROCESS | 27517 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.41 03:12:56 INFO - PROCESS | 27517 | Values: 63.0 63.0 64.0 63.0 62.0 64.0 64.0 67.0 63.0 63.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:3.03 (4.7%) stddev-sans-first:3.16 03:12:56 INFO - PROCESS | 27517 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 65.0 74.0 65.0 64.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:84.00 stddev:8.27 (9.8%) stddev-sans-first:8.63 03:12:56 INFO - PROCESS | 27517 | Values: 83.0 82.0 88.0 83.0 88.0 86.0 84.0 84.0 110.0 84.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:130.50 stddev:3.53 (2.7%) stddev-sans-first:2.26 03:12:56 INFO - PROCESS | 27517 | Values: 139.0 131.0 130.0 129.0 127.0 129.0 128.0 134.0 133.0 130.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:3.14 (1.8%) stddev-sans-first:2.44 03:12:56 INFO - PROCESS | 27517 | Values: 176.0 171.0 172.0 170.0 168.0 173.0 167.0 169.0 167.0 166.0 03:12:56 INFO - PROCESS | 27517 | 03:12:56 INFO - PROCESS | 27517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 03:12:56 INFO - PROCESS | 27517 | Values: 66.0 67.0 67.0 66.0 66.0 70.0 66.0 67.0 66.0 65.0 03:12:56 INFO - PROCESS | 27517 | -------- Summary: end -------- 03:12:56 INFO - PROCESS | 27517 | 03:12:57 INFO - TEST-INFO | 27517: exit 0 03:12:57 INFO - TEST-OK | kraken | took 63609ms 03:12:57 INFO - SUITE-END | took 1182s 03:12:57 INFO - Completed test suite (00:19:42) 03:12:57 INFO - javascript benchmark 03:12:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.047782798193, 2673.2782148819833, 2679.11589175572, 2692.2057992892096, 2700.2709268497506, 4643.396358473394, 4727.149113159629, 4740.407449068866, 4775.856724298273, 4811.687240329376, 4734.857954261369, 4749.952500474994, 4752.500987396325, 4780.043991201756, 4853.344798452208, 4330.307150855863, 4342.153280110364, 4398.626116780078, 4445.57767012135, 4533.954660453386, 4419.558044195587, 4465.129299786527, 4482.372467854503, 4494.168578812913, 4520.141173177086, 4275.593818587229, 4317.784110794479, 4320.0, 4358.5859343362645, 4405.691601587891, 4339.132173565268, 4346.73919564824, 4348.282533381988, 4351.782410879475, 4405.7797110144365, 4360.934585981213, 4368.191884501377, 4372.846950356754, 4374.12517496502, 4418.867433976986, 4593.219152744042, 4625.074985002979, 4676.602488788457, 4780.450248221464, 4782.426108866958, 5027.723475208862, 5050.7222102784335, 5100.948990510122, 5104.285400043997, 5105.2086926526445, 5088.77100530477, 5138.640295179339, 5147.305113809625, 5148.279240906276, 5152.201408781645, 4670.509596492388, 4691.83578574755, 4783.617310615143, 4788.521147885219, 4788.545088216614, 5269.631125821233, 5272.499112584298, 5274.287971123849, 5300.337457817773, 5312.681239125664, 5058.620603454756, 5066.138756411419, 5066.392032955995, 5069.087564238473, 5088.847334579968, 4991.251312303184, 5067.97466012675, 5099.898002039939, 5108.386993560722, 5123.820666276737, 5097.362829646294, 5098.694078355311, 5105.285260063594, 5129.846104616868, 5139.871503212449, 5085.1355269604255, 5087.135187018216, 5088.847334579968, 5089.847304580869, 5150.072986862401, 4317.158154159909, 4372.081862808782, 4375.037491751809, 4386.2762644163995, 4437.955620443754, 3824.101336185994, 3851.114243723959, 3868.187680587052, 3872.9806350968065, 3880.049387899983, 4417.3815665806815, 4417.801198946056, 4423.845165419195, 4427.623651989553, 4427.889302767392, 5049.545540901337, 5108.438071812097, 5112.872178195575, 5115.462876397924, 5171.172612382001, 4367.6287515561535, 4389.341598760211, 4405.449318835145, 4408.382826404306, 4445.444319460067, 4479.664025198058, 4590.839320623762, 4591.494935557086, 4592.908141837144, 4645.117427688729, 4789.042191561702, 4817.8313759018965, 4848.7090774553635, 4862.756862156807, 4864.343313652612, 5152.716600587004, 5163.406208285945, 5164.7934082636275, 5171.663841850268, 5220.843374698765, 4687.789049492712, 4785.688930219525, 4843.297721830244, 4858.58702010333, 4905.362302900743, 5019.7239151847, 5030.572401345927, 5038.093143234253, 5055.266986286894, 5095.210242412432, 5109.31024311728, 5118.795248190179, 5121.8975620486635, 5130.461301563282, 5175.689458632494, 4841.95158048415, 4864.221724524059, 4900.779464924016, 4964.156093464192, 4979.427365852974, 4922.433920099091, 4939.481354457874, 4940.925886111783, 4943.777530011086, 4981.37732783402, 4880.95119048805, 4885.65800393969, 4923.212286034217, 4927.926081108858, 4935.876603084952, 4879.268109783419, 4922.532359425849, 4957.900841983213, 4989.650724449254, 5024.698518088926, 4873.46391896884, 4882.804687812448, 4897.559219670246, 4901.117798796251, 4933.33399991011], "value": 4691.101822039624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9343425506065, 588.9911651325231, 591.2550186764676, 599.4934280532949, 614.9077638354248, 27413.177604671866, 40033.0, 40742.79628601853, 40818.38772418416, 40896.38655420171, 42048.78975605125, 42573.36139957903, 42583.78708106463, 42613.36079958803, 42621.0, 7725.420593455499, 7878.606069696492, 7880.960595197016, 7899.407544434191, 7901.0, 7674.501157424749, 7785.338246249075, 7811.179826118261, 7812.531248125102, 7816.843663126734, 7813.21867813217, 7827.3346765525, 7852.411069169807, 7854.764357069297, 7867.842643147163, 7785.805354866117, 7805.219478052206, 7805.414593905423, 7820.491668041616, 7836.177201393829, 7562.810929726801, 7638.8472230555635, 7647.426443016796, 7652.081750189957, 7659.272369124924, 38002.0, 38331.61668383336, 38499.42250866239, 38518.80740596279, 38541.22917541634, 2968.7921845470823, 3061.7550595952493, 3117.3297740985795, 3396.8980930571875, 3801.5628202756484, 29446.26384340387, 29667.258318541994, 30385.0, 30394.240143996354, 30423.543646845315, 3477.5826900772067, 3487.34527711673, 3516.7010804081683, 3522.7710198836994, 3529.982350088259, 174654.0, 176644.0, 176757.0, 176871.0, 176929.0, 51089.0, 51162.0, 51347.0, 51392.74303628458, 51478.22782658263, 47367.0, 52160.0, 52958.205626915624, 53328.73335633297, 59524.40475595189, 13394.0, 13536.187828730308, 13538.86461135376, 13544.525941591997, 13550.051496395157, 9208.907910920805, 10174.084332409971, 10254.6410875619, 10310.07209351162, 10323.174146068297, 14793.0, 15079.54761357161, 15297.235138243042, 15659.608509787118, 15748.92125539365, 5925.762969481259, 5980.611260268069, 6032.758689652364, 6099.146119543268, 6169.84575385619, 765.7205120131223, 847.8685803700437, 860.3633311349681, 880.0, 923.2752289452882, 27842.0, 28079.0, 28300.858495707802, 28560.42879142447, 28814.135575932756, 958.91849192818, 977.3451787302524, 1048.0410424461531, 1056.7675111475462, 1106.1316866260108, 14821.0, 15132.167730774692, 15208.543743687707, 15289.847101529065, 15426.305816238297, 376902.0, 377410.0, 379739.0, 379987.0, 382969.0, 50048.0, 50071.0, 50227.0, 50268.74865625649, 50280.24579631309, 1090.7164137324194, 1185.853604974998, 1216.580279803484, 1226.6565361698738, 1227.7605866856056, 28253.858730706215, 29187.7081229185, 29417.55873661854, 29454.263643409085, 29904.0, 42011.579884200764, 42153.156936860476, 42613.14773704571, 42629.57370426256, 42753.78623106865, 302511.0, 304597.0, 305211.0, 305811.0, 306667.0, 30626.84686576553, 38229.61770382261, 39013.41479877747, 39697.61058362944, 39759.60240397674, 42561.78719106385, 42596.78701606596, 42954.78522607367, 43345.78327108471, 43423.34864977091, 36121.45817812682, 36633.63366366409, 36853.0, 37384.626153739206, 37419.81290093532, 36021.81989090038, 36144.81927590345, 36737.0, 37001.629983699815, 37059.25881482301, 35517.0, 36056.45915311325, 36092.63907360998, 36339.091522712144, 36462.4530632046, 32026.35947281088, 32340.676593234708, 32694.085836095084, 32717.345653087283, 33031.50452743259, 24856.0, 24882.0, 25063.0, 25065.480994420082, 25421.364465888502], "value": 17398.51661057132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.6031776158391, 373.19576313045377, 376.9020054785755, 383.12073790650453, 383.3636163967814, 15837.604059898495, 17321.0, 17427.825721742778, 17730.695009648745, 17809.465716028506, 11859.466324015419, 15698.0, 16359.100249486273, 16380.590485237844, 17072.743908841378, 1433.0899878577075, 4635.860924172272, 4798.0164066366315, 4808.735519546441, 4813.951860481403, 3509.3858574749443, 3666.8716594919183, 4736.763161841911, 5318.734063296839, 5636.464535869086, 5584.078627026536, 5603.075492543725, 5613.747381367848, 5622.690752008638, 5640.802571909984, 5209.895802083956, 5492.588055895823, 5519.834404967857, 5584.5811564132855, 5594.58040646951, 3430.1081718753053, 5075.873103172414, 5379.327584051994, 5389.299391079174, 5408.026555220059, 11060.612878549293, 11185.32888026721, 11246.943765281203, 11294.94352528232, 12427.005839532816, 1740.1995082262174, 1797.0565453137076, 1802.288096202006, 1858.5818190907073, 1869.1401955100534, 9353.158215760614, 9728.075832795874, 9967.700968970943, 10728.570857165703, 13570.389332480063, 1648.282996896342, 1733.1767410480047, 1778.1020584604692, 1781.9910900445416, 1818.2817786974072, 46986.53013469856, 68598.31401685969, 68622.65688671525, 69205.0, 69547.30452695458, 10040.347377420445, 10252.23108266883, 10346.637867674595, 10795.622153224756, 11099.167562432689, 14059.43762249519, 14236.501722439665, 14237.85762142386, 14248.145111293356, 14266.714665706628, 6695.732170713214, 6832.658367081626, 6914.9308506915295, 6924.0, 6939.063226464464, 6351.714172862232, 6355.269144048401, 6363.522735794834, 6495.220573531206, 6504.577202481823, 4154.065335299533, 4247.548257498388, 4254.595813397722, 4256.638185754246, 4427.512973572904, 1576.1961399686243, 1711.144427786107, 1726.464795913271, 1774.9112544372729, 1799.8057693340158, 778.4473024152915, 833.4332653795356, 839.6935118681637, 871.4858233642054, 897.6588896219395, 16315.51053468398, 16553.121615483928, 16762.245698943578, 16935.15324233808, 17071.487855364358, 800.1598321762126, 828.6975254032355, 834.486790623762, 839.4040231435627, 853.159637756809, 9208.815823683488, 9291.117343852324, 9448.527573621292, 9471.668491602899, 9628.71113866585, 367862.0, 368990.0, 376294.0, 392015.0, 395636.0, 79380.60309698415, 82141.58929205436, 82993.58503207445, 83777.0, 84319.5784021076, 949.9620015199453, 968.6754937096151, 969.6363863551027, 990.4156547636928, 995.0447570332561, 15238.695226095639, 15454.690906182039, 15599.376024959329, 15631.374745010527, 15986.920065399598, 36267.45598815967, 36816.44775328426, 36962.630373695916, 37454.876353709435, 37582.0, 48796.75601621969, 50734.23898641449, 50890.74554627203, 50892.49107508877, 51018.0, 7113.146422429341, 7153.535020223669, 7160.964195178991, 7178.0, 7341.3392794648735, 9370.625174992923, 9595.568199431182, 11251.0, 11336.546538138382, 11588.188826782045, 9422.575984080595, 9536.046395360408, 9574.186194173573, 9578.90421095808, 9873.950630246803, 4842.7820748065715, 8564.52895090776, 9461.479618621042, 9569.330196830622, 9572.617095316109, 9561.521923903916, 9663.27525435581, 9915.26808662366, 10031.29780915329, 10083.798324033625, 7191.065161529177, 7220.36395492382, 7414.406847452083, 7424.665890034853, 7431.4054875608745, 6955.130608673916, 8229.382796290183, 9826.16477599412, 9873.308868379145, 10078.496075196064], "value": 7810.697550292805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.8341415615969, 1434.670025894044, 1465.7141857337817, 1590.3161640494582, 1767.3284152022222, 6860.828479288014, 7619.123800762907, 7863.56750378729, 7869.488483248585, 8017.358611311096, 7807.960960195205, 7908.0, 7935.246151615587, 7953.965984422017, 7989.840203195947, 2112.408525612831, 2142.6036183306137, 2144.592527419793, 2148.6562150055993, 2153.4616345913523, 2182.3671135370723, 2216.357256395643, 2226.666000099982, 2227.8440509164366, 2234.7988681018705, 2155.698202251686, 2162.2216002239184, 2171.869687818736, 2178.814800741939, 2199.9010044547954, 2130.1053557505807, 2133.2426988419043, 2136.1455417832913, 2137.7648458669532, 2139.21918499748, 2101.0440249686358, 2155.8490905636613, 2162.762096169436, 2163.383435720812, 2165.0906619219963, 7546.132194797614, 7831.490953088088, 7886.802829929297, 7896.289333959971, 7908.209179082103, 4671.532846715335, 4805.351277577517, 4849.878753031167, 4861.319415281863, 4869.902601947977, 2933.41331733652, 3018.5321275202377, 3101.2091916561358, 3102.348506813572, 3106.9067927962196, 949.5632009275741, 963.8939716631165, 964.2767924056957, 984.0651381187829, 987.6987518806761, 10473.68578942633, 10669.359838409642, 10674.839877401846, 10679.519421626046, 10705.197110216764, 4313.956860431418, 4330.415393921843, 4426.800793964279, 4430.379746835446, 4444.466664000341, 9173.40372875761, 9204.171624553823, 9205.309601779893, 9219.354645174908, 9231.353805233703, 4658.883527911829, 4673.299005149255, 4674.041821426599, 4682.063587282557, 4684.039771846763, 3640.472131540912, 3661.2860492204295, 4234.830606775756, 4317.611414972667, 4328.632066274339, 3718.4050551911564, 3828.789416582059, 3887.8444862205197, 3892.260470510594, 3896.922061558753, 1153.3887039868882, 1255.522901297501, 1256.5288016993627, 1259.6850787303174, 1263.92416455013, 837.417994493821, 848.9448185868023, 852.7680092449671, 872.7861673889938, 881.7751473374249, 5115.897682046412, 5351.652142610717, 5354.518093371616, 5442.156465747816, 5482.095454250004, 410.6160739708382, 412.2558781399543, 412.66986410871783, 417.89761508430627, 427.1478400590779, 3494.405950988338, 3750.287445385368, 3757.6993840492696, 3774.8490060397826, 3810.2760475509563, 9187.310951678652, 9387.342885997914, 9519.23846092311, 9543.713688589354, 9546.95226523863, 9335.0, 9402.200812930841, 9416.95291523538, 9430.622775089058, 9435.05649435051, 7229.421646268286, 7295.489315747846, 7300.306470885257, 7301.379382752525, 7307.123145222501, 5452.591055670761, 5505.119180931032, 5622.634528755618, 5654.660720356792, 5716.171155182392, 8792.120787921156, 8845.115488451362, 8924.910750892668, 8976.955115224382, 9020.819583608421, 8723.651053958025, 9032.0, 9086.273098152264, 9088.091190881123, 9089.909100908906, 6167.969160154171, 6207.6275423474735, 6849.486288528281, 6907.378335949788, 6943.340382663639, 7390.889136663062, 7406.629668516661, 7440.218777028334, 7453.478256521991, 7476.439267054884, 6757.22291936414, 6853.7943861684225, 6926.06498122747, 6987.615681137586, 7056.6118863463, 6459.289478157493, 6477.773277935438, 6605.405513503808, 6622.205335359788, 6780.830479238059, 6297.905531416941, 6460.160179176865, 6510.0, 6547.312532184052, 6558.376954189344, 4611.2391455410825, 4657.417822772153, 4754.096721622881, 4799.9760001199775, 4820.132376172322, 4744.715317080986, 4813.446453657874, 4864.270359446112, 4904.779284932115, 5003.3495645565845], "value": 4112.621046298338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.50798722044726, 312.70449425293094, 320.63127403485987, 320.9165616939595, 322.37298454506, 4790.281457781334, 4808.951910480894, 4830.661853670244, 4838.4193896732395, 4881.4630390657085, 4748.786304616292, 4789.808407663698, 4791.113643975867, 4800.207965685667, 4804.1352556539805, 3575.892723218301, 3674.1916778308864, 3735.8318875650525, 3804.7146464015173, 3855.4987851579253, 3764.8305826237884, 3776.2258736958856, 3778.641029102245, 3818.6372294632106, 3820.617938206185, 3596.136927137481, 3777.376732839078, 3785.4889589905424, 3796.1458671798764, 3797.506324177853, 3650.1604630934903, 3746.157114649182, 3770.3401904666575, 3793.6775374093236, 3804.4863943367845, 3353.128186671483, 3363.041533163061, 3370.9831450842835, 3373.797572145679, 3379.6650323122476, 4540.0, 4571.474280457756, 4580.839670611513, 4585.0, 4601.654875884322, 4210.7473551587, 4287.006541957973, 4303.505096913832, 4325.091730736549, 4325.178216138955, 4914.508549145093, 4929.880151534839, 4943.530364615356, 4975.850724478235, 4978.079055374767, 3657.4696668982847, 3662.7802331859907, 3686.6866316362875, 3693.741438099334, 3695.427208782643, 5055.9241611375855, 5212.566544200337, 5215.478452154754, 5250.396204436501, 5280.735963201824, 3706.258748250361, 3718.9442158367647, 3720.3675375186285, 3722.6091260417807, 3722.8696995605023, 3775.6224377562025, 3779.055236190952, 3781.262653782486, 3785.6592906638534, 3786.2995345861104, 4272.6795490338345, 4280.165367753259, 4302.82788688449, 4303.139372125587, 4305.397244385788, 4747.928781068286, 4983.8006479741125, 4984.750762461862, 5017.422996355393, 5070.036693028313, 1257.5787111317627, 1268.8096785482066, 1269.2891980490954, 1272.41468924294, 1275.5981865712272, 798.964046617892, 828.3869936247254, 909.777104609375, 926.7914719188263, 930.065284389198, 4311.956880431156, 4390.363397307373, 4413.867583972486, 4465.553444655508, 4470.441194850644, 5153.433122356538, 5156.782583489061, 5175.792968281302, 5178.275041494194, 5190.169572868323, 4271.295236285978, 4433.911321773547, 4447.62195213404, 4458.977705111453, 4459.888502787457, 2735.809922683639, 2736.8631568421897, 2749.175247425764, 2750.4911591355662, 2760.254731222559, 4829.1790395632825, 4846.39420072491, 4849.563539281482, 4870.394339028603, 4872.561469467765, 4976.850694479172, 5107.336046313955, 5110.182370820651, 5192.143296356059, 5239.502247286502, 4705.20011598036, 4725.976370118127, 4734.313524538991, 4756.0, 4802.927956080732, 5088.6946783193125, 5093.185090385668, 5128.05134049059, 5132.10188217053, 5147.897042059213, 4743.739094349844, 4956.330895329084, 4964.751762411793, 4982.6512144149565, 5012.874678133076, 4731.787069581808, 4749.976250118727, 4762.833300834454, 4781.354517140142, 4787.3537072496165, 3788.5035411011945, 3808.8666896658483, 3815.1034506890305, 3821.5032045833864, 3833.597472265372, 4839.830605928775, 5028.34631497903, 5088.015673887113, 5115.693058416358, 5117.488251174853, 4847.981923795901, 4858.271259311132, 4899.1426500363, 4903.436104847846, 4921.975390123026, 4896.209160778322, 4897.265410188358, 4927.433345165352, 4941.407031156285, 4955.207166853286, 4621.676482646182, 4806.735629540269, 4851.490593487774, 4878.585320247818, 4897.926531102107, 4908.803647854189, 4942.357493525818, 4951.900961980812, 4956.454789973028, 4963.858312588052, 4777.641676874179, 4835.323054772405, 4841.878953026203, 4844.346013288302, 4874.268859671078], "value": 3783.6375615932166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.988180236395, 593.2587854646612, 606.2391698418489, 693.6081114170494, 742.547046301756, 11855.347955862435, 12514.49942002321, 12517.749645007118, 12523.561675341354, 12526.373681315932, 10990.340579565232, 12126.636200913965, 12169.57406490773, 12598.118131730782, 12661.62015139545, 791.2522666080541, 798.7843282313772, 803.2088392932957, 803.5540275147291, 803.6544285957036, 793.095870707394, 799.2007992007992, 799.6921185343656, 800.8558459477292, 801.0267524957176, 841.4110122913954, 842.0821304777791, 842.3429724814624, 842.6966292134857, 843.4770442325766, 831.7296878514506, 832.1844592299519, 832.1927730101822, 832.8042909916165, 833.5332213960202, 616.4020899727258, 617.2346290599669, 617.2685367839125, 617.4350469320566, 617.6139912554653, 11144.108471322355, 11197.832032519518, 11236.831447528293, 11240.381779002151, 11269.830952535718, 10119.24105692076, 10275.537600807982, 10428.634997775118, 10673.092787113104, 10813.945930270298, 8891.510966896818, 8901.777455563599, 9039.050899655507, 9240.168384845329, 9241.537923103819, 3087.428825667259, 3106.534019897011, 3154.1010811918723, 3184.570083038783, 3249.723773479257, 36570.634293657255, 37621.62378376209, 44269.77865110686, 44703.0, 46733.766331168124, 10319.380837149794, 10412.334026555714, 10506.369617822955, 10541.104006159409, 10563.524641391155, 15120.319585618674, 18143.63712725738, 18146.0, 18159.0, 18184.545386365182, 6554.770583029666, 6749.831254218684, 6860.936554834008, 7096.290370962965, 7264.091988501437, 3777.1879046005242, 3819.7708137511836, 3860.768353898775, 3879.573246942834, 3884.3979183226643, 2771.792115591298, 2883.423315336941, 2885.2786803299177, 2887.595736596878, 2888.725571070745, 524.3576618642132, 533.7731464127808, 543.2503145658966, 544.0995153021755, 550.8512701570553, 543.5883751155135, 590.3240789296232, 608.7473698415197, 611.4283145259197, 629.2700467457727, 7625.237476252441, 7703.3067023968115, 7715.807104822425, 7862.135165131831, 7982.880256796153, 579.6058680097574, 593.7654626422539, 606.0061499141411, 608.9025755879038, 610.2250142319318, 3536.2043540203763, 3575.6960658344333, 3712.294664013829, 3718.5537735471376, 3761.473393724826, 56195.0, 57450.13824792631, 57478.7126064367, 57852.710736446046, 59600.10599841006, 49436.50563494319, 50354.24468632974, 51528.74235628798, 52353.73823130936, 52793.47206527885, 47000.7649961748, 47132.7643361781, 47229.0, 47810.0, 48732.26901596479, 7178.8564228714085, 7323.597202153933, 7343.522671026366, 7367.852642947219, 7396.667149978156, 30829.38341233118, 30883.227919302197, 31514.0, 32085.03744887657, 32277.677223227467, 37907.62092379041, 40731.59268407278, 41892.58107418887, 42038.36942445927, 42828.14343713046, 8876.245519130945, 9103.271738261055, 9177.219936305222, 9202.585883635118, 9544.95227523858, 9597.376170548892, 9708.077732615391, 9787.706368808947, 9881.407115573089, 10081.243906706879, 8930.419522731001, 8970.37207395476, 8997.280217582447, 9031.774205644911, 9425.858612120686, 8596.054434012129, 8905.55472226399, 9094.363394562317, 9144.222741067084, 9325.440473571607, 9056.818863622559, 9121.270298376247, 9122.635094596142, 9162.129597688208, 9225.58484868169, 7844.137144913941, 7973.920260797549, 8010.879836802569, 8086.595670216348, 8152.2662960333855, 7796.337311328601, 8099.716509922125, 8146.348292136497, 8303.543305118277, 8320.500769953822], "value": 5708.144393222117, "unit": "score"}], "name": "dromaeo_css", "value": 6196.905341842557, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 114.0, 114.0, 114.0, 113.0, 112.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 130.0, 179.0, 131.0, 130.0, 155.0, 129.0, 196.0, 128.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 160.0, 163.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 132.0, 86.0, 76.0, 76.0, 78.0, 106.0, 75.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 115.0, 85.0, 85.0, 83.0, 125.0, 85.0, 85.0, 133.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 148.0, 145.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 62.0, 64.0, 64.0, 67.0, 63.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 74.0, 65.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 88.0, 83.0, 88.0, 86.0, 84.0, 84.0, 110.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 130.0, 129.0, 127.0, 129.0, 128.0, 134.0, 133.0, 130.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 172.0, 170.0, 168.0, 173.0, 167.0, 169.0, 167.0, 166.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 70.0, 66.0, 67.0, 66.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1545.9, "alertThreshold": 2.0}]} 03:12:57 INFO - Return code: 0 03:12:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:12:57 ERROR - # TBPL SUCCESS # 03:12:57 INFO - Running post-action listener: _resource_record_post_action 03:12:57 INFO - ##### 03:12:57 INFO - ##### Finished run-tests step (success) 03:12:57 INFO - ##### 03:12:57 INFO - Running post-run listener: _resource_record_post_run 03:12:58 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507994112; Read time: 12; Write time: 357612 03:12:58 INFO - TinderboxPrint: CPU usage
13.1% 03:12:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:12:58 INFO - TinderboxPrint: I/O write bytes / time
507,994,112 / 357,612 03:12:58 INFO - TinderboxPrint: CPU idle
8,318.2 (86.9%) 03:12:58 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 03:12:58 INFO - TinderboxPrint: Swap in / out
0 / 0 03:12:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110440448; Read time: 0; Write time: 77952 03:12:58 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284065792; Read time: 12; Write time: 164044 03:12:58 INFO - Running post-run listener: _upload_blobber_files 03:12:58 INFO - Blob upload gear active. 03:12:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12: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 03:12: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:12: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:12:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:12:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:12:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:59 INFO - (blobuploader) - INFO - Done attempting. 03:12:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:12:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:03 INFO - (blobuploader) - INFO - Done attempting. 03:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:04 INFO - (blobuploader) - INFO - Done attempting. 03:13:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:04 INFO - Return code: 0 03:13:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990632ea3ecbd23fbcc42695af9142fa36b0570bf001654201c633b36c4d5075d6b1896167c9930147f6370da3fc1d488355b4a626f0fff7314faa4b44f057e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/256233d18ee8442282b2fd9967efc02174e55812016adc52c0810523196e28818d53fb249a992fc2a3f2b96fbc2d442dcacdf01083e591e18ac2d9464ce23075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6bf8fa1ad41bb0e78e59e5ad5fc69435bf84586f2b68a2262402435a799c7198885253359184898d6180b4b4567694f3091c6bcd4b85166b10c2f0b85ae1720"} 03:13:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:04 INFO - Contents: 03:13:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990632ea3ecbd23fbcc42695af9142fa36b0570bf001654201c633b36c4d5075d6b1896167c9930147f6370da3fc1d488355b4a626f0fff7314faa4b44f057e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/256233d18ee8442282b2fd9967efc02174e55812016adc52c0810523196e28818d53fb249a992fc2a3f2b96fbc2d442dcacdf01083e591e18ac2d9464ce23075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6bf8fa1ad41bb0e78e59e5ad5fc69435bf84586f2b68a2262402435a799c7198885253359184898d6180b4b4567694f3091c6bcd4b85166b10c2f0b85ae1720"} 03:13:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:04 INFO - Copying logs to upload dir... 03:13:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.446353 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-30 03:13:04.225590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 03:13:04.228966) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990632ea3ecbd23fbcc42695af9142fa36b0570bf001654201c633b36c4d5075d6b1896167c9930147f6370da3fc1d488355b4a626f0fff7314faa4b44f057e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/256233d18ee8442282b2fd9967efc02174e55812016adc52c0810523196e28818d53fb249a992fc2a3f2b96fbc2d442dcacdf01083e591e18ac2d9464ce23075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6bf8fa1ad41bb0e78e59e5ad5fc69435bf84586f2b68a2262402435a799c7198885253359184898d6180b4b4567694f3091c6bcd4b85166b10c2f0b85ae1720"} build_url:https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/DhCPuR-wTAyiVHE81c4wNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990632ea3ecbd23fbcc42695af9142fa36b0570bf001654201c633b36c4d5075d6b1896167c9930147f6370da3fc1d488355b4a626f0fff7314faa4b44f057e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/256233d18ee8442282b2fd9967efc02174e55812016adc52c0810523196e28818d53fb249a992fc2a3f2b96fbc2d442dcacdf01083e591e18ac2d9464ce23075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6bf8fa1ad41bb0e78e59e5ad5fc69435bf84586f2b68a2262402435a799c7198885253359184898d6180b4b4567694f3091c6bcd4b85166b10c2f0b85ae1720"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 03:13:04.255037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 03:13:04.255372) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464600810.71821-177311218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004734 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 03:13:04.337502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 03:13:04.337822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 03:13:04.338149) ========= ========= Total master_lag: 0.29 =========