builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1463710217.88 results: success (0) buildid: 20160519184214 builduid: 4f59cb535d784b79bd21e16870009839 revision: 466d5c96f43964d4122959e5ab19131237bdc6fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:17.878464) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:17.879004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:17.879288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:17.941212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:17.941479) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 19:10: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% 46.3M=0s 2016-05-19 19:10:18 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.089249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.089545) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017240 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.140044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.140364) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 466d5c96f43964d4122959e5ab19131237bdc6fa --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 466d5c96f43964d4122959e5ab19131237bdc6fa --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=a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 19:10:18,430 truncating revision to first 12 chars 2016-05-19 19:10:18,430 Setting DEBUG logging. 2016-05-19 19:10:18,431 attempt 1/10 2016-05-19 19:10:18,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/466d5c96f439?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 19:10:18,663 unpacking tar archive at: fx-team-466d5c96f439/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.717591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.717957) ========= script_repo_revision: 466d5c96f43964d4122959e5ab19131237bdc6fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.718364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.718656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.728548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-19 19:10:18.728826) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:19 INFO - MultiFileLogger online at 20160519 19:10:19 in /builds/slave/test 19:10:19 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 19:10:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:19 INFO - {'append_to_log': False, 19:10:19 INFO - 'base_work_dir': '/builds/slave/test', 19:10:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:10:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:19 INFO - 'branch': 'Fx-Team-Non-PGO', 19:10:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:19 INFO - 'config_files': ('talos/linux_config.py',), 19:10:19 INFO - 'default_actions': ('clobber', 19:10:19 INFO - 'read-buildbot-config', 19:10:19 INFO - 'download-and-extract', 19:10:19 INFO - 'populate-webroot', 19:10:19 INFO - 'create-virtualenv', 19:10:19 INFO - 'install', 19:10:19 INFO - 'run-tests'), 19:10:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:19 INFO - 'download_minidump_stackwalk': True, 19:10:19 INFO - 'download_symbols': 'ondemand', 19:10:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:19 INFO - 'installer_path': 'installer.exe', 19:10:19 INFO - 'log_level': 'info', 19:10:19 INFO - 'log_name': 'talos', 19:10:19 INFO - 'log_to_console': True, 19:10:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:19 INFO - 'opt_config_files': (), 19:10:19 INFO - 'pip_index': False, 19:10:19 INFO - 'sps_profile': False, 19:10:19 INFO - 'sps_profile_interval': 0, 19:10:19 INFO - 'suite': 'dromaeojs', 19:10:19 INFO - 'system_bits': '32', 19:10:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:19 INFO - 'title': 'talos-linux64-ix-064', 19:10:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:19 INFO - 'use_talos_json': True, 19:10:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:19 INFO - 'work_dir': 'build'} 19:10:19 INFO - ##### 19:10:19 INFO - ##### Running clobber step. 19:10:19 INFO - ##### 19:10:19 INFO - Running pre-action listener: _resource_record_pre_action 19:10:19 INFO - Running main action method: clobber 19:10:19 INFO - rmtree: /builds/slave/test/build 19:10:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:19 INFO - Running post-action listener: _resource_record_post_action 19:10:19 INFO - ##### 19:10:19 INFO - ##### Finished clobber step (success) 19:10:19 INFO - ##### 19:10:19 INFO - ##### 19:10:19 INFO - ##### Running read-buildbot-config step. 19:10:19 INFO - ##### 19:10:19 INFO - Running pre-action listener: _resource_record_pre_action 19:10:19 INFO - Running main action method: read_buildbot_config 19:10:19 INFO - Using buildbot properties: 19:10:19 INFO - { 19:10:19 INFO - "project": "", 19:10:19 INFO - "product": "firefox", 19:10:19 INFO - "script_repo_revision": "production", 19:10:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:10:19 INFO - "repository": "", 19:10:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:10:19 INFO - "buildid": "20160519184214", 19:10:19 INFO - "pgo_build": "False", 19:10:19 INFO - "basedir": "/builds/slave/test", 19:10:19 INFO - "buildnumber": 1759, 19:10:19 INFO - "slavename": "talos-linux64-ix-064", 19:10:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:10:19 INFO - "platform": "ubuntu64_hw", 19:10:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:10:19 INFO - "branch": "fx-team", 19:10:19 INFO - "repo_path": "integration/fx-team", 19:10:19 INFO - "revision": "466d5c96f43964d4122959e5ab19131237bdc6fa", 19:10:19 INFO - "stage_platform": "linux64", 19:10:19 INFO - "builduid": "4f59cb535d784b79bd21e16870009839", 19:10:19 INFO - "slavebuilddir": "test" 19:10:19 INFO - } 19:10:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:10:19 INFO - Running post-action listener: _resource_record_post_action 19:10:19 INFO - ##### 19:10:19 INFO - ##### Finished read-buildbot-config step (success) 19:10:19 INFO - ##### 19:10:19 INFO - ##### 19:10:19 INFO - ##### Running download-and-extract step. 19:10:19 INFO - ##### 19:10:19 INFO - Running pre-action listener: _resource_record_pre_action 19:10:19 INFO - Running main action method: download_and_extract 19:10:19 INFO - mkdir: /builds/slave/test/build/tests 19:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:19 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:24 INFO - Downloaded 1361 bytes. 19:10:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:24 INFO - Using the following test package requirements: 19:10:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:10:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'jsshell-linux-x86_64.zip'], 19:10:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:10:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:10:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:24 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:29 INFO - Downloaded 22813669 bytes. 19:10:29 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'] 19:10:29 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 19:10:30 INFO - Return code: 0 19:10:30 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 19:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:30 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:31 INFO - Downloaded 22813669 bytes. 19:10:31 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'] 19:10:31 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 19:10:33 INFO - Return code: 0 19:10:33 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')]} 19:10:33 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:34 INFO - Downloaded 10840359 bytes. 19:10:34 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'] 19:10:34 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 19:10:34 INFO - Return code: 0 19:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:34 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/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 19:10:37 INFO - Downloaded 54814434 bytes. 19:10:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:37 INFO - mkdir: /builds/slave/test/properties 19:10:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:37 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:37 INFO - Contents: 19:10:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:38 INFO - Running post-action listener: _resource_record_post_action 19:10:38 INFO - Running post-action listener: set_extra_try_arguments 19:10:38 INFO - ##### 19:10:38 INFO - ##### Finished download-and-extract step (success) 19:10:38 INFO - ##### 19:10:38 INFO - ##### 19:10:38 INFO - ##### Running populate-webroot step. 19:10:38 INFO - ##### 19:10:38 INFO - Running pre-action listener: _resource_record_pre_action 19:10:38 INFO - Running main action method: populate_webroot 19:10:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:38 INFO - '--tppagecycles', 19:10:38 INFO - '7'], 19:10:38 INFO - 'tests': ['tsvgm']}}, 19:10:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['damp', 'tps']}, 19:10:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'tests': ['damp', 'tps']}, 19:10:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['dromaeo_dom']}, 19:10:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['a11yr', 19:10:38 INFO - 'ts_paint', 19:10:38 INFO - 'tpaint', 19:10:38 INFO - 'sessionrestore', 19:10:38 INFO - 'sessionrestore_no_auto_restore', 19:10:38 INFO - 'tabpaint']}, 19:10:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:38 INFO - 'ts_paint', 19:10:38 INFO - 'tpaint', 19:10:38 INFO - 'sessionrestore', 19:10:38 INFO - 'sessionrestore_no_auto_restore', 19:10:38 INFO - 'tabpaint']}, 19:10:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:38 INFO - 'ts_paint', 19:10:38 INFO - 'tpaint', 19:10:38 INFO - 'sessionrestore', 19:10:38 INFO - 'sessionrestore_no_auto_restore', 19:10:38 INFO - 'tabpaint']}, 19:10:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:38 INFO - 'ts_paint', 19:10:38 INFO - 'tpaint', 19:10:38 INFO - 'sessionrestore', 19:10:38 INFO - 'sessionrestore_no_auto_restore', 19:10:38 INFO - 'tabpaint']}, 19:10:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['a11yr', 19:10:38 INFO - 'ts_paint', 19:10:38 INFO - 'tpaint', 19:10:38 INFO - 'sessionrestore', 19:10:38 INFO - 'sessionrestore_no_auto_restore', 19:10:38 INFO - 'tabpaint']}, 19:10:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['a11yr', 19:10:38 INFO - 'ts_paint', 19:10:38 INFO - 'tpaint', 19:10:38 INFO - 'sessionrestore', 19:10:38 INFO - 'sessionrestore_no_auto_restore', 19:10:38 INFO - 'tabpaint']}, 19:10:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['tsvgx', 19:10:38 INFO - 'tsvgr_opacity', 19:10:38 INFO - 'tart', 19:10:38 INFO - 'tscrollx', 19:10:38 INFO - 'cart']}, 19:10:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:38 INFO - 'tsvgr_opacity', 19:10:38 INFO - 'tart', 19:10:38 INFO - 'tscrollx', 19:10:38 INFO - 'cart']}, 19:10:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'talos_options': ['--disable-e10s'], 19:10:38 INFO - 'tests': ['tp5o']}, 19:10:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'tests': ['tp5o']}, 19:10:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'talos_options': ['--disable-e10s', 19:10:38 INFO - '--xperf_path', 19:10:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:38 INFO - 'tests': ['tp5n']}, 19:10:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:38 INFO - 'talos_options': ['--xperf_path', 19:10:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:38 INFO - 'tests': ['tp5n']}}, 19:10:38 INFO - 'talos.zip': {'path': '', 19:10:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:38 INFO - Running post-action listener: _resource_record_post_action 19:10:38 INFO - ##### 19:10:38 INFO - ##### Finished populate-webroot step (success) 19:10:38 INFO - ##### 19:10:38 INFO - ##### 19:10:38 INFO - ##### Running create-virtualenv step. 19:10:38 INFO - ##### 19:10:38 INFO - Running pre-action listener: _resource_record_pre_action 19:10:38 INFO - Running main action method: create_virtualenv 19:10:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:38 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 19:10:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:38 INFO - Using real prefix '/usr' 19:10:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:38 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:40 INFO - Installing pip.................done. 19:10:40 INFO - Return code: 0 19:10:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10:40 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')]} 19:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 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')]} 19:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:40 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 19:10:40 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 19:10:40 INFO - Using env: {'DISPLAY': ':0', 19:10:40 INFO - 'HOME': '/home/cltbld', 19:10:40 INFO - 'LANG': 'en_US.UTF-8', 19:10:40 INFO - 'LANGUAGE': 'en_US:en', 19:10:40 INFO - 'LOGNAME': 'cltbld', 19:10:40 INFO - 'MAIL': '/var/mail/cltbld', 19:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:40 INFO - 'MOZ_NO_REMOTE': '1', 19:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:40 INFO - 'NO_EM_RESTART': '1', 19:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:40 INFO - 'PWD': '/builds/slave/test', 19:10:40 INFO - 'SHELL': '/bin/bash', 19:10:40 INFO - 'SHLVL': '1', 19:10:40 INFO - 'TERM': 'linux', 19:10:40 INFO - 'TMOUT': '86400', 19:10:40 INFO - 'USER': 'cltbld', 19:10:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:40 INFO - '_': '/tools/buildbot/bin/python'} 19:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:40 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 19:10:40 INFO - Cleaning up... 19:10:40 INFO - Return code: 0 19:10:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10:40 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')]} 19:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 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')]} 19:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:40 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 19:10:40 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 19:10:40 INFO - Using env: {'DISPLAY': ':0', 19:10:40 INFO - 'HOME': '/home/cltbld', 19:10:40 INFO - 'LANG': 'en_US.UTF-8', 19:10:40 INFO - 'LANGUAGE': 'en_US:en', 19:10:40 INFO - 'LOGNAME': 'cltbld', 19:10:40 INFO - 'MAIL': '/var/mail/cltbld', 19:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:40 INFO - 'MOZ_NO_REMOTE': '1', 19:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:40 INFO - 'NO_EM_RESTART': '1', 19:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:40 INFO - 'PWD': '/builds/slave/test', 19:10:40 INFO - 'SHELL': '/bin/bash', 19:10:40 INFO - 'SHLVL': '1', 19:10:40 INFO - 'TERM': 'linux', 19:10:40 INFO - 'TMOUT': '86400', 19:10:40 INFO - 'USER': 'cltbld', 19:10:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:40 INFO - '_': '/tools/buildbot/bin/python'} 19:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:41 INFO - Downloading/unpacking psutil>=3.1.1 19:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:43 INFO - Installing collected packages: psutil 19:10:43 INFO - Running setup.py install for psutil 19:10:43 INFO - building 'psutil._psutil_linux' extension 19:10:43 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 19:10:43 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 19:10:43 INFO - building 'psutil._psutil_posix' extension 19:10:43 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 19:10:43 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 19:10:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:43 INFO - Successfully installed psutil 19:10:43 INFO - Cleaning up... 19:10:45 INFO - Return code: 0 19:10:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:45 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:45 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 19:10:45 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 19:10:45 INFO - Using env: {'DISPLAY': ':0', 19:10:45 INFO - 'HOME': '/home/cltbld', 19:10:45 INFO - 'LANG': 'en_US.UTF-8', 19:10:45 INFO - 'LANGUAGE': 'en_US:en', 19:10:45 INFO - 'LOGNAME': 'cltbld', 19:10:45 INFO - 'MAIL': '/var/mail/cltbld', 19:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:45 INFO - 'MOZ_NO_REMOTE': '1', 19:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:45 INFO - 'NO_EM_RESTART': '1', 19:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:45 INFO - 'PWD': '/builds/slave/test', 19:10:45 INFO - 'SHELL': '/bin/bash', 19:10:45 INFO - 'SHLVL': '1', 19:10:45 INFO - 'TERM': 'linux', 19:10:45 INFO - 'TMOUT': '86400', 19:10:45 INFO - 'USER': 'cltbld', 19:10:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:45 INFO - '_': '/tools/buildbot/bin/python'} 19:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:45 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 19:10:45 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 19:10:45 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 19:10:45 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 19:10:45 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 19:10:45 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 19:10:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:47 INFO - Installing collected packages: mozsystemmonitor 19:10:47 INFO - Running setup.py install for mozsystemmonitor 19:10:47 INFO - Successfully installed mozsystemmonitor 19:10:47 INFO - Cleaning up... 19:10:47 INFO - Return code: 0 19:10:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:47 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:47 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 19:10:47 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 19:10:47 INFO - Using env: {'DISPLAY': ':0', 19:10:47 INFO - 'HOME': '/home/cltbld', 19:10:47 INFO - 'LANG': 'en_US.UTF-8', 19:10:47 INFO - 'LANGUAGE': 'en_US:en', 19:10:47 INFO - 'LOGNAME': 'cltbld', 19:10:47 INFO - 'MAIL': '/var/mail/cltbld', 19:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:47 INFO - 'MOZ_NO_REMOTE': '1', 19:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:47 INFO - 'NO_EM_RESTART': '1', 19:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:47 INFO - 'PWD': '/builds/slave/test', 19:10:47 INFO - 'SHELL': '/bin/bash', 19:10:47 INFO - 'SHLVL': '1', 19:10:47 INFO - 'TERM': 'linux', 19:10:47 INFO - 'TMOUT': '86400', 19:10:47 INFO - 'USER': 'cltbld', 19:10:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:47 INFO - '_': '/tools/buildbot/bin/python'} 19:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:47 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 19:10:47 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 19:10:47 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 19:10:47 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 19:10:47 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 19:10:47 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 19:10:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:50 INFO - Downloading docopt-0.6.1.tar.gz 19:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:50 INFO - Running setup.py install for blobuploader 19:10:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:50 INFO - Running setup.py install for requests 19:10:50 INFO - Running setup.py install for docopt 19:10:50 INFO - Successfully installed blobuploader requests docopt 19:10:50 INFO - Cleaning up... 19:10:50 INFO - Return code: 0 19:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:50 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')]} 19:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:50 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')]} 19:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:50 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:50 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 19:10:50 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 19:10:50 INFO - Using env: {'DISPLAY': ':0', 19:10:50 INFO - 'HOME': '/home/cltbld', 19:10:50 INFO - 'LANG': 'en_US.UTF-8', 19:10:50 INFO - 'LANGUAGE': 'en_US:en', 19:10:50 INFO - 'LOGNAME': 'cltbld', 19:10:50 INFO - 'MAIL': '/var/mail/cltbld', 19:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:50 INFO - 'MOZ_NO_REMOTE': '1', 19:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:50 INFO - 'NO_EM_RESTART': '1', 19:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:50 INFO - 'PWD': '/builds/slave/test', 19:10:50 INFO - 'SHELL': '/bin/bash', 19:10:50 INFO - 'SHLVL': '1', 19:10:50 INFO - 'TERM': 'linux', 19:10:50 INFO - 'TMOUT': '86400', 19:10:50 INFO - 'USER': 'cltbld', 19:10:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:50 INFO - '_': '/tools/buildbot/bin/python'} 19:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:50 INFO - Running setup.py (path:/tmp/pip-Y1Q__4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:51 INFO - Running setup.py (path:/tmp/pip-pYsRK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:51 INFO - Running setup.py (path:/tmp/pip-GGFwih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:51 INFO - Running setup.py (path:/tmp/pip-s9FPVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:51 INFO - Running setup.py (path:/tmp/pip-QI8w_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:51 INFO - Running setup.py (path:/tmp/pip-YpfcBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:51 INFO - Running setup.py (path:/tmp/pip-Cuupz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:51 INFO - Running setup.py (path:/tmp/pip-bvVq_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:51 INFO - Running setup.py (path:/tmp/pip-UfAD27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:51 INFO - Running setup.py (path:/tmp/pip-z6FphS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:51 INFO - Running setup.py (path:/tmp/pip-Yi70Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:51 INFO - Running setup.py (path:/tmp/pip-HsjOXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:51 INFO - Running setup.py (path:/tmp/pip-HwtoEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:51 INFO - Running setup.py (path:/tmp/pip-J_hjoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:51 INFO - Running setup.py (path:/tmp/pip-zFNI16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:52 INFO - Running setup.py (path:/tmp/pip-FkDX7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:52 INFO - Running setup.py (path:/tmp/pip-qQ1Yu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:52 INFO - Running setup.py install for manifestparser 19:10:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Running setup.py install for mozcrash 19:10:52 INFO - Running setup.py install for mozdebug 19:10:52 INFO - Running setup.py install for mozdevice 19:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Running setup.py install for mozfile 19:10:52 INFO - Running setup.py install for mozhttpd 19:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Running setup.py install for mozinfo 19:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Running setup.py install for mozInstall 19:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:52 INFO - Running setup.py install for mozleak 19:10:53 INFO - Running setup.py install for mozlog 19:10:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Running setup.py install for moznetwork 19:10:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Running setup.py install for mozprocess 19:10:53 INFO - Running setup.py install for mozprofile 19:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Running setup.py install for mozrunner 19:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Running setup.py install for mozscreenshot 19:10:53 INFO - Running setup.py install for moztest 19:10:53 INFO - Running setup.py install for mozversion 19:10:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:53 INFO - Cleaning up... 19:10:53 INFO - Return code: 0 19:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:53 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')]} 19:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:53 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')]} 19:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:53 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:53 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 19:10:53 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 19:10:53 INFO - Using env: {'DISPLAY': ':0', 19:10:53 INFO - 'HOME': '/home/cltbld', 19:10:53 INFO - 'LANG': 'en_US.UTF-8', 19:10:53 INFO - 'LANGUAGE': 'en_US:en', 19:10:53 INFO - 'LOGNAME': 'cltbld', 19:10:53 INFO - 'MAIL': '/var/mail/cltbld', 19:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:53 INFO - 'MOZ_NO_REMOTE': '1', 19:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:53 INFO - 'NO_EM_RESTART': '1', 19:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:53 INFO - 'PWD': '/builds/slave/test', 19:10:53 INFO - 'SHELL': '/bin/bash', 19:10:53 INFO - 'SHLVL': '1', 19:10:53 INFO - 'TERM': 'linux', 19:10:53 INFO - 'TMOUT': '86400', 19:10:53 INFO - 'USER': 'cltbld', 19:10:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:53 INFO - '_': '/tools/buildbot/bin/python'} 19:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:54 INFO - Running setup.py (path:/tmp/pip-2o1BgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:54 INFO - Running setup.py (path:/tmp/pip-uUMK0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:54 INFO - Running setup.py (path:/tmp/pip-ip_UNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:54 INFO - Running setup.py (path:/tmp/pip-T27u5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:54 INFO - Running setup.py (path:/tmp/pip-rTurM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:54 INFO - Running setup.py (path:/tmp/pip-KLTtZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:54 INFO - Running setup.py (path:/tmp/pip-J4E_vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:54 INFO - Running setup.py (path:/tmp/pip-Pnpnkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:54 INFO - Running setup.py (path:/tmp/pip-RClFRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:54 INFO - Running setup.py (path:/tmp/pip-oUfh2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:54 INFO - Running setup.py (path:/tmp/pip-D48jnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:54 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)) 19:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:54 INFO - Running setup.py (path:/tmp/pip-2L3Drk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:55 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)) 19:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:55 INFO - Running setup.py (path:/tmp/pip-iuhcCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:55 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)) 19:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:55 INFO - Running setup.py (path:/tmp/pip-UzG0m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:55 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)) 19:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:55 INFO - Running setup.py (path:/tmp/pip-jk8R9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:55 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)) 19:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:55 INFO - Running setup.py (path:/tmp/pip-VngYrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:55 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)) 19:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:55 INFO - Running setup.py (path:/tmp/pip-K6lxL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:55 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)) 19:10:55 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)) 19:10:55 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)) 19:10:55 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)) 19:10:55 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)) 19:10:55 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)) 19:10:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10: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 19:10: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 19:10: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 19:10: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 19:10: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 19:10: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 19:10:58 INFO - Downloading blessings-1.6.tar.gz 19:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:58 INFO - Installing collected packages: blessings 19:10:58 INFO - Running setup.py install for blessings 19:10:58 INFO - Successfully installed blessings 19:10:58 INFO - Cleaning up... 19:10:58 INFO - Return code: 0 19:10:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:58 INFO - Reading from file tmpfile_stdout 19:10:58 INFO - Current package versions: 19:10:58 INFO - argparse == 1.2.1 19:10:58 INFO - blessings == 1.6 19:10:58 INFO - blobuploader == 1.2.4 19:10:58 INFO - docopt == 0.6.1 19:10:58 INFO - manifestparser == 1.1 19:10:58 INFO - mozInstall == 1.12 19:10:58 INFO - mozcrash == 0.17 19:10:58 INFO - mozdebug == 0.1 19:10:58 INFO - mozdevice == 0.48 19:10:58 INFO - mozfile == 1.2 19:10:58 INFO - mozhttpd == 0.7 19:10:58 INFO - mozinfo == 0.9 19:10:58 INFO - mozleak == 0.1 19:10:58 INFO - mozlog == 3.2 19:10:58 INFO - moznetwork == 0.27 19:10:58 INFO - mozprocess == 0.22 19:10:58 INFO - mozprofile == 0.28 19:10:58 INFO - mozrunner == 6.11 19:10:58 INFO - mozscreenshot == 0.1 19:10:58 INFO - mozsystemmonitor == 0.3 19:10:58 INFO - moztest == 0.7 19:10:58 INFO - mozversion == 1.4 19:10:58 INFO - psutil == 3.1.1 19:10:58 INFO - requests == 1.2.3 19:10:58 INFO - wsgiref == 0.1.2 19:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:58 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:58 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 19:10:58 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 19:10:58 INFO - Using env: {'DISPLAY': ':0', 19:10:58 INFO - 'HOME': '/home/cltbld', 19:10:58 INFO - 'LANG': 'en_US.UTF-8', 19:10:58 INFO - 'LANGUAGE': 'en_US:en', 19:10:58 INFO - 'LOGNAME': 'cltbld', 19:10:58 INFO - 'MAIL': '/var/mail/cltbld', 19:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:58 INFO - 'MOZ_NO_REMOTE': '1', 19:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:58 INFO - 'NO_EM_RESTART': '1', 19:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:58 INFO - 'PWD': '/builds/slave/test', 19:10:58 INFO - 'SHELL': '/bin/bash', 19:10:58 INFO - 'SHLVL': '1', 19:10:58 INFO - 'TERM': 'linux', 19:10:58 INFO - 'TMOUT': '86400', 19:10:58 INFO - 'USER': 'cltbld', 19:10:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:58 INFO - '_': '/tools/buildbot/bin/python'} 19:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 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)) 19:10:58 INFO - Cleaning up... 19:10:58 INFO - Return code: 0 19:10:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:58 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:10:58 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 19:10:58 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 19:10:58 INFO - Using env: {'DISPLAY': ':0', 19:10:58 INFO - 'HOME': '/home/cltbld', 19:10:58 INFO - 'LANG': 'en_US.UTF-8', 19:10:58 INFO - 'LANGUAGE': 'en_US:en', 19:10:58 INFO - 'LOGNAME': 'cltbld', 19:10:58 INFO - 'MAIL': '/var/mail/cltbld', 19:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:58 INFO - 'MOZ_NO_REMOTE': '1', 19:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:58 INFO - 'NO_EM_RESTART': '1', 19:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:58 INFO - 'PWD': '/builds/slave/test', 19:10:58 INFO - 'SHELL': '/bin/bash', 19:10:58 INFO - 'SHLVL': '1', 19:10:58 INFO - 'TERM': 'linux', 19:10:58 INFO - 'TMOUT': '86400', 19:10:58 INFO - 'USER': 'cltbld', 19:10:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:58 INFO - '_': '/tools/buildbot/bin/python'} 19:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:59 INFO - Downloading/unpacking jsonschema 19:10:59 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 19:10:59 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 19:10:59 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 19:10:59 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 19:10:59 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 19:10:59 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 19:11:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:01 INFO - Downloading/unpacking functools32 (from jsonschema) 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:01 INFO - warning: no files found matching '*.txt' 19:11:01 INFO - no previously-included directories found matching 'build' 19:11:01 INFO - no previously-included directories found matching 'dist' 19:11:01 INFO - no previously-included directories found matching '.git*' 19:11:01 INFO - Installing collected packages: jsonschema, functools32 19:11:01 INFO - Running setup.py install for functools32 19:11:01 INFO - warning: no files found matching '*.txt' 19:11:01 INFO - no previously-included directories found matching 'build' 19:11:01 INFO - no previously-included directories found matching 'dist' 19:11:01 INFO - no previously-included directories found matching '.git*' 19:11:01 INFO - Successfully installed jsonschema functools32 19:11:01 INFO - Cleaning up... 19:11:01 INFO - Return code: 0 19:11:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:01 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 0x7fbc5e6a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', '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 19:11:01 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 19:11:01 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 19:11:01 INFO - Using env: {'DISPLAY': ':0', 19:11:01 INFO - 'HOME': '/home/cltbld', 19:11:01 INFO - 'LANG': 'en_US.UTF-8', 19:11:01 INFO - 'LANGUAGE': 'en_US:en', 19:11:01 INFO - 'LOGNAME': 'cltbld', 19:11:01 INFO - 'MAIL': '/var/mail/cltbld', 19:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:01 INFO - 'MOZ_NO_REMOTE': '1', 19:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:01 INFO - 'NO_EM_RESTART': '1', 19:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:01 INFO - 'PWD': '/builds/slave/test', 19:11:01 INFO - 'SHELL': '/bin/bash', 19:11:01 INFO - 'SHLVL': '1', 19:11:01 INFO - 'TERM': 'linux', 19:11:01 INFO - 'TMOUT': '86400', 19:11:01 INFO - 'USER': 'cltbld', 19:11:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:01 INFO - '_': '/tools/buildbot/bin/python'} 19:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:01 INFO - Downloading/unpacking flake8 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 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 19:11:01 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 19:11:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 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 19:11:03 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 19:11:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11:04 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 19:11:04 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 19:11:04 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 19:11:04 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 19:11:04 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 19:11:04 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 19:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:04 INFO - no previously-included directories found matching 'docs/_build' 19:11:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:11:04 INFO - Running setup.py install for pep8 19:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:04 INFO - no previously-included directories found matching 'docs/_build' 19:11:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:11:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:11:04 INFO - Cleaning up... 19:11:04 INFO - Return code: 0 19:11:04 INFO - Running post-action listener: _resource_record_post_action 19:11:04 INFO - Running post-action listener: _start_resource_monitoring 19:11:04 INFO - Starting resource monitoring. 19:11:04 INFO - ##### 19:11:04 INFO - ##### Finished create-virtualenv step (success) 19:11:04 INFO - ##### 19:11:04 INFO - ##### 19:11:04 INFO - ##### Running install step. 19:11:04 INFO - ##### 19:11:04 INFO - Running pre-action listener: _resource_record_pre_action 19:11:04 INFO - Running main action method: install 19:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:04 INFO - Reading from file tmpfile_stdout 19:11:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:04 INFO - Reading from file tmpfile_stdout 19:11:04 INFO - Output received: 19:11:04 INFO - Usage: mozinstall [options] installer 19:11:04 INFO - Options: 19:11:04 INFO - -h, --help show this help message and exit 19:11:04 INFO - -d DEST, --destination=DEST 19:11:04 INFO - Directory to install application into. [default: 19:11:04 INFO - "/builds/slave/test"] 19:11:04 INFO - --app=APP Application being installed. [default: firefox] 19:11:04 INFO - mkdir: /builds/slave/test/build/application 19:11:04 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'] 19:11:04 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 19:11:20 INFO - Reading from file tmpfile_stdout 19:11:20 INFO - Output received: 19:11:20 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:20 INFO - Running post-action listener: _resource_record_post_action 19:11:20 INFO - ##### 19:11:20 INFO - ##### Finished install step (success) 19:11:20 INFO - ##### 19:11:20 INFO - ##### 19:11:20 INFO - ##### Running run-tests step. 19:11:20 INFO - ##### 19:11:20 INFO - Running pre-action listener: _resource_record_pre_action 19:11:20 INFO - Running main action method: run_tests 19:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:20 INFO - Python 2.7.3 19:11:20 INFO - Return code: 0 19:11:20 INFO - grabbing minidump binary from tooltool 19:11: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')]} 19:11:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f09c0>, '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 0x23f18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:11:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:11:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:11:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:20 INFO - Return code: 0 19:11:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:11:21 INFO - Return code: 0 19:11:21 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/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 19:11:21 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/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 19:11:21 INFO - Using env: {'DISPLAY': ':0', 19:11:21 INFO - 'HOME': '/home/cltbld', 19:11:21 INFO - 'LANG': 'en_US.UTF-8', 19:11:21 INFO - 'LANGUAGE': 'en_US:en', 19:11:21 INFO - 'LOGNAME': 'cltbld', 19:11:21 INFO - 'MAIL': '/var/mail/cltbld', 19:11:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:21 INFO - 'MOZ_NO_REMOTE': '1', 19:11:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:21 INFO - 'NO_EM_RESTART': '1', 19:11:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:21 INFO - 'PWD': '/builds/slave/test', 19:11:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:21 INFO - 'SHELL': '/bin/bash', 19:11:21 INFO - 'SHLVL': '1', 19:11:21 INFO - 'TERM': 'linux', 19:11:21 INFO - 'TMOUT': '86400', 19:11:21 INFO - 'USER': 'cltbld', 19:11:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172', 19:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:21 INFO - '_': '/tools/buildbot/bin/python'} 19:11:21 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/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 19:11:21 INFO - mozversion application_buildid: 20160519184214 19:11:21 INFO - mozversion application_changeset: 466d5c96f43964d4122959e5ab19131237bdc6fa 19:11:21 INFO - mozversion application_display_name: Nightly 19:11:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:21 INFO - mozversion application_name: Firefox 19:11:21 INFO - mozversion application_remotingname: firefox 19:11:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:11:21 INFO - mozversion application_vendor: Mozilla 19:11:21 INFO - mozversion application_version: 49.0a1 19:11:21 INFO - mozversion platform_buildid: 20160519184214 19:11:21 INFO - mozversion platform_changeset: 466d5c96f43964d4122959e5ab19131237bdc6fa 19:11:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:11:21 INFO - mozversion platform_version: 49.0a1 19:11:21 INFO - using testdate: 1463710281 19:11:21 INFO - actual date: 1463710281 19:11:21 INFO - starting webserver on 'localhost:55438' 19:11:21 INFO - SUITE-START | Running 2 tests 19:11:21 INFO - TEST-START | dromaeo_css 19:11:21 INFO - operating with platform_type : linux_ 19:11:21 INFO - Initialising browser for dromaeo_css test... 19:11:21 INFO - TEST-INFO | started process 4850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYoNH6/profile http://localhost:55438/getInfo.html) 19:11:26 INFO - PROCESS | 4850 | __metrics Screen width/height:1600/1200 19:11:26 INFO - PROCESS | 4850 | colorDepth:24 19:11:26 INFO - PROCESS | 4850 | Browser inner width/height: 1024/697 19:11:26 INFO - PROCESS | 4850 | __metrics 19:11:27 ERROR - PROCESS | 4850 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:11:28 INFO - TEST-INFO | 4850: exit 0 19:11:28 INFO - Browser initialized. 19:11:28 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:28 INFO - TEST-INFO | started process 4931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYoNH6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:40 INFO - PROCESS | 4931 | RSS: Main: 154066944 19:11:40 INFO - PROCESS | 4931 | 19:12:31 INFO - PROCESS | 4931 | 1463710351787 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] 19:14:43 INFO - PROCESS | 4931 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55438/tests/dromaeo/cssquery-ext.html) 19:14:44 INFO - PROCESS | 4931 | RSS: Main: 236023808 19:14:44 INFO - PROCESS | 4931 | 19:17:46 INFO - PROCESS | 4931 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-ext.html (next: http://localhost:55438/tests/dromaeo/cssquery-jquery.html) 19:17:47 INFO - PROCESS | 4931 | RSS: Main: 242614272 19:17:47 INFO - PROCESS | 4931 | 19:20:49 INFO - PROCESS | 4931 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55438/tests/dromaeo/cssquery-mootools.html) 19:20:50 INFO - PROCESS | 4931 | RSS: Main: 236322816 19:20:50 INFO - PROCESS | 4931 | 19:23:52 INFO - PROCESS | 4931 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55438/tests/dromaeo/cssquery-prototype.html) 19:23:52 INFO - PROCESS | 4931 | RSS: Main: 237461504 19:23:52 INFO - PROCESS | 4931 | 19:26:55 INFO - PROCESS | 4931 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55438/tests/dromaeo/cssquery-yui.html) 19:26:56 INFO - PROCESS | 4931 | RSS: Main: 219541504 19:26:56 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-yui.html (next: http://localhost:55438/tests/dromaeo/cssquery-dojo.html) 19:29:59 INFO - PROCESS | 4931 | RSS: Main: 307163136 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | __start_tp_report 19:29:59 INFO - PROCESS | 4931 | _x_x_mozilla_page_load 19:29:59 INFO - PROCESS | 4931 | _x_x_mozilla_page_load_details 19:29:59 INFO - PROCESS | 4931 | |i|pagename|runs| 19:29:59 INFO - PROCESS | 4931 | |0;dojo.html;2642.709301976782;2651.920442386729;2684.6375739275204;2686.3955609987747;2693.2189664997154;4594.908101837966;4613.400257966459;4661.860144195671;4666.976665116674;4720.551547602977;4676.111538807624;4697.2954056891485;4704.741239231841;4731.526847315266;4739.786709598067;4144.6684265258855;4245.108527209282;4369.825206991716;4382.452193475816;4505.346724724913;4407.096545208241;4442.777861106948;4454.97772511137;4469.307257375112;4502.3696682464315;4244.3209086546;4272.273713468718;4291.35629655551;4302.376155457441;4325.286327755916;4321.438213032317;4330.7401555906745;4339.175556644227;4361.672874534423;4375.234333991571;4395.670324725626;4403.933940990888;4413.757243351614;4416.2713152329825;4447.110577884404;4539.251023581105;4566.995261042599;4591.977040114812;4596.724196548218;4611.723296602181;5043;5055.5702765265;5073.061483625541;5095.439501654815;5096.261042148868;5112.872178195575;5142.897142057175;5154.819581314636;5157.8452646420665;5180.119379705459;4600.056988317387;4712.976435117803;4766.880827979328;4770.475247722748;4798.328234047236;5222.373315202124;5240.266362709223;5260.736963151827;5305.920411193835;5328.520433160957;4849.248366503198;5035.093683137071;5074.543291103744;5098.898022039539;5103.055934652101;4978.6017118630425;5019.949800501949;5030.170021946338;5046.6719663221775;5080.212567052113;5016.698998060128;5017.197248440232;5019.14674505335;5023.296738456619;5051.747412629354;4885.169521181337;4912.508749125059;5012.699238045729;5012.774425150877;5023.598112151019;4281.743095414286;4298.4197133387215;4302.139572085595;4330.783460826946;4333.826646934151;3728.3475391806323;3732.3654978653694;3754.568224654145;3783.375743002374;3797.0697179190724;4225.9788701056295;4252.978735106367;4268.765217913045;4304.569543045671;4323.978380108142;5023.497650234947;5066.493350664904;5068.062408454448;5072.923906141411;5126.92309615356;4280.058387154821;4330.328799036154;4330.7401555906745;4374.759388233678;4377.78111094444;4489.281714925596;4489.5959363656775;4520.299353600197;4541.931871021938;4550.567696068868;4708.81164753406;4729.243321068612;4730.1958667026;4762.095201911695;4776.737279449663;5010.123228434936;5025.623078269071;5027.296178534935;5043.394792624908;5078.949210507995;4628.884277892945;4639.953600463952;4698.92951605733;4704.482506924304;4719.032598317405;4884.755762211804;4904.509549045067;4908.9754551227015;4918.409790825124;4962.330085438564;4946.480619535041;4975.5522003019905;4975.850724478271;5003.199488081889;5042.899142017212;4798.376211092535;4855.101806165871;4880.389951256093;4901.191303434894;4928.753562321941;4901.240307752304;4905.622888933013;4910.631702622389;4912.803487860446;4966.602671786176;4677.438707355003;4847.248676455155;4849.80600775965;4894.363732714724;4903.068417000758;4885.218365061573;4944.208926571731;4944.53026962438;4968.180250258812;4970.080535101018;4850.854474365775;4879.243717223836;4887.462379138363;4898.510148985073;4934.777934992862 19:29:59 INFO - PROCESS | 4931 | |1;ext.html;570.9600327977041;591.0572636644551;600.495583709684;607.9665618390986;609.3632154398653;27380.589291160624;39969.80015099924;40915.38626920595;41280.38079428811;44227.77886110573;38134.237315253675;38183.618163818355;38199;38260.23479530408;38495.61504384955;7699.153093159748;7839.059312882462;7887.684492620288;7895.24995125465;7897.368210543172;7709.922900771005;7806.5316081035035;7827.412944029221;7836.529808211497;7837.960810195969;7782.105057918327;7813.843723125534;7832.530048197098;7834.608269586498;7838.686452541891;7760.961195194044;7804.570748608824;7810.921890781076;7816.6873325066645;7823.139454659983;7683.847422886612;7777.494462859896;7790.415718821111;7791.961040194763;7793.922060779433;37786.244275114346;38119.618803811885;38153.42769858454;38170.809145954096;38218.80890595557;2991.2671395508023;3091.7681173912047;3181.220600952758;3241.675832416763;3294.7364210863075;28604.856975715196;28754.137375878756;28811.71188288132;29459.852700736574;29484.852575737197;3529.9674348074827;3535.3106144301873;3546.1666508370513;3548.556430446194;3594.5506811648543;267586;271240;271306.999999998;272088;272274;51975;52199.73900130551;52377.33358664857;52390.47609523856;52411;40229.19541609151;41465.58534414678;55179;56794.14808777872;56920.715396423584;12169.391530423443;12215.694607634703;12319.014478841671;12323;12356.073294502949;8711.303095752324;10355;10423.322484038514;10434.947825260826;10438;15404.306806193748;15693.686126277411;15859.127747973742;16044.919775401047;16079.196040197943;6272.8118156455375;6381.680915954184;6418.26189988148;6525.2169739631545;6554.004114979717;856.4347530629755;936.9344145909721;988.8813342398959;1065.7815147894662;1069.978600427987;28139.71860281412;28252.293692657437;28465.10335519846;28676.283092922844;28711.56932646012;975.453745902297;988.9703308900745;989.7129832348538;1003.6637726361605;1005.939643621385;14177.78733319001;14338.928305358406;14383.78424323636;14580.854191458162;14586.562403127711;385190;390399;393847;394102;394487;48642.5135748638;48762.5123748765;48799;48837.26744098841;48844.7557762216;1109.57836022311;1215.4348228073989;1227.3617718786359;1261.5521489871146;1305.3081866610712;27219.319517012234;28356.574651379833;28974.27564310909;29069.563956540245;29319.85340073286;40551.1889762209;41185;41431.37852932269;41448.3782743253;41457.1708565833;310295;310720;311128;311859;312518;21652.35042948714;23780.643290350312;24841.378965526008;24858.25425237246;25750.227493175236;40516.3922541168;40545;40644.39033414442;40901;41400.58599413967;34606.82696586501;35108;35522.28955420929;35783.284334312644;36252.456213157355;35244.823775880956;35374.823125884206;35574.466383004794;35932.64067359293;35940.46089308715;34363.82818085894;34817.47773783345;35124.140412601584;35208.47187292244;35428.114297142776;30496.237594060327;31668.683313166573;31673.5248971261;31705.002846498475;31777.20556986094;24119.63820542658;25837.354066148495;25839.095631652803;25974.35064123412;26185.869070654524 19:29:59 INFO - PROCESS | 4931 | |2;jquery.html;377.1344763767155;380.4407520944211;385.7473354952506;390.1183325683953;396.85911501416996;15677;16686.249118789652;17042.488725338244;17188.914055429705;17195.570110747238;15820.208989550505;16694;16731.247093880804;16795.160241987884;16806.075665838373;5068.2651015602805;5264.184051472009;5274.393444753845;5280.1815718563685;5316.388615309231;3722.8138593070375;3951.0714981979213;5823.184754134425;6143.354947730491;6150.50795936324;6104.96947515264;6186.381361863822;6194.81415557534;6211.130441738161;6221.906671399933;6065.969670151665;6162.476189523896;6202.658853763041;6203.2866220384785;6209.9068513972325;3408.454647256452;5109.233614957749;5412.729363531807;5418.864528386822;5500.50495455411;20390.388288351372;20399.388018359474;20656.070476828427;20923.953802309978;20957.371278861658;1826.9817301826945;2089.9059542320633;2528.380546766054;2550.5919052951626;2562.0520407449176;12980.28608426536;13170.736585268241;13250.093644649769;13292.401841917137;13763;1811.610503741702;2044.2845004248543;2108.135664377598;2117.390783004912;2159.2442645074257;75377.62311188463;79231.60384198099;81140.59429702873;83114;85310;16405;16429.58926026835;16433.506994790176;16467.83532164687;16525.504234872973;29776;29948.95178668736;30131.69868301333;30289.24276893095;30411.543826842615;8299.668013279523;8771.473711577326;8821.382503224713;8855.33584981129;8905.243054340324;6936.861262774817;7019.087518622547;7034.537911730853;7075.327843854826;7136.571805691675;8257.174282571696;8482.915170848213;8520.14798520143;8545.487270763773;8580.356473264404;2632.6577544919037;3244.4484437645656;3329.417351963445;3518.7712798668003;3532.1699400640828;673.5419914458117;749.1010787055556;754.5321900421774;821.359329754841;933.206774241889;16997.575060623585;17021.40425085116;17061.317547297967;17550.122493875257;17559.12204389801;840.5251033166242;852.424613385962;866.787637028932;884.027569673367;927.9536023198813;9345.532723363805;9749.512524373753;9778.217742580577;9791.755206119904;9930.851037234448;387828;391211;395813;397345;407443;80724;80831.59584202159;81552;83564.16435835685;83981;881.1716986033108;891.892972843263;902.5622573052065;925.3615005646217;926.6571368593663;15132.167730774912;15319;15390.461333853262;15466.458673946358;15760.60598485047;28964.13107606775;35388.39950806378;35507.46738798972;35855.28289434144;37033.259334813694;50192;50229.74885125551;50498;51126.23310650269;51570.22644660258;6571.57284776488;6824.829379265558;7004.964975175091;7761;8206.58967051657;7673.439393036525;10476.947615261875;10478.685639430829;10548.103411210133;11107.777844443228;9887.752806179904;9957.850632240667;10141.188704903738;10194.592216311265;10280.126189273995;9383.812323753351;9705.417674939526;9806.872209695975;10077.344972576759;10290.12533934624;9510.572024258787;9738.123568878835;9787.16809071237;10089.091981721387;10487.528061237415;7606.20134885829;7679.808004799925;7851.175626559358;7851.450398472052;7945.324647405036;9634.325597208408;9848.359856609584;9868.457234852152;10121.089101980857;10420.68737937863 19:29:59 INFO - PROCESS | 4931 | |3;mootools.html;1280.60301306595;1419.3329135306406;1459.5402448228808;1579.8341174176712;1779.9854083172588;7433;7773.922260777397;7775.183605721402;7976.441649084566;7988.92011079889;7711;7863.8427231455335;7869.331106855924;7872.01599800025;7877.842443151134;2209.635410157326;2233.0955962834996;2235.552889422114;2239.0372139979804;2239.317008312464;2195.5169862630196;2217.390217690132;2225.098834971839;2228.832837537183;2234.4748983988748;2176.6843807647883;2202.9779702203014;2216.024949022425;2216.26863135165;2244.551089782042;2125.2774056820676;2132.0618927671853;2141.8714877107423;2145.9356219313445;2151.139544182332;2112.852100352976;2151.3868547464053;2152.1714140056033;2156.70884430603;2157.061678170001;7693.884591731128;7714.845703085907;7780.221977802231;7789.883151752728;7888.842223155505;4418.469783625953;4519.932201016987;4532.954670453286;4533.410656614652;4535.637149028103;2888.653361596601;2893.6382952130984;2935.853207339646;2947.911562653124;2977.970220297791;869.0831173112364;875.5797217335651;904.2359206470522;907.1246247371253;924.2051835421532;10517.63188288414;10614.840777388268;10648.946755266252;10653.201009924209;10654.893451065467;4052.5339585947995;4108.815103320358;4176.331786914079;4179.644730197906;4181.121964387513;7897.842043159219;7940.444168908121;7977.521348719096;7994.920050799534;7999.9600001999615;4378.5183629800695;4379.5401482843845;4415.40392047076;4428.4243048403505;4433;3637.5634923808784;4035.1727895781296;4056.0671045659665;4130.814113364906;4190.643795277375;3460.3598334308235;3465.86136554535;3518.7009104226427;3544.5392099026963;3657.7805331680183;1008.7175590834578;1012.6000229909292;1018.6485662446444;1031.4945676618554;1050.1808589300358;727.9818004549822;849.2696281198165;853.8217260181035;857.1985193843776;862.6420035685246;5116.846494605168;5237.319148510669;5243.4232234454175;5245.6852588844795;5333.919991200135;393.86805420183987;394.43595658208466;400.5453809925697;405.59237965844136;415.5532802237546;3674.393725035393;3690.2619476104887;3713.4801127842125;3716.7769933804057;3753.211825516672;9306;9724;9808.803823923481;9808.803823923481;9819.901800982041;9658.3722058066;9675.371100878421;9679.9032009679;9682.419054856731;9687.128158465772;6987.301269872972;7461.477696561188;7467.215942326086;7499.587522686195;7501.62491875415;5148.6910785353;5242.318498595158;5266.236395722675;5378.650387724785;5463.235147079333;8931.687390941286;9009.459432434074;9034.232090272137;9107.590158442754;9135.58889849945;8999.100089990949;9160.31297652692;9245.676401325922;9275.907240927505;9367;5727.770889164387;5910.172575839472;6053;6185.257769067741;6240.469560087444;7531.510451820614;7579.204183560647;7639.350655194371;7644.961775191088;7646.579438130956;6539.084528165966;6772.55978361405;6811.421029212573;6846.5892046477375;6908.1364829396325;6516.771912983023;6539.771108011197;6696.732130714717;6742.359475849787;6773.93226067733;6154.261488621394;6184.412480814315;6244.968775156095;6245.843853903689;6246.5002799775;4477.753723545236;4577.633789296915;4626.1904166771355;4695.225287827607;4820.6143508518535;4528.932066018947;4601.849537615596;4715.599174070106;4770.666053376231;4799.208130658542 19:29:59 INFO - PROCESS | 4931 | |4;prototype.html;280.4363229907886;288.13990239136183;295.6945087438957;299.58357882543254;300.17751361270115;4757.857264282077;4795.640326975477;4797.400324959376;4800.975995120024;4801.135795556798;4501.909961800762;4550.180967425862;4562.84030058948;4746.359241502396;4759.976605029918;3748.231612519427;3784.375578029622;3804.5434547854156;3810.19985802981;3810.2569998850236;3791.4123310886857;3795.8043216386886;3800.1639639279315;3811.1234416084317;3814.2263847310996;3574.338747331739;3655.817209139546;3776.30138424391;3777.263433630443;3778.3576791945434;3743.6630703236838;3750.849966001384;3755.906102347436;3775.754575952554;3777.8866634001024;3333.383324085052;3333.599968003831;3360.22714775603;3365.848536815849;3378.341223461426;4333.609975102256;4532.116237333721;4561.566651168134;4571.9314210286875;4574.382458368144;4261.829526818923;4286.635635970946;4324.783760811947;4324.913501729948;4328;4977.253411988195;4978.303037574742;4987.850364489072;4991.900161996739;5007.749612519359;3670.4310831821113;3671.1556342041213;3673.4673472346362;3683.4658974448553;3706.5737440194453;5044.798208071673;5158.38099428071;5167.819126330561;5176.404713457963;5181.274621552986;3713.6472035156617;3746.494223279822;3748.6251374862295;3758.361078616642;3764.303603833245;3809.847606095725;3813.2182902505474;3824.7569539899646;3831.4635950966886;3844.4233364995475;4005.2790497710694;4239.0885959518855;4278.893027674333;4322.508734486597;4325.956740432618;4968.168144157868;4971.552560269521;4979.30289759434;4990.650654454226;5009.423916249605;1216.5498765456837;1249.9875001250052;1256.9497220111275;1275.7384736129072;1283.1018287199;812.6586833529932;824.2334628795278;825.455199568294;834.9165083491603;839.8446287436843;3853.5953724859046;3922.4508568800393;3946.3883098119836;3976.522817261889;3982.960170398259;4510.909781804346;4565.406497155349;4565.703229290086;4578.65660075489;4594.036846234227;3860.845566177378;3869.4389313549377;3952.320263887894;3955.5253369595257;3977.5226972762875;2400.2679182849397;2423.503181847717;2544.9363765906;2728.249731323902;2749.628800111999;4842.15262329091;4874.341963834837;4875.146849301429;4881.365422495053;4887.90022244992;5265.157574788015;5268.525832675077;5275.072334854116;5276.287701160371;5287.814926477555;4650.604698600657;4795.472498025214;4829.4204695437475;4843.782029808737;4889.315495830587;5099.209622508517;5112.565431938327;5120.771014956458;5133.794648214179;5190.662606930538;4996.975015124901;5065.973610555659;5093.733288686499;5096.286519887293;5096.796128154832;4717.292406139107;4721.7756185943035;4834.081524510332;4847.781849816837;4870.172070747911;3539.9469007965417;3554.4845997329726;3578.3380074686265;3585.1395665040723;3597.874074407383;4970.353853998957;5144.099782537966;5155.742212889266;5157.896842063213;5195;4861.975690121527;4951.207806750903;4969.180085285887;4971.627127965345;5001.57486613642;4870.9770948101295;4958.950410495849;4960.181570040902;5001.174806156943;5016.824411145738;4792.281157826354;4833.9274910875665;4913.238448040416;4915.901681966412;4934.149693864801;5019.573336266459;5024.246363045572;5053.2420136979745;5053.974730126326;5054.721990290569;4842.903141937212;4862.878428039186;4924.138275801792;4933.407991040955;4945.703257804544 19:29:59 INFO - PROCESS | 4931 | |5;yui.html;658.2331583704984;677.4918810891829;700.4571457120734;700.6391708270245;708.2987842036384;12154.392280385979;12549.184303020298;12578.182418142815;12944.834964853162;12949.223046617199;12447.502099916015;12516.812247816268;12577.182483138613;12578.371081445937;12580.24518528889;631.7251995382023;790.1466416270414;808.5997431271514;821.0844907927648;821.195228675898;806.5241507510567;816.0696805641544;816.3550794872044;817.7342363731811;817.8773184022385;852.9061803201643;857.4897935728231;857.7984173719202;857.9828403431927;858.5149390594325;655.4952686431421;815.2051749544206;836.619338201117;848.4188330993259;853.1468531468531;608.8051823416508;612.1735656863243;612.2958597612736;612.5038718637918;613.1140501974648;12157.51369945201;12157.817632735427;12389.946854517286;12459.75080498394;12492.312922789242;11427.60845968174;11492.942535287353;11763.411829408495;11939.641810745692;12583.496660133675;10136.746581335525;10288.382697038127;11376.089912806956;11408.657740267723;11517.251378660443;3299.290652509722;3321.501774733785;3323.7839540429795;3422.401079811023;3465.220325426784;40832.591674083174;42611;43040.56959430428;46168.53831461676;46650;9807;9844.3601165924;9859.753506162404;9911.702648920544;10281.948590257001;16557.08936008507;17094.829051709574;17142.314307427565;17217.139143042798;17220.225089870986;6686.364795344434;6719.328067193339;6828;6848.417884479775;6852.45180385568;3579.6957258632788;3611.476335931275;3628.4194528875782;3661.6704496595435;3704.7221458390727;2731.8907243710028;2815.127310533741;2818.3236023354248;2819.323362393052;2820.7461328480535;499.5878400319751;517.3300575754407;521.2285816990799;522.334024119251;553.8836844262669;479.297828680984;585.6134950932365;586.355009489558;591.2136857978878;607.480604083511;7680.500767450098;7762.184970578121;7851.685932562634;7945.682172713026;7956.801079972931;459.71267957526544;467.53947361848554;510.8824970256862;546.3471151973433;555.7276934302163;3596.0650230939623;3599.208174201671;3601.1177261571083;3603.4234522476277;3673.8530458781884;53210.46789532132;54293.45706542884;54345.1848222277;54418.45581544213;54421;47456.76271618689;48294.27558586624;48446.5155348442;48987;49553;43624;44190.779046104566;44612.3308150378;44987.325190122174;45356.77321613437;7367.484276100621;7388.556686598821;7397.630118493946;7434.8411629565335;7442.553446793209;28681.713182868738;29118.27204319909;29706.851465742533;31371.84314078415;31485.685143148276;38510.22979540337;38794;39205;39405.408918866815;40741.79629101954;10460.843087353544;10470.21473389514;10531.157507399543;10634.468276586294;10897.073748731447;11275.7744845101;11313.151513636674;11433.253059907081;11540.422978851191;11624.767504650028;10749.89250107489;10963.671089867317;11090.889091109308;11437;11606.94196529012;11073.224874258725;11185.72035699114;11665;11668.416579170838;11682.415879205835;10733.785324293627;10901.890981090088;11269.943650281695;11462.656120316404;11476.540938362372;8774.540440264685;8831.072737362485;8899.644014239617;8955.820883582423;9119.224865886474;8917.242034427147;9033.50315732641;9128.771780705536;9266.305027123128;9416.435013898914 19:29:59 INFO - PROCESS | 4931 | __end_tp_report 19:29:59 INFO - PROCESS | 4931 | __start_cc_report 19:29:59 INFO - PROCESS | 4931 | _x_x_mozilla_cycle_collect,897 19:29:59 INFO - PROCESS | 4931 | __end_cc_report 19:29:59 INFO - PROCESS | 4931 | __startTimestamp1463711399401__endTimestamp 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | ------- Summary: start ------- 19:29:59 INFO - PROCESS | 4931 | Number of tests: 6 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | [#0] dojo.html Cycles:165 Average:4661.28 Median:4766.88 stddev:485.83 (10.2%) stddev-sans-first:460.79 19:29:59 INFO - PROCESS | 4931 | Values: 2642.7 2651.9 2684.6 2686.4 2693.2 4594.9 4613.4 4661.9 4667.0 4720.6 4676.1 4697.3 4704.7 4731.5 4739.8 4144.7 4245.1 4369.8 4382.5 4505.3 4407.1 4442.8 4455.0 4469.3 4502.4 4244.3 4272.3 4291.4 4302.4 4325.3 4321.4 4330.7 4339.2 4361.7 4375.2 4395.7 4403.9 4413.8 4416.3 4447.1 4539.3 4567.0 4592.0 4596.7 4611.7 5043.0 5055.6 5073.1 5095.4 5096.3 5112.9 5142.9 5154.8 5157.8 5180.1 4600.1 4713.0 4766.9 4770.5 4798.3 5222.4 5240.3 5260.7 5305.9 5328.5 4849.2 5035.1 5074.5 5098.9 5103.1 4978.6 5019.9 5030.2 5046.7 5080.2 5016.7 5017.2 5019.1 5023.3 5051.7 4885.2 4912.5 5012.7 5012.8 5023.6 4281.7 4298.4 4302.1 4330.8 4333.8 3728.3 3732.4 3754.6 3783.4 3797.1 4226.0 4253.0 4268.8 4304.6 4324.0 5023.5 5066.5 5068.1 5072.9 5126.9 4280.1 4330.3 4330.7 4374.8 4377.8 4489.3 4489.6 4520.3 4541.9 4550.6 4708.8 4729.2 4730.2 4762.1 4776.7 5010.1 5025.6 5027.3 5043.4 5078.9 4628.9 4640.0 4698.9 4704.5 4719.0 4884.8 4904.5 4909.0 4918.4 4962.3 4946.5 4975.6 4975.9 5003.2 5042.9 4798.4 4855.1 4880.4 4901.2 4928.8 4901.2 4905.6 4910.6 4912.8 4966.6 4677.4 4847.2 4849.8 4894.4 4903.1 4885.2 4944.2 4944.5 4968.2 4970.1 4850.9 4879.2 4887.5 4898.5 4934.8 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | [#1] ext.html Cycles:180 Average:47333.12 Median:19763.60 stddev:86528.67 (437.8%) stddev-sans-first:86700.17 19:29:59 INFO - PROCESS | 4931 | Values: 571.0 591.1 600.5 608.0 609.4 27380.6 39969.8 40915.4 41280.4 44227.8 38134.2 38183.6 38199.0 38260.2 38495.6 7699.2 7839.1 7887.7 7895.2 7897.4 7709.9 7806.5 7827.4 7836.5 7838.0 7782.1 7813.8 7832.5 7834.6 7838.7 7761.0 7804.6 7810.9 7816.7 7823.1 7683.8 7777.5 7790.4 7792.0 7793.9 37786.2 38119.6 38153.4 38170.8 38218.8 2991.3 3091.8 3181.2 3241.7 3294.7 28604.9 28754.1 28811.7 29459.9 29484.9 3530.0 3535.3 3546.2 3548.6 3594.6 267586.0 271240.0 271307.0 272088.0 272274.0 51975.0 52199.7 52377.3 52390.5 52411.0 40229.2 41465.6 55179.0 56794.1 56920.7 12169.4 12215.7 12319.0 12323.0 12356.1 8711.3 10355.0 10423.3 10434.9 10438.0 15404.3 15693.7 15859.1 16044.9 16079.2 6272.8 6381.7 6418.3 6525.2 6554.0 856.4 936.9 988.9 1065.8 1070.0 28139.7 28252.3 28465.1 28676.3 28711.6 975.5 989.0 989.7 1003.7 1005.9 14177.8 14338.9 14383.8 14580.9 14586.6 385190.0 390399.0 393847.0 394102.0 394487.0 48642.5 48762.5 48799.0 48837.3 48844.8 1109.6 1215.4 1227.4 1261.6 1305.3 27219.3 28356.6 28974.3 29069.6 29319.9 40551.2 41185.0 41431.4 41448.4 41457.2 310295.0 310720.0 311128.0 311859.0 312518.0 21652.4 23780.6 24841.4 24858.3 25750.2 40516.4 40545.0 40644.4 40901.0 41400.6 34606.8 35108.0 35522.3 35783.3 36252.5 35244.8 35374.8 35574.5 35932.6 35940.5 34363.8 34817.5 35124.1 35208.5 35428.1 30496.2 31668.7 31673.5 31705.0 31777.2 24119.6 25837.4 25839.1 25974.4 26185.9 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | [#2] jquery.html Cycles:180 Average:25774.50 Median:28117.73 stddev:65568.73 (233.2%) stddev-sans-first:65724.93 19:29:59 INFO - PROCESS | 4931 | Values: 377.1 380.4 385.7 390.1 396.9 15677.0 16686.2 17042.5 17188.9 17195.6 15820.2 16694.0 16731.2 16795.2 16806.1 5068.3 5264.2 5274.4 5280.2 5316.4 3722.8 3951.1 5823.2 6143.4 6150.5 6105.0 6186.4 6194.8 6211.1 6221.9 6066.0 6162.5 6202.7 6203.3 6209.9 3408.5 5109.2 5412.7 5418.9 5500.5 20390.4 20399.4 20656.1 20924.0 20957.4 1827.0 2089.9 2528.4 2550.6 2562.1 12980.3 13170.7 13250.1 13292.4 13763.0 1811.6 2044.3 2108.1 2117.4 2159.2 75377.6 79231.6 81140.6 83114.0 85310.0 16405.0 16429.6 16433.5 16467.8 16525.5 29776.0 29949.0 30131.7 30289.2 30411.5 8299.7 8771.5 8821.4 8855.3 8905.2 6936.9 7019.1 7034.5 7075.3 7136.6 8257.2 8482.9 8520.1 8545.5 8580.4 2632.7 3244.4 3329.4 3518.8 3532.2 673.5 749.1 754.5 821.4 933.2 16997.6 17021.4 17061.3 17550.1 17559.1 840.5 852.4 866.8 884.0 928.0 9345.5 9749.5 9778.2 9791.8 9930.9 387828.0 391211.0 395813.0 397345.0 407443.0 80724.0 80831.6 81552.0 83564.2 83981.0 881.2 891.9 902.6 925.4 926.7 15132.2 15319.0 15390.5 15466.5 15760.6 28964.1 35388.4 35507.5 35855.3 37033.3 50192.0 50229.7 50498.0 51126.2 51570.2 6571.6 6824.8 7005.0 7761.0 8206.6 7673.4 10476.9 10478.7 10548.1 11107.8 9887.8 9957.9 10141.2 10194.6 10280.1 9383.8 9705.4 9806.9 10077.3 10290.1 9510.6 9738.1 9787.2 10089.1 10487.5 7606.2 7679.8 7851.2 7851.5 7945.3 9634.3 9848.4 9868.5 10121.1 10420.7 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | [#3] mootools.html Cycles:180 Average:5082.23 Median:5132.77 stddev:2878.06 (56.1%) stddev-sans-first:2871.95 19:29:59 INFO - PROCESS | 4931 | Values: 1280.6 1419.3 1459.5 1579.8 1780.0 7433.0 7773.9 7775.2 7976.4 7988.9 7711.0 7863.8 7869.3 7872.0 7877.8 2209.6 2233.1 2235.6 2239.0 2239.3 2195.5 2217.4 2225.1 2228.8 2234.5 2176.7 2203.0 2216.0 2216.3 2244.6 2125.3 2132.1 2141.9 2145.9 2151.1 2112.9 2151.4 2152.2 2156.7 2157.1 7693.9 7714.8 7780.2 7789.9 7888.8 4418.5 4519.9 4533.0 4533.4 4535.6 2888.7 2893.6 2935.9 2947.9 2978.0 869.1 875.6 904.2 907.1 924.2 10517.6 10614.8 10648.9 10653.2 10654.9 4052.5 4108.8 4176.3 4179.6 4181.1 7897.8 7940.4 7977.5 7994.9 8000.0 4378.5 4379.5 4415.4 4428.4 4433.0 3637.6 4035.2 4056.1 4130.8 4190.6 3460.4 3465.9 3518.7 3544.5 3657.8 1008.7 1012.6 1018.6 1031.5 1050.2 728.0 849.3 853.8 857.2 862.6 5116.8 5237.3 5243.4 5245.7 5333.9 393.9 394.4 400.5 405.6 415.6 3674.4 3690.3 3713.5 3716.8 3753.2 9306.0 9724.0 9808.8 9808.8 9819.9 9658.4 9675.4 9679.9 9682.4 9687.1 6987.3 7461.5 7467.2 7499.6 7501.6 5148.7 5242.3 5266.2 5378.7 5463.2 8931.7 9009.5 9034.2 9107.6 9135.6 8999.1 9160.3 9245.7 9275.9 9367.0 5727.8 5910.2 6053.0 6185.3 6240.5 7531.5 7579.2 7639.4 7645.0 7646.6 6539.1 6772.6 6811.4 6846.6 6908.1 6516.8 6539.8 6696.7 6742.4 6773.9 6154.3 6184.4 6245.0 6245.8 6246.5 4477.8 4577.6 4626.2 4695.2 4820.6 4528.9 4601.8 4715.6 4770.7 4799.2 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | [#4] prototype.html Cycles:180 Average:4111.30 Median:4576.52 stddev:1192.69 (26.1%) stddev-sans-first:1160.86 19:29:59 INFO - PROCESS | 4931 | Values: 280.4 288.1 295.7 299.6 300.2 4757.9 4795.6 4797.4 4801.0 4801.1 4501.9 4550.2 4562.8 4746.4 4760.0 3748.2 3784.4 3804.5 3810.2 3810.3 3791.4 3795.8 3800.2 3811.1 3814.2 3574.3 3655.8 3776.3 3777.3 3778.4 3743.7 3750.8 3755.9 3775.8 3777.9 3333.4 3333.6 3360.2 3365.8 3378.3 4333.6 4532.1 4561.6 4571.9 4574.4 4261.8 4286.6 4324.8 4324.9 4328.0 4977.3 4978.3 4987.9 4991.9 5007.7 3670.4 3671.2 3673.5 3683.5 3706.6 5044.8 5158.4 5167.8 5176.4 5181.3 3713.6 3746.5 3748.6 3758.4 3764.3 3809.8 3813.2 3824.8 3831.5 3844.4 4005.3 4239.1 4278.9 4322.5 4326.0 4968.2 4971.6 4979.3 4990.7 5009.4 1216.5 1250.0 1256.9 1275.7 1283.1 812.7 824.2 825.5 834.9 839.8 3853.6 3922.5 3946.4 3976.5 3983.0 4510.9 4565.4 4565.7 4578.7 4594.0 3860.8 3869.4 3952.3 3955.5 3977.5 2400.3 2423.5 2544.9 2728.2 2749.6 4842.2 4874.3 4875.1 4881.4 4887.9 5265.2 5268.5 5275.1 5276.3 5287.8 4650.6 4795.5 4829.4 4843.8 4889.3 5099.2 5112.6 5120.8 5133.8 5190.7 4997.0 5066.0 5093.7 5096.3 5096.8 4717.3 4721.8 4834.1 4847.8 4870.2 3539.9 3554.5 3578.3 3585.1 3597.9 4970.4 5144.1 5155.7 5157.9 5195.0 4862.0 4951.2 4969.2 4971.6 5001.6 4871.0 4959.0 4960.2 5001.2 5016.8 4792.3 4833.9 4913.2 4915.9 4934.1 5019.6 5024.2 5053.2 5054.0 5054.7 4842.9 4862.9 4924.1 4933.4 4945.7 19:29:59 INFO - PROCESS | 4931 | 19:29:59 INFO - PROCESS | 4931 | [#5] yui.html Cycles:180 Average:12869.03 Median:44401.55 stddev:14772.60 (33.3%) stddev-sans-first:14785.58 19:29:59 INFO - PROCESS | 4931 | Values: 658.2 677.5 700.5 700.6 708.3 12154.4 12549.2 12578.2 12944.8 12949.2 12447.5 12516.8 12577.2 12578.4 12580.2 631.7 790.1 808.6 821.1 821.2 806.5 816.1 816.4 817.7 817.9 852.9 857.5 857.8 858.0 858.5 655.5 815.2 836.6 848.4 853.1 608.8 612.2 612.3 612.5 613.1 12157.5 12157.8 12389.9 12459.8 12492.3 11427.6 11492.9 11763.4 11939.6 12583.5 10136.7 10288.4 11376.1 11408.7 11517.3 3299.3 3321.5 3323.8 3422.4 3465.2 40832.6 42611.0 43040.6 46168.5 46650.0 9807.0 9844.4 9859.8 9911.7 10281.9 16557.1 17094.8 17142.3 17217.1 17220.2 6686.4 6719.3 6828.0 6848.4 6852.5 3579.7 3611.5 3628.4 3661.7 3704.7 2731.9 2815.1 2818.3 2819.3 2820.7 499.6 517.3 521.2 522.3 553.9 479.3 585.6 586.4 591.2 607.5 7680.5 7762.2 7851.7 7945.7 7956.8 459.7 467.5 510.9 546.3 555.7 3596.1 3599.2 3601.1 3603.4 3673.9 53210.5 54293.5 54345.2 54418.5 54421.0 47456.8 48294.3 48446.5 48987.0 49553.0 43624.0 44190.8 44612.3 44987.3 45356.8 7367.5 7388.6 7397.6 7434.8 7442.6 28681.7 29118.3 29706.9 31371.8 31485.7 38510.2 38794.0 39205.0 39405.4 40741.8 10460.8 10470.2 10531.2 10634.5 10897.1 11275.8 11313.2 11433.3 11540.4 11624.8 10749.9 10963.7 11090.9 11437.0 11606.9 11073.2 11185.7 11665.0 11668.4 11682.4 10733.8 10901.9 11269.9 11462.7 11476.5 8774.5 8831.1 8899.6 8955.8 9119.2 8917.2 9033.5 9128.8 9266.3 9416.4 19:29:59 INFO - PROCESS | 4931 | -------- Summary: end -------- 19:29:59 INFO - PROCESS | 4931 | 19:30:00 INFO - TEST-INFO | 4931: exit 0 19:30:00 INFO - TEST-OK | dromaeo_css | took 1118257ms 19:30:00 INFO - TEST-START | kraken 19:30:00 INFO - operating with platform_type : linux_ 19:30:00 INFO - Initialising browser for kraken test... 19:30:00 INFO - TEST-INFO | started process 5113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI8Eac8/profile http://localhost:55438/getInfo.html) 19:30:04 INFO - PROCESS | 5113 | __metrics Screen width/height:1600/1200 19:30:04 INFO - PROCESS | 5113 | colorDepth:24 19:30:04 INFO - PROCESS | 5113 | Browser inner width/height: 1024/697 19:30:04 INFO - PROCESS | 5113 | __metrics 19:30:05 ERROR - PROCESS | 5113 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:30:06 INFO - TEST-INFO | 5113: exit 0 19:30:06 INFO - Browser initialized. 19:30:06 INFO - Running cycle 1/1 for kraken test... 19:30:06 INFO - TEST-INFO | started process 5195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI8Eac8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:18 INFO - PROCESS | 5195 | RSS: Main: 154701824 19:30:18 INFO - PROCESS | 5195 | 19:30:21 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:22 INFO - PROCESS | 5195 | RSS: Main: 210616320 19:30:22 INFO - PROCESS | 5195 | 19:30:25 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-dft) 19:30:26 INFO - PROCESS | 5195 | RSS: Main: 199065600 19:30:26 INFO - PROCESS | 5195 | 19:30:29 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-fft) 19:30:30 INFO - PROCESS | 5195 | RSS: Main: 267804672 19:30:30 INFO - PROCESS | 5195 | 19:30:32 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-oscillator) 19:30:32 INFO - PROCESS | 5195 | RSS: Main: 176922624 19:30:32 INFO - PROCESS | 5195 | 19:30:35 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:35 INFO - PROCESS | 5195 | RSS: Main: 180047872 19:30:35 INFO - PROCESS | 5195 | 19:30:39 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:39 INFO - PROCESS | 5195 | RSS: Main: 216371200 19:30:39 INFO - PROCESS | 5195 | 19:30:43 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:44 INFO - PROCESS | 5195 | RSS: Main: 214999040 19:30:44 INFO - PROCESS | 5195 | 19:30:47 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55438/tests/kraken/driver.html?testName=json-parse-financial) 19:30:47 INFO - PROCESS | 5195 | RSS: Main: 215748608 19:30:47 INFO - PROCESS | 5195 | 19:30:49 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:50 INFO - PROCESS | 5195 | RSS: Main: 208179200 19:30:50 INFO - PROCESS | 5195 | 19:30:52 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:52 INFO - PROCESS | 5195 | RSS: Main: 212619264 19:30:52 INFO - PROCESS | 5195 | 19:30:55 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:55 INFO - PROCESS | 5195 | RSS: Main: 216981504 19:30:55 INFO - PROCESS | 5195 | 19:30:58 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:59 INFO - PROCESS | 5195 | RSS: Main: 220065792 19:30:59 INFO - PROCESS | 5195 | 19:31:02 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:02 INFO - PROCESS | 5195 | RSS: Main: 219103232 19:31:02 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55438/tests/kraken/driver.html?testName=ai-astar) 19:31:04 INFO - PROCESS | 5195 | RSS: Main: 266141696 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | __start_tp_report 19:31:04 INFO - PROCESS | 5195 | _x_x_mozilla_page_load 19:31:04 INFO - PROCESS | 5195 | _x_x_mozilla_page_load_details 19:31:04 INFO - PROCESS | 5195 | |i|pagename|runs| 19:31:04 INFO - PROCESS | 5195 | |0;ai-astar;115;109;116;114;114;114;114;113;114;114 19:31:04 INFO - PROCESS | 5195 | |1;audio-beat-detection;162;133;160;207;132;168;164;135;192;134 19:31:04 INFO - PROCESS | 5195 | |2;audio-dft;162;160;162;159;162;161;161;161;161;160 19:31:04 INFO - PROCESS | 5195 | |3;audio-fft;74;76;77;144;75;76;77;76;138;76 19:31:04 INFO - PROCESS | 5195 | |4;audio-oscillator;94;93;165;92;94;93;125;93;95;137 19:31:04 INFO - PROCESS | 5195 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;117 19:31:04 INFO - PROCESS | 5195 | |6;imaging-darkroom;146;146;146;147;146;146;146;147;146;146 19:31:04 INFO - PROCESS | 5195 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;94;95 19:31:04 INFO - PROCESS | 5195 | |8;json-parse-financial;63;64;64;64;65;65;63;65;63;65 19:31:04 INFO - PROCESS | 5195 | |9;json-stringify-tinderbox;65;66;64;65;67;66;65;66;65;65 19:31:04 INFO - PROCESS | 5195 | |10;stanford-crypto-aes;83;83;82;82;82;81;83;83;161;83 19:31:04 INFO - PROCESS | 5195 | |11;stanford-crypto-ccm;134;132;138;130;147;127;129;130;146;132 19:31:04 INFO - PROCESS | 5195 | |12;stanford-crypto-pbkdf2;177;172;176;173;173;172;171;175;177;172 19:31:04 INFO - PROCESS | 5195 | |13;stanford-crypto-sha256-iterative;66;68;67;66;66;64;65;66;66;65 19:31:04 INFO - PROCESS | 5195 | __end_tp_report 19:31:04 INFO - PROCESS | 5195 | __start_cc_report 19:31:04 INFO - PROCESS | 5195 | _x_x_mozilla_cycle_collect,2114 19:31:04 INFO - PROCESS | 5195 | __end_cc_report 19:31:04 INFO - PROCESS | 5195 | __startTimestamp1463711464958__endTimestamp 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | ------- Summary: start ------- 19:31:04 INFO - PROCESS | 5195 | Number of tests: 14 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.83 (1.6%) stddev-sans-first:1.88 19:31:04 INFO - PROCESS | 5195 | Values: 115.0 109.0 116.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#1] audio-beat-detection Cycles:10 Average:158.70 Median:163.00 stddev:26.06 (16.0%) stddev-sans-first:27.62 19:31:04 INFO - PROCESS | 5195 | Values: 162.0 133.0 160.0 207.0 132.0 168.0 164.0 135.0 192.0 134.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 19:31:04 INFO - PROCESS | 5195 | Values: 162.0 160.0 162.0 159.0 162.0 161.0 161.0 161.0 161.0 160.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#3] audio-fft Cycles:10 Average:88.90 Median:76.00 stddev:27.51 (36.2%) stddev-sans-first:28.64 19:31:04 INFO - PROCESS | 5195 | Values: 74.0 76.0 77.0 144.0 75.0 76.0 77.0 76.0 138.0 76.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:25.54 (27.5%) stddev-sans-first:26.58 19:31:04 INFO - PROCESS | 5195 | Values: 94.0 93.0 165.0 92.0 94.0 93.0 125.0 93.0 95.0 137.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:31:04 INFO - PROCESS | 5195 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 19:31:04 INFO - PROCESS | 5195 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:31:04 INFO - PROCESS | 5195 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.83 19:31:04 INFO - PROCESS | 5195 | Values: 63.0 64.0 64.0 64.0 65.0 65.0 63.0 65.0 63.0 65.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 19:31:04 INFO - PROCESS | 5195 | Values: 65.0 66.0 64.0 65.0 67.0 66.0 65.0 66.0 65.0 65.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:83.00 stddev:24.85 (29.9%) stddev-sans-first:26.22 19:31:04 INFO - PROCESS | 5195 | Values: 83.0 83.0 82.0 82.0 82.0 81.0 83.0 83.0 161.0 83.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:133.00 stddev:7.00 (5.3%) stddev-sans-first:7.42 19:31:04 INFO - PROCESS | 5195 | Values: 134.0 132.0 138.0 130.0 147.0 127.0 129.0 130.0 146.0 132.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:2.25 (1.3%) stddev-sans-first:2.07 19:31:04 INFO - PROCESS | 5195 | Values: 177.0 172.0 176.0 173.0 173.0 172.0 171.0 175.0 177.0 172.0 19:31:04 INFO - PROCESS | 5195 | 19:31:04 INFO - PROCESS | 5195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 19:31:04 INFO - PROCESS | 5195 | Values: 66.0 68.0 67.0 66.0 66.0 64.0 65.0 66.0 66.0 65.0 19:31:04 INFO - PROCESS | 5195 | -------- Summary: end -------- 19:31:04 INFO - PROCESS | 5195 | 19:31:05 INFO - TEST-INFO | 5195: exit 0 19:31:06 INFO - TEST-OK | kraken | took 65869ms 19:31:06 INFO - SUITE-END | took 1184s 19:31:06 INFO - Completed test suite (00:19:44) 19:31:06 INFO - javascript benchmark 19:31:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.709301976782, 2651.920442386729, 2684.6375739275204, 2686.3955609987747, 2693.2189664997154, 4594.908101837966, 4613.400257966459, 4661.860144195671, 4666.976665116674, 4720.551547602977, 4676.111538807624, 4697.2954056891485, 4704.741239231841, 4731.526847315266, 4739.786709598067, 4144.6684265258855, 4245.108527209282, 4369.825206991716, 4382.452193475816, 4505.346724724913, 4407.096545208241, 4442.777861106948, 4454.97772511137, 4469.307257375112, 4502.3696682464315, 4244.3209086546, 4272.273713468718, 4291.35629655551, 4302.376155457441, 4325.286327755916, 4321.438213032317, 4330.7401555906745, 4339.175556644227, 4361.672874534423, 4375.234333991571, 4395.670324725626, 4403.933940990888, 4413.757243351614, 4416.2713152329825, 4447.110577884404, 4539.251023581105, 4566.995261042599, 4591.977040114812, 4596.724196548218, 4611.723296602181, 5043.0, 5055.5702765265, 5073.061483625541, 5095.439501654815, 5096.261042148868, 5112.872178195575, 5142.897142057175, 5154.819581314636, 5157.8452646420665, 5180.119379705459, 4600.056988317387, 4712.976435117803, 4766.880827979328, 4770.475247722748, 4798.328234047236, 5222.373315202124, 5240.266362709223, 5260.736963151827, 5305.920411193835, 5328.520433160957, 4849.248366503198, 5035.093683137071, 5074.543291103744, 5098.898022039539, 5103.055934652101, 4978.6017118630425, 5019.949800501949, 5030.170021946338, 5046.6719663221775, 5080.212567052113, 5016.698998060128, 5017.197248440232, 5019.14674505335, 5023.296738456619, 5051.747412629354, 4885.169521181337, 4912.508749125059, 5012.699238045729, 5012.774425150877, 5023.598112151019, 4281.743095414286, 4298.4197133387215, 4302.139572085595, 4330.783460826946, 4333.826646934151, 3728.3475391806323, 3732.3654978653694, 3754.568224654145, 3783.375743002374, 3797.0697179190724, 4225.9788701056295, 4252.978735106367, 4268.765217913045, 4304.569543045671, 4323.978380108142, 5023.497650234947, 5066.493350664904, 5068.062408454448, 5072.923906141411, 5126.92309615356, 4280.058387154821, 4330.328799036154, 4330.7401555906745, 4374.759388233678, 4377.78111094444, 4489.281714925596, 4489.5959363656775, 4520.299353600197, 4541.931871021938, 4550.567696068868, 4708.81164753406, 4729.243321068612, 4730.1958667026, 4762.095201911695, 4776.737279449663, 5010.123228434936, 5025.623078269071, 5027.296178534935, 5043.394792624908, 5078.949210507995, 4628.884277892945, 4639.953600463952, 4698.92951605733, 4704.482506924304, 4719.032598317405, 4884.755762211804, 4904.509549045067, 4908.9754551227015, 4918.409790825124, 4962.330085438564, 4946.480619535041, 4975.5522003019905, 4975.850724478271, 5003.199488081889, 5042.899142017212, 4798.376211092535, 4855.101806165871, 4880.389951256093, 4901.191303434894, 4928.753562321941, 4901.240307752304, 4905.622888933013, 4910.631702622389, 4912.803487860446, 4966.602671786176, 4677.438707355003, 4847.248676455155, 4849.80600775965, 4894.363732714724, 4903.068417000758, 4885.218365061573, 4944.208926571731, 4944.53026962438, 4968.180250258812, 4970.080535101018, 4850.854474365775, 4879.243717223836, 4887.462379138363, 4898.510148985073, 4934.777934992862], "value": 4630.795057877731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9600327977041, 591.0572636644551, 600.495583709684, 607.9665618390986, 609.3632154398653, 27380.589291160624, 39969.80015099924, 40915.38626920595, 41280.38079428811, 44227.77886110573, 38134.237315253675, 38183.618163818355, 38199.0, 38260.23479530408, 38495.61504384955, 7699.153093159748, 7839.059312882462, 7887.684492620288, 7895.24995125465, 7897.368210543172, 7709.922900771005, 7806.5316081035035, 7827.412944029221, 7836.529808211497, 7837.960810195969, 7782.105057918327, 7813.843723125534, 7832.530048197098, 7834.608269586498, 7838.686452541891, 7760.961195194044, 7804.570748608824, 7810.921890781076, 7816.6873325066645, 7823.139454659983, 7683.847422886612, 7777.494462859896, 7790.415718821111, 7791.961040194763, 7793.922060779433, 37786.244275114346, 38119.618803811885, 38153.42769858454, 38170.809145954096, 38218.80890595557, 2991.2671395508023, 3091.7681173912047, 3181.220600952758, 3241.675832416763, 3294.7364210863075, 28604.856975715196, 28754.137375878756, 28811.71188288132, 29459.852700736574, 29484.852575737197, 3529.9674348074827, 3535.3106144301873, 3546.1666508370513, 3548.556430446194, 3594.5506811648543, 267586.0, 271240.0, 271306.999999998, 272088.0, 272274.0, 51975.0, 52199.73900130551, 52377.33358664857, 52390.47609523856, 52411.0, 40229.19541609151, 41465.58534414678, 55179.0, 56794.14808777872, 56920.715396423584, 12169.391530423443, 12215.694607634703, 12319.014478841671, 12323.0, 12356.073294502949, 8711.303095752324, 10355.0, 10423.322484038514, 10434.947825260826, 10438.0, 15404.306806193748, 15693.686126277411, 15859.127747973742, 16044.919775401047, 16079.196040197943, 6272.8118156455375, 6381.680915954184, 6418.26189988148, 6525.2169739631545, 6554.004114979717, 856.4347530629755, 936.9344145909721, 988.8813342398959, 1065.7815147894662, 1069.978600427987, 28139.71860281412, 28252.293692657437, 28465.10335519846, 28676.283092922844, 28711.56932646012, 975.453745902297, 988.9703308900745, 989.7129832348538, 1003.6637726361605, 1005.939643621385, 14177.78733319001, 14338.928305358406, 14383.78424323636, 14580.854191458162, 14586.562403127711, 385190.0, 390399.0, 393847.0, 394102.0, 394487.0, 48642.5135748638, 48762.5123748765, 48799.0, 48837.26744098841, 48844.7557762216, 1109.57836022311, 1215.4348228073989, 1227.3617718786359, 1261.5521489871146, 1305.3081866610712, 27219.319517012234, 28356.574651379833, 28974.27564310909, 29069.563956540245, 29319.85340073286, 40551.1889762209, 41185.0, 41431.37852932269, 41448.3782743253, 41457.1708565833, 310295.0, 310720.0, 311128.0, 311859.0, 312518.0, 21652.35042948714, 23780.643290350312, 24841.378965526008, 24858.25425237246, 25750.227493175236, 40516.3922541168, 40545.0, 40644.39033414442, 40901.0, 41400.58599413967, 34606.82696586501, 35108.0, 35522.28955420929, 35783.284334312644, 36252.456213157355, 35244.823775880956, 35374.823125884206, 35574.466383004794, 35932.64067359293, 35940.46089308715, 34363.82818085894, 34817.47773783345, 35124.140412601584, 35208.47187292244, 35428.114297142776, 30496.237594060327, 31668.683313166573, 31673.5248971261, 31705.002846498475, 31777.20556986094, 24119.63820542658, 25837.354066148495, 25839.095631652803, 25974.35064123412, 26185.869070654524], "value": 17262.75026777865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1344763767155, 380.4407520944211, 385.7473354952506, 390.1183325683953, 396.85911501416996, 15677.0, 16686.249118789652, 17042.488725338244, 17188.914055429705, 17195.570110747238, 15820.208989550505, 16694.0, 16731.247093880804, 16795.160241987884, 16806.075665838373, 5068.2651015602805, 5264.184051472009, 5274.393444753845, 5280.1815718563685, 5316.388615309231, 3722.8138593070375, 3951.0714981979213, 5823.184754134425, 6143.354947730491, 6150.50795936324, 6104.96947515264, 6186.381361863822, 6194.81415557534, 6211.130441738161, 6221.906671399933, 6065.969670151665, 6162.476189523896, 6202.658853763041, 6203.2866220384785, 6209.9068513972325, 3408.454647256452, 5109.233614957749, 5412.729363531807, 5418.864528386822, 5500.50495455411, 20390.388288351372, 20399.388018359474, 20656.070476828427, 20923.953802309978, 20957.371278861658, 1826.9817301826945, 2089.9059542320633, 2528.380546766054, 2550.5919052951626, 2562.0520407449176, 12980.28608426536, 13170.736585268241, 13250.093644649769, 13292.401841917137, 13763.0, 1811.610503741702, 2044.2845004248543, 2108.135664377598, 2117.390783004912, 2159.2442645074257, 75377.62311188463, 79231.60384198099, 81140.59429702873, 83114.0, 85310.0, 16405.0, 16429.58926026835, 16433.506994790176, 16467.83532164687, 16525.504234872973, 29776.0, 29948.95178668736, 30131.69868301333, 30289.24276893095, 30411.543826842615, 8299.668013279523, 8771.473711577326, 8821.382503224713, 8855.33584981129, 8905.243054340324, 6936.861262774817, 7019.087518622547, 7034.537911730853, 7075.327843854826, 7136.571805691675, 8257.174282571696, 8482.915170848213, 8520.14798520143, 8545.487270763773, 8580.356473264404, 2632.6577544919037, 3244.4484437645656, 3329.417351963445, 3518.7712798668003, 3532.1699400640828, 673.5419914458117, 749.1010787055556, 754.5321900421774, 821.359329754841, 933.206774241889, 16997.575060623585, 17021.40425085116, 17061.317547297967, 17550.122493875257, 17559.12204389801, 840.5251033166242, 852.424613385962, 866.787637028932, 884.027569673367, 927.9536023198813, 9345.532723363805, 9749.512524373753, 9778.217742580577, 9791.755206119904, 9930.851037234448, 387828.0, 391211.0, 395813.0, 397345.0, 407443.0, 80724.0, 80831.59584202159, 81552.0, 83564.16435835685, 83981.0, 881.1716986033108, 891.892972843263, 902.5622573052065, 925.3615005646217, 926.6571368593663, 15132.167730774912, 15319.0, 15390.461333853262, 15466.458673946358, 15760.60598485047, 28964.13107606775, 35388.39950806378, 35507.46738798972, 35855.28289434144, 37033.259334813694, 50192.0, 50229.74885125551, 50498.0, 51126.23310650269, 51570.22644660258, 6571.57284776488, 6824.829379265558, 7004.964975175091, 7761.0, 8206.58967051657, 7673.439393036525, 10476.947615261875, 10478.685639430829, 10548.103411210133, 11107.777844443228, 9887.752806179904, 9957.850632240667, 10141.188704903738, 10194.592216311265, 10280.126189273995, 9383.812323753351, 9705.417674939526, 9806.872209695975, 10077.344972576759, 10290.12533934624, 9510.572024258787, 9738.123568878835, 9787.16809071237, 10089.091981721387, 10487.528061237415, 7606.20134885829, 7679.808004799925, 7851.175626559358, 7851.450398472052, 7945.324647405036, 9634.325597208408, 9848.359856609584, 9868.457234852152, 10121.089101980857, 10420.68737937863], "value": 9026.640865296378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.60301306595, 1419.3329135306406, 1459.5402448228808, 1579.8341174176712, 1779.9854083172588, 7433.0, 7773.922260777397, 7775.183605721402, 7976.441649084566, 7988.92011079889, 7711.0, 7863.8427231455335, 7869.331106855924, 7872.01599800025, 7877.842443151134, 2209.635410157326, 2233.0955962834996, 2235.552889422114, 2239.0372139979804, 2239.317008312464, 2195.5169862630196, 2217.390217690132, 2225.098834971839, 2228.832837537183, 2234.4748983988748, 2176.6843807647883, 2202.9779702203014, 2216.024949022425, 2216.26863135165, 2244.551089782042, 2125.2774056820676, 2132.0618927671853, 2141.8714877107423, 2145.9356219313445, 2151.139544182332, 2112.852100352976, 2151.3868547464053, 2152.1714140056033, 2156.70884430603, 2157.061678170001, 7693.884591731128, 7714.845703085907, 7780.221977802231, 7789.883151752728, 7888.842223155505, 4418.469783625953, 4519.932201016987, 4532.954670453286, 4533.410656614652, 4535.637149028103, 2888.653361596601, 2893.6382952130984, 2935.853207339646, 2947.911562653124, 2977.970220297791, 869.0831173112364, 875.5797217335651, 904.2359206470522, 907.1246247371253, 924.2051835421532, 10517.63188288414, 10614.840777388268, 10648.946755266252, 10653.201009924209, 10654.893451065467, 4052.5339585947995, 4108.815103320358, 4176.331786914079, 4179.644730197906, 4181.121964387513, 7897.842043159219, 7940.444168908121, 7977.521348719096, 7994.920050799534, 7999.9600001999615, 4378.5183629800695, 4379.5401482843845, 4415.40392047076, 4428.4243048403505, 4433.0, 3637.5634923808784, 4035.1727895781296, 4056.0671045659665, 4130.814113364906, 4190.643795277375, 3460.3598334308235, 3465.86136554535, 3518.7009104226427, 3544.5392099026963, 3657.7805331680183, 1008.7175590834578, 1012.6000229909292, 1018.6485662446444, 1031.4945676618554, 1050.1808589300358, 727.9818004549822, 849.2696281198165, 853.8217260181035, 857.1985193843776, 862.6420035685246, 5116.846494605168, 5237.319148510669, 5243.4232234454175, 5245.6852588844795, 5333.919991200135, 393.86805420183987, 394.43595658208466, 400.5453809925697, 405.59237965844136, 415.5532802237546, 3674.393725035393, 3690.2619476104887, 3713.4801127842125, 3716.7769933804057, 3753.211825516672, 9306.0, 9724.0, 9808.803823923481, 9808.803823923481, 9819.901800982041, 9658.3722058066, 9675.371100878421, 9679.9032009679, 9682.419054856731, 9687.128158465772, 6987.301269872972, 7461.477696561188, 7467.215942326086, 7499.587522686195, 7501.62491875415, 5148.6910785353, 5242.318498595158, 5266.236395722675, 5378.650387724785, 5463.235147079333, 8931.687390941286, 9009.459432434074, 9034.232090272137, 9107.590158442754, 9135.58889849945, 8999.100089990949, 9160.31297652692, 9245.676401325922, 9275.907240927505, 9367.0, 5727.770889164387, 5910.172575839472, 6053.0, 6185.257769067741, 6240.469560087444, 7531.510451820614, 7579.204183560647, 7639.350655194371, 7644.961775191088, 7646.579438130956, 6539.084528165966, 6772.55978361405, 6811.421029212573, 6846.5892046477375, 6908.1364829396325, 6516.771912983023, 6539.771108011197, 6696.732130714717, 6742.359475849787, 6773.93226067733, 6154.261488621394, 6184.412480814315, 6244.968775156095, 6245.843853903689, 6246.5002799775, 4477.753723545236, 4577.633789296915, 4626.1904166771355, 4695.225287827607, 4820.6143508518535, 4528.932066018947, 4601.849537615596, 4715.599174070106, 4770.666053376231, 4799.208130658542], "value": 4012.2781961680535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.4363229907886, 288.13990239136183, 295.6945087438957, 299.58357882543254, 300.17751361270115, 4757.857264282077, 4795.640326975477, 4797.400324959376, 4800.975995120024, 4801.135795556798, 4501.909961800762, 4550.180967425862, 4562.84030058948, 4746.359241502396, 4759.976605029918, 3748.231612519427, 3784.375578029622, 3804.5434547854156, 3810.19985802981, 3810.2569998850236, 3791.4123310886857, 3795.8043216386886, 3800.1639639279315, 3811.1234416084317, 3814.2263847310996, 3574.338747331739, 3655.817209139546, 3776.30138424391, 3777.263433630443, 3778.3576791945434, 3743.6630703236838, 3750.849966001384, 3755.906102347436, 3775.754575952554, 3777.8866634001024, 3333.383324085052, 3333.599968003831, 3360.22714775603, 3365.848536815849, 3378.341223461426, 4333.609975102256, 4532.116237333721, 4561.566651168134, 4571.9314210286875, 4574.382458368144, 4261.829526818923, 4286.635635970946, 4324.783760811947, 4324.913501729948, 4328.0, 4977.253411988195, 4978.303037574742, 4987.850364489072, 4991.900161996739, 5007.749612519359, 3670.4310831821113, 3671.1556342041213, 3673.4673472346362, 3683.4658974448553, 3706.5737440194453, 5044.798208071673, 5158.38099428071, 5167.819126330561, 5176.404713457963, 5181.274621552986, 3713.6472035156617, 3746.494223279822, 3748.6251374862295, 3758.361078616642, 3764.303603833245, 3809.847606095725, 3813.2182902505474, 3824.7569539899646, 3831.4635950966886, 3844.4233364995475, 4005.2790497710694, 4239.0885959518855, 4278.893027674333, 4322.508734486597, 4325.956740432618, 4968.168144157868, 4971.552560269521, 4979.30289759434, 4990.650654454226, 5009.423916249605, 1216.5498765456837, 1249.9875001250052, 1256.9497220111275, 1275.7384736129072, 1283.1018287199, 812.6586833529932, 824.2334628795278, 825.455199568294, 834.9165083491603, 839.8446287436843, 3853.5953724859046, 3922.4508568800393, 3946.3883098119836, 3976.522817261889, 3982.960170398259, 4510.909781804346, 4565.406497155349, 4565.703229290086, 4578.65660075489, 4594.036846234227, 3860.845566177378, 3869.4389313549377, 3952.320263887894, 3955.5253369595257, 3977.5226972762875, 2400.2679182849397, 2423.503181847717, 2544.9363765906, 2728.249731323902, 2749.628800111999, 4842.15262329091, 4874.341963834837, 4875.146849301429, 4881.365422495053, 4887.90022244992, 5265.157574788015, 5268.525832675077, 5275.072334854116, 5276.287701160371, 5287.814926477555, 4650.604698600657, 4795.472498025214, 4829.4204695437475, 4843.782029808737, 4889.315495830587, 5099.209622508517, 5112.565431938327, 5120.771014956458, 5133.794648214179, 5190.662606930538, 4996.975015124901, 5065.973610555659, 5093.733288686499, 5096.286519887293, 5096.796128154832, 4717.292406139107, 4721.7756185943035, 4834.081524510332, 4847.781849816837, 4870.172070747911, 3539.9469007965417, 3554.4845997329726, 3578.3380074686265, 3585.1395665040723, 3597.874074407383, 4970.353853998957, 5144.099782537966, 5155.742212889266, 5157.896842063213, 5195.0, 4861.975690121527, 4951.207806750903, 4969.180085285887, 4971.627127965345, 5001.57486613642, 4870.9770948101295, 4958.950410495849, 4960.181570040902, 5001.174806156943, 5016.824411145738, 4792.281157826354, 4833.9274910875665, 4913.238448040416, 4915.901681966412, 4934.149693864801, 5019.573336266459, 5024.246363045572, 5053.2420136979745, 5053.974730126326, 5054.721990290569, 4842.903141937212, 4862.878428039186, 4924.138275801792, 4933.407991040955, 4945.703257804544], "value": 3730.5253761012495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.2331583704984, 677.4918810891829, 700.4571457120734, 700.6391708270245, 708.2987842036384, 12154.392280385979, 12549.184303020298, 12578.182418142815, 12944.834964853162, 12949.223046617199, 12447.502099916015, 12516.812247816268, 12577.182483138613, 12578.371081445937, 12580.24518528889, 631.7251995382023, 790.1466416270414, 808.5997431271514, 821.0844907927648, 821.195228675898, 806.5241507510567, 816.0696805641544, 816.3550794872044, 817.7342363731811, 817.8773184022385, 852.9061803201643, 857.4897935728231, 857.7984173719202, 857.9828403431927, 858.5149390594325, 655.4952686431421, 815.2051749544206, 836.619338201117, 848.4188330993259, 853.1468531468531, 608.8051823416508, 612.1735656863243, 612.2958597612736, 612.5038718637918, 613.1140501974648, 12157.51369945201, 12157.817632735427, 12389.946854517286, 12459.75080498394, 12492.312922789242, 11427.60845968174, 11492.942535287353, 11763.411829408495, 11939.641810745692, 12583.496660133675, 10136.746581335525, 10288.382697038127, 11376.089912806956, 11408.657740267723, 11517.251378660443, 3299.290652509722, 3321.501774733785, 3323.7839540429795, 3422.401079811023, 3465.220325426784, 40832.591674083174, 42611.0, 43040.56959430428, 46168.53831461676, 46650.0, 9807.0, 9844.3601165924, 9859.753506162404, 9911.702648920544, 10281.948590257001, 16557.08936008507, 17094.829051709574, 17142.314307427565, 17217.139143042798, 17220.225089870986, 6686.364795344434, 6719.328067193339, 6828.0, 6848.417884479775, 6852.45180385568, 3579.6957258632788, 3611.476335931275, 3628.4194528875782, 3661.6704496595435, 3704.7221458390727, 2731.8907243710028, 2815.127310533741, 2818.3236023354248, 2819.323362393052, 2820.7461328480535, 499.5878400319751, 517.3300575754407, 521.2285816990799, 522.334024119251, 553.8836844262669, 479.297828680984, 585.6134950932365, 586.355009489558, 591.2136857978878, 607.480604083511, 7680.500767450098, 7762.184970578121, 7851.685932562634, 7945.682172713026, 7956.801079972931, 459.71267957526544, 467.53947361848554, 510.8824970256862, 546.3471151973433, 555.7276934302163, 3596.0650230939623, 3599.208174201671, 3601.1177261571083, 3603.4234522476277, 3673.8530458781884, 53210.46789532132, 54293.45706542884, 54345.1848222277, 54418.45581544213, 54421.0, 47456.76271618689, 48294.27558586624, 48446.5155348442, 48987.0, 49553.0, 43624.0, 44190.779046104566, 44612.3308150378, 44987.325190122174, 45356.77321613437, 7367.484276100621, 7388.556686598821, 7397.630118493946, 7434.8411629565335, 7442.553446793209, 28681.713182868738, 29118.27204319909, 29706.851465742533, 31371.84314078415, 31485.685143148276, 38510.22979540337, 38794.0, 39205.0, 39405.408918866815, 40741.79629101954, 10460.843087353544, 10470.21473389514, 10531.157507399543, 10634.468276586294, 10897.073748731447, 11275.7744845101, 11313.151513636674, 11433.253059907081, 11540.422978851191, 11624.767504650028, 10749.89250107489, 10963.671089867317, 11090.889091109308, 11437.0, 11606.94196529012, 11073.224874258725, 11185.72035699114, 11665.0, 11668.416579170838, 11682.415879205835, 10733.785324293627, 10901.890981090088, 11269.943650281695, 11462.656120316404, 11476.540938362372, 8774.540440264685, 8831.072737362485, 8899.644014239617, 8955.820883582423, 9119.224865886474, 8917.242034427147, 9033.50315732641, 9128.771780705536, 9266.305027123128, 9416.435013898914], "value": 5881.695594280661, "unit": "score"}], "name": "dromaeo_css", "value": 6316.861956490811, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 116.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 160.0, 207.0, 132.0, 168.0, 164.0, 135.0, 192.0, 134.0], "value": 158.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 159.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 144.0, 75.0, 76.0, 77.0, 76.0, 138.0, 76.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 165.0, 92.0, 94.0, 93.0, 125.0, 93.0, 95.0, 137.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 65.0, 63.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 83.0, 83.0, 161.0, 83.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 138.0, 130.0, 147.0, 127.0, 129.0, 130.0, 146.0, 132.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 176.0, 173.0, 173.0, 172.0, 171.0, 175.0, 177.0, 172.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 66.0, 64.0, 65.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1582.0, "alertThreshold": 2.0}]} 19:31:06 INFO - Return code: 0 19:31:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:31:06 ERROR - # TBPL SUCCESS # 19:31:06 INFO - Running post-action listener: _resource_record_post_action 19:31:06 INFO - ##### 19:31:06 INFO - ##### Finished run-tests step (success) 19:31:06 INFO - ##### 19:31:06 INFO - Running post-run listener: _resource_record_post_run 19:31:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 300806144; Read time: 0; Write time: 311416 19:31:06 INFO - TinderboxPrint: CPU usage
13.1% 19:31:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:31:06 INFO - TinderboxPrint: I/O write bytes / time
300,806,144 / 311,416 19:31:06 INFO - TinderboxPrint: CPU idle
8,328.5 (86.9%) 19:31:06 INFO - TinderboxPrint: CPU user
1,213.1 (12.7%) 19:31:06 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13713408; Read time: 0; Write time: 4208 19:31:06 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 287092736; Read time: 0; Write time: 307208 19:31:06 INFO - Running post-run listener: _upload_blobber_files 19:31:06 INFO - Blob upload gear active. 19:31:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:06 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 19:31:06 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'] 19:31:06 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 19:31:07 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:08 INFO - (blobuploader) - INFO - Done attempting. 19:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:11 INFO - (blobuploader) - INFO - Done attempting. 19:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:12 INFO - (blobuploader) - INFO - Done attempting. 19:31:12 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:12 INFO - Return code: 0 19:31:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad5dd195a6ab7251c410fb5e1c565ba4bd4482bdfc72f8b7656b920498329d2fee4def5ef4d669ea3202bd375b0d8086572b080b816593639098c584bb99f8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/200fac678f7ee7dc5e63a46222bef301e8463e965ed45cc8bad641bad96f0e68ac9758974ecdade3b660b1a3cb540b36f320a09aff5eb255c5231eda16343a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf4ab1cc5afcff8b30b486d44849bd4f598b11c9fff742b6bc92668305c0d77e59b5f0931a9edc64d2fc8a1e340e01fd3d52a32929408bea7657fd4a5b0b4836"} 19:31:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:12 INFO - Contents: 19:31:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad5dd195a6ab7251c410fb5e1c565ba4bd4482bdfc72f8b7656b920498329d2fee4def5ef4d669ea3202bd375b0d8086572b080b816593639098c584bb99f8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/200fac678f7ee7dc5e63a46222bef301e8463e965ed45cc8bad641bad96f0e68ac9758974ecdade3b660b1a3cb540b36f320a09aff5eb255c5231eda16343a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf4ab1cc5afcff8b30b486d44849bd4f598b11c9fff742b6bc92668305c0d77e59b5f0931a9edc64d2fc8a1e340e01fd3d52a32929408bea7657fd4a5b0b4836"} 19:31:12 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:12 INFO - Copying logs to upload dir... 19:31:12 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.869310 ========= master_lag: 8.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-19 19:31:21.582169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 19:31:21.589992) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172 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/ad5dd195a6ab7251c410fb5e1c565ba4bd4482bdfc72f8b7656b920498329d2fee4def5ef4d669ea3202bd375b0d8086572b080b816593639098c584bb99f8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/200fac678f7ee7dc5e63a46222bef301e8463e965ed45cc8bad641bad96f0e68ac9758974ecdade3b660b1a3cb540b36f320a09aff5eb255c5231eda16343a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf4ab1cc5afcff8b30b486d44849bd4f598b11c9fff742b6bc92668305c0d77e59b5f0931a9edc64d2fc8a1e340e01fd3d52a32929408bea7657fd4a5b0b4836"} build_url:https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/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/ad5dd195a6ab7251c410fb5e1c565ba4bd4482bdfc72f8b7656b920498329d2fee4def5ef4d669ea3202bd375b0d8086572b080b816593639098c584bb99f8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/200fac678f7ee7dc5e63a46222bef301e8463e965ed45cc8bad641bad96f0e68ac9758974ecdade3b660b1a3cb540b36f320a09aff5eb255c5231eda16343a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf4ab1cc5afcff8b30b486d44849bd4f598b11c9fff742b6bc92668305c0d77e59b5f0931a9edc64d2fc8a1e340e01fd3d52a32929408bea7657fd4a5b0b4836"}' ========= master_lag: 0.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 19:31:22.146175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 19:31:22.146512) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463706541.760409-475664172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 1.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 19:31:23.510464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 19:31:23.510826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 19:31:23.569271) ========= ========= Total master_lag: 10.96 =========