builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1463463674.47 results: success (0) buildid: 20160516220137 builduid: b339a9849e3148e5908457ea97e60907 revision: 4c709f7a03350ad5e36d0d726c8f12106ed2049d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.467520) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.467997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.468317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.490655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.490965) ========= 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=7de08804244eb36560b44971000001c3-1463463282.858536-1397964085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 22:41:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-05-16 22:41:14 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.258959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.769286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.769671) ========= 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=7de08804244eb36560b44971000001c3-1463463282.858536-1397964085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019127 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.819591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.819996) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c709f7a03350ad5e36d0d726c8f12106ed2049d --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 4c709f7a03350ad5e36d0d726c8f12106ed2049d --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=7de08804244eb36560b44971000001c3-1463463282.858536-1397964085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 22:41:14,980 truncating revision to first 12 chars 2016-05-16 22:41:14,980 Setting DEBUG logging. 2016-05-16 22:41:14,980 attempt 1/10 2016-05-16 22:41:14,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c709f7a0335?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 22:41:15,261 unpacking tar archive at: fx-team-4c709f7a0335/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.398801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.399565) ========= script_repo_revision: 4c709f7a03350ad5e36d0d726c8f12106ed2049d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.400515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.400839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.411159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-16 22:41:15.411707) ========= /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=7de08804244eb36560b44971000001c3-1463463282.858536-1397964085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:15 INFO - MultiFileLogger online at 20160516 22:41:15 in /builds/slave/test 22:41:15 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 22:41:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:41:15 INFO - {'append_to_log': False, 22:41:15 INFO - 'base_work_dir': '/builds/slave/test', 22:41:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:41:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:41:15 INFO - 'branch': 'Fx-Team-Non-PGO', 22:41:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:15 INFO - 'config_files': ('talos/linux_config.py',), 22:41:15 INFO - 'default_actions': ('clobber', 22:41:15 INFO - 'read-buildbot-config', 22:41:15 INFO - 'download-and-extract', 22:41:15 INFO - 'populate-webroot', 22:41:15 INFO - 'create-virtualenv', 22:41:15 INFO - 'install', 22:41:15 INFO - 'run-tests'), 22:41:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:15 INFO - 'download_minidump_stackwalk': True, 22:41:15 INFO - 'download_symbols': 'ondemand', 22:41:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:15 INFO - 'installer_path': 'installer.exe', 22:41:15 INFO - 'log_level': 'info', 22:41:15 INFO - 'log_name': 'talos', 22:41:15 INFO - 'log_to_console': True, 22:41:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:15 INFO - 'opt_config_files': (), 22:41:15 INFO - 'pip_index': False, 22:41:15 INFO - 'sps_profile': False, 22:41:15 INFO - 'sps_profile_interval': 0, 22:41:15 INFO - 'suite': 'dromaeojs', 22:41:15 INFO - 'system_bits': '32', 22:41:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:15 INFO - 'title': 'talos-linux64-ix-003', 22:41:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:15 INFO - 'use_talos_json': True, 22:41:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:41:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:15 INFO - 'work_dir': 'build'} 22:41:15 INFO - ##### 22:41:15 INFO - ##### Running clobber step. 22:41:15 INFO - ##### 22:41:15 INFO - Running pre-action listener: _resource_record_pre_action 22:41:15 INFO - Running main action method: clobber 22:41:15 INFO - rmtree: /builds/slave/test/build 22:41:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:41:16 INFO - Running post-action listener: _resource_record_post_action 22:41:16 INFO - ##### 22:41:16 INFO - ##### Finished clobber step (success) 22:41:16 INFO - ##### 22:41:16 INFO - ##### 22:41:16 INFO - ##### Running read-buildbot-config step. 22:41:16 INFO - ##### 22:41:16 INFO - Running pre-action listener: _resource_record_pre_action 22:41:16 INFO - Running main action method: read_buildbot_config 22:41:16 INFO - Using buildbot properties: 22:41:16 INFO - { 22:41:16 INFO - "project": "", 22:41:16 INFO - "product": "firefox", 22:41:16 INFO - "script_repo_revision": "production", 22:41:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:41:16 INFO - "repository": "", 22:41:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:41:16 INFO - "buildid": "20160516220137", 22:41:16 INFO - "pgo_build": "False", 22:41:16 INFO - "basedir": "/builds/slave/test", 22:41:16 INFO - "buildnumber": 1752, 22:41:16 INFO - "slavename": "talos-linux64-ix-003", 22:41:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:41:16 INFO - "platform": "ubuntu64_hw", 22:41:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:41:16 INFO - "branch": "fx-team", 22:41:16 INFO - "repo_path": "integration/fx-team", 22:41:16 INFO - "revision": "4c709f7a03350ad5e36d0d726c8f12106ed2049d", 22:41:16 INFO - "stage_platform": "linux64", 22:41:16 INFO - "builduid": "b339a9849e3148e5908457ea97e60907", 22:41:16 INFO - "slavebuilddir": "test" 22:41:16 INFO - } 22:41:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:41:16 INFO - Running post-action listener: _resource_record_post_action 22:41:16 INFO - ##### 22:41:16 INFO - ##### Finished read-buildbot-config step (success) 22:41:16 INFO - ##### 22:41:16 INFO - ##### 22:41:16 INFO - ##### Running download-and-extract step. 22:41:16 INFO - ##### 22:41:16 INFO - Running pre-action listener: _resource_record_pre_action 22:41:16 INFO - Running main action method: download_and_extract 22:41:16 INFO - mkdir: /builds/slave/test/build/tests 22:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:16 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:41:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:41:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:41:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:22 INFO - Downloaded 1361 bytes. 22:41:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:41:22 INFO - Using the following test package requirements: 22:41:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:41:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:41:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'jsshell-linux-x86_64.zip'], 22:41:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:41:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:41:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:41:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:41:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:41:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:22 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:28 INFO - Downloaded 22448136 bytes. 22:41:28 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'] 22:41:28 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 22:41:30 INFO - Return code: 0 22:41: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 22:41: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')]} 22:41:30 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:36 INFO - Downloaded 22448136 bytes. 22:41:36 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'] 22:41:36 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 22:41:37 INFO - Return code: 0 22:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:37 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:41:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:38 INFO - Downloaded 10840194 bytes. 22:41:38 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'] 22:41:38 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 22:41:39 INFO - Return code: 0 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:39 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:41 INFO - Downloaded 54767525 bytes. 22:41:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:41 INFO - mkdir: /builds/slave/test/properties 22:41:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:41:41 INFO - Writing to file /builds/slave/test/properties/build_url 22:41:41 INFO - Contents: 22:41:41 INFO - build_url:https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:41 INFO - Running post-action listener: _resource_record_post_action 22:41:41 INFO - Running post-action listener: set_extra_try_arguments 22:41:41 INFO - ##### 22:41:41 INFO - ##### Finished download-and-extract step (success) 22:41:41 INFO - ##### 22:41:41 INFO - ##### 22:41:41 INFO - ##### Running populate-webroot step. 22:41:41 INFO - ##### 22:41:41 INFO - Running pre-action listener: _resource_record_pre_action 22:41:41 INFO - Running main action method: populate_webroot 22:41:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:41 INFO - '--tppagecycles', 22:41:41 INFO - '7'], 22:41:41 INFO - 'tests': ['tsvgm']}}, 22:41:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:41:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:41:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['damp', 'tps']}, 22:41:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'tests': ['damp', 'tps']}, 22:41:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['dromaeo_dom']}, 22:41:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['a11yr', 22:41:41 INFO - 'ts_paint', 22:41:41 INFO - 'tpaint', 22:41:41 INFO - 'sessionrestore', 22:41:41 INFO - 'sessionrestore_no_auto_restore', 22:41:41 INFO - 'tabpaint']}, 22:41:41 INFO - 'other-e10s': {'tests': ['a11yr', 22:41:41 INFO - 'ts_paint', 22:41:41 INFO - 'tpaint', 22:41:41 INFO - 'sessionrestore', 22:41:41 INFO - 'sessionrestore_no_auto_restore', 22:41:41 INFO - 'tabpaint']}, 22:41:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:41:41 INFO - 'ts_paint', 22:41:41 INFO - 'tpaint', 22:41:41 INFO - 'sessionrestore', 22:41:41 INFO - 'sessionrestore_no_auto_restore', 22:41:41 INFO - 'tabpaint']}, 22:41:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:41:41 INFO - 'ts_paint', 22:41:41 INFO - 'tpaint', 22:41:41 INFO - 'sessionrestore', 22:41:41 INFO - 'sessionrestore_no_auto_restore', 22:41:41 INFO - 'tabpaint']}, 22:41:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['a11yr', 22:41:41 INFO - 'ts_paint', 22:41:41 INFO - 'tpaint', 22:41:41 INFO - 'sessionrestore', 22:41:41 INFO - 'sessionrestore_no_auto_restore', 22:41:41 INFO - 'tabpaint']}, 22:41:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['a11yr', 22:41:41 INFO - 'ts_paint', 22:41:41 INFO - 'tpaint', 22:41:41 INFO - 'sessionrestore', 22:41:41 INFO - 'sessionrestore_no_auto_restore', 22:41:41 INFO - 'tabpaint']}, 22:41:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['tsvgx', 22:41:41 INFO - 'tsvgr_opacity', 22:41:41 INFO - 'tart', 22:41:41 INFO - 'tscrollx', 22:41:41 INFO - 'cart']}, 22:41:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:41:41 INFO - 'tsvgr_opacity', 22:41:41 INFO - 'tart', 22:41:41 INFO - 'tscrollx', 22:41:41 INFO - 'cart']}, 22:41:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'talos_options': ['--disable-e10s'], 22:41:41 INFO - 'tests': ['tp5o']}, 22:41:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'tests': ['tp5o']}, 22:41:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'talos_options': ['--disable-e10s', 22:41:41 INFO - '--xperf_path', 22:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:41 INFO - 'tests': ['tp5n']}, 22:41:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:41 INFO - 'talos_options': ['--xperf_path', 22:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:41 INFO - 'tests': ['tp5n']}}, 22:41:41 INFO - 'talos.zip': {'path': '', 22:41:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:41 INFO - Running post-action listener: _resource_record_post_action 22:41:41 INFO - ##### 22:41:41 INFO - ##### Finished populate-webroot step (success) 22:41:41 INFO - ##### 22:41:41 INFO - ##### 22:41:41 INFO - ##### Running create-virtualenv step. 22:41:41 INFO - ##### 22:41:41 INFO - Running pre-action listener: _resource_record_pre_action 22:41:41 INFO - Running main action method: create_virtualenv 22:41:41 INFO - Creating virtualenv /builds/slave/test/build/venv 22:41:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:41:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:41:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:42 INFO - Using real prefix '/usr' 22:41:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:41:42 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:44 INFO - Installing pip.................done. 22:41:44 INFO - Return code: 0 22:41:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:41:44 INFO - Using env: {'DISPLAY': ':0', 22:41:44 INFO - 'HOME': '/home/cltbld', 22:41:44 INFO - 'LANG': 'en_US.UTF-8', 22:41:44 INFO - 'LANGUAGE': 'en_US:en', 22:41:44 INFO - 'LOGNAME': 'cltbld', 22:41:44 INFO - 'MAIL': '/var/mail/cltbld', 22:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:44 INFO - 'MOZ_NO_REMOTE': '1', 22:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:44 INFO - 'NO_EM_RESTART': '1', 22:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:44 INFO - 'PWD': '/builds/slave/test', 22:41:44 INFO - 'SHELL': '/bin/bash', 22:41:44 INFO - 'SHLVL': '1', 22:41:44 INFO - 'TERM': 'linux', 22:41:44 INFO - 'TMOUT': '86400', 22:41:44 INFO - 'USER': 'cltbld', 22:41:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:44 INFO - '_': '/tools/buildbot/bin/python'} 22:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:44 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 22:41:44 INFO - Cleaning up... 22:41:44 INFO - Return code: 0 22:41:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:41:44 INFO - Using env: {'DISPLAY': ':0', 22:41:44 INFO - 'HOME': '/home/cltbld', 22:41:44 INFO - 'LANG': 'en_US.UTF-8', 22:41:44 INFO - 'LANGUAGE': 'en_US:en', 22:41:44 INFO - 'LOGNAME': 'cltbld', 22:41:44 INFO - 'MAIL': '/var/mail/cltbld', 22:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:44 INFO - 'MOZ_NO_REMOTE': '1', 22:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:44 INFO - 'NO_EM_RESTART': '1', 22:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:44 INFO - 'PWD': '/builds/slave/test', 22:41:44 INFO - 'SHELL': '/bin/bash', 22:41:44 INFO - 'SHLVL': '1', 22:41:44 INFO - 'TERM': 'linux', 22:41:44 INFO - 'TMOUT': '86400', 22:41:44 INFO - 'USER': 'cltbld', 22:41:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:44 INFO - '_': '/tools/buildbot/bin/python'} 22:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:44 INFO - Downloading/unpacking psutil>=3.1.1 22:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:41:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:46 INFO - Installing collected packages: psutil 22:41:46 INFO - Running setup.py install for psutil 22:41:47 INFO - building 'psutil._psutil_linux' extension 22:41:47 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 22:41:47 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 22:41:47 INFO - building 'psutil._psutil_posix' extension 22:41:47 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 22:41:47 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 22:41:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:47 INFO - Successfully installed psutil 22:41:47 INFO - Cleaning up... 22:41:47 INFO - Return code: 0 22:41:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:41: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:41: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 mozsystemmonitor==0.3 22:41:47 INFO - Using env: {'DISPLAY': ':0', 22:41:47 INFO - 'HOME': '/home/cltbld', 22:41:47 INFO - 'LANG': 'en_US.UTF-8', 22:41:47 INFO - 'LANGUAGE': 'en_US:en', 22:41:47 INFO - 'LOGNAME': 'cltbld', 22:41:47 INFO - 'MAIL': '/var/mail/cltbld', 22:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:47 INFO - 'MOZ_NO_REMOTE': '1', 22:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:47 INFO - 'NO_EM_RESTART': '1', 22:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:47 INFO - 'PWD': '/builds/slave/test', 22:41:47 INFO - 'SHELL': '/bin/bash', 22:41:47 INFO - 'SHLVL': '1', 22:41:47 INFO - 'TERM': 'linux', 22:41:47 INFO - 'TMOUT': '86400', 22:41:47 INFO - 'USER': 'cltbld', 22:41:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:47 INFO - '_': '/tools/buildbot/bin/python'} 22:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:41:49 INFO - Installing collected packages: mozsystemmonitor 22:41:49 INFO - Running setup.py install for mozsystemmonitor 22:41:49 INFO - Successfully installed mozsystemmonitor 22:41:49 INFO - Cleaning up... 22:41:49 INFO - Return code: 0 22:41:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:41:49 INFO - Using env: {'DISPLAY': ':0', 22:41:49 INFO - 'HOME': '/home/cltbld', 22:41:49 INFO - 'LANG': 'en_US.UTF-8', 22:41:49 INFO - 'LANGUAGE': 'en_US:en', 22:41:49 INFO - 'LOGNAME': 'cltbld', 22:41:49 INFO - 'MAIL': '/var/mail/cltbld', 22:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:49 INFO - 'MOZ_NO_REMOTE': '1', 22:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:49 INFO - 'NO_EM_RESTART': '1', 22:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:49 INFO - 'PWD': '/builds/slave/test', 22:41:49 INFO - 'SHELL': '/bin/bash', 22:41:49 INFO - 'SHLVL': '1', 22:41:49 INFO - 'TERM': 'linux', 22:41:49 INFO - 'TMOUT': '86400', 22:41:49 INFO - 'USER': 'cltbld', 22:41:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:49 INFO - '_': '/tools/buildbot/bin/python'} 22:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - Downloading docopt-0.6.1.tar.gz 22:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:52 INFO - Running setup.py install for blobuploader 22:41:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:41:52 INFO - Running setup.py install for requests 22:41:53 INFO - Running setup.py install for docopt 22:41:53 INFO - Successfully installed blobuploader requests docopt 22:41:53 INFO - Cleaning up... 22:41:53 INFO - Return code: 0 22:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:53 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 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:41:53 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 22:41:53 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 22:41:53 INFO - Using env: {'DISPLAY': ':0', 22:41:53 INFO - 'HOME': '/home/cltbld', 22:41:53 INFO - 'LANG': 'en_US.UTF-8', 22:41:53 INFO - 'LANGUAGE': 'en_US:en', 22:41:53 INFO - 'LOGNAME': 'cltbld', 22:41:53 INFO - 'MAIL': '/var/mail/cltbld', 22:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:53 INFO - 'MOZ_NO_REMOTE': '1', 22:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:53 INFO - 'NO_EM_RESTART': '1', 22:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:53 INFO - 'PWD': '/builds/slave/test', 22:41:53 INFO - 'SHELL': '/bin/bash', 22:41:53 INFO - 'SHLVL': '1', 22:41:53 INFO - 'TERM': 'linux', 22:41:53 INFO - 'TMOUT': '86400', 22:41:53 INFO - 'USER': 'cltbld', 22:41:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:53 INFO - '_': '/tools/buildbot/bin/python'} 22:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:53 INFO - Running setup.py (path:/tmp/pip-JHRjQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:53 INFO - Running setup.py (path:/tmp/pip-2KteAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:53 INFO - Running setup.py (path:/tmp/pip-1ioEtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:53 INFO - Running setup.py (path:/tmp/pip-qn0zT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:53 INFO - Running setup.py (path:/tmp/pip-s0Mj9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:53 INFO - Running setup.py (path:/tmp/pip-RTJqd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:53 INFO - Running setup.py (path:/tmp/pip-PBleo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:54 INFO - Running setup.py (path:/tmp/pip-iCQ1Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:54 INFO - Running setup.py (path:/tmp/pip-gNOvVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:54 INFO - Running setup.py (path:/tmp/pip-Qp6fKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:54 INFO - Running setup.py (path:/tmp/pip-tVtBb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:54 INFO - Running setup.py (path:/tmp/pip-6fPaig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:54 INFO - Running setup.py (path:/tmp/pip-dUukcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:54 INFO - Running setup.py (path:/tmp/pip-fkcRuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:54 INFO - Running setup.py (path:/tmp/pip-gwFm4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:54 INFO - Running setup.py (path:/tmp/pip-KgmJK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:54 INFO - Running setup.py (path:/tmp/pip-pUUKDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:54 INFO - Running setup.py install for manifestparser 22:41:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:41:54 INFO - Running setup.py install for mozcrash 22:41:55 INFO - Running setup.py install for mozdebug 22:41:55 INFO - Running setup.py install for mozdevice 22:41:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Running setup.py install for mozfile 22:41:55 INFO - Running setup.py install for mozhttpd 22:41:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Running setup.py install for mozinfo 22:41:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Running setup.py install for mozInstall 22:41:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Running setup.py install for mozleak 22:41:55 INFO - Running setup.py install for mozlog 22:41:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Running setup.py install for moznetwork 22:41:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:41:55 INFO - Running setup.py install for mozprocess 22:41:56 INFO - Running setup.py install for mozprofile 22:41:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:41:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:41:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:41:56 INFO - Running setup.py install for mozrunner 22:41:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:41:56 INFO - Running setup.py install for mozscreenshot 22:41:56 INFO - Running setup.py install for moztest 22:41:56 INFO - Running setup.py install for mozversion 22:41:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:41:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:56 INFO - Cleaning up... 22:41:56 INFO - Return code: 0 22:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:56 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')]} 22:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:56 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')]} 22:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:56 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 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:41:56 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 22:41:56 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 22:41:56 INFO - Using env: {'DISPLAY': ':0', 22:41:56 INFO - 'HOME': '/home/cltbld', 22:41:56 INFO - 'LANG': 'en_US.UTF-8', 22:41:56 INFO - 'LANGUAGE': 'en_US:en', 22:41:56 INFO - 'LOGNAME': 'cltbld', 22:41:56 INFO - 'MAIL': '/var/mail/cltbld', 22:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:56 INFO - 'MOZ_NO_REMOTE': '1', 22:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:56 INFO - 'NO_EM_RESTART': '1', 22:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:56 INFO - 'PWD': '/builds/slave/test', 22:41:56 INFO - 'SHELL': '/bin/bash', 22:41:56 INFO - 'SHLVL': '1', 22:41:56 INFO - 'TERM': 'linux', 22:41:56 INFO - 'TMOUT': '86400', 22:41:56 INFO - 'USER': 'cltbld', 22:41:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:56 INFO - '_': '/tools/buildbot/bin/python'} 22:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:56 INFO - Running setup.py (path:/tmp/pip-D9NrL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:56 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)) 22:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:56 INFO - Running setup.py (path:/tmp/pip-HwVHJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:56 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)) 22:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:56 INFO - Running setup.py (path:/tmp/pip-BlNaYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:57 INFO - Running setup.py (path:/tmp/pip-wYd0hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:57 INFO - Running setup.py (path:/tmp/pip-0qeStb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:57 INFO - Running setup.py (path:/tmp/pip-kzR8ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:57 INFO - Running setup.py (path:/tmp/pip-i97JMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:57 INFO - Running setup.py (path:/tmp/pip-npcm0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:57 INFO - Running setup.py (path:/tmp/pip-FZ4kJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:57 INFO - Running setup.py (path:/tmp/pip-iuG9Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:57 INFO - Running setup.py (path:/tmp/pip-dpC4jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:57 INFO - Running setup.py (path:/tmp/pip-e5XYEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:57 INFO - Running setup.py (path:/tmp/pip-3iVxRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:57 INFO - Running setup.py (path:/tmp/pip-cfOhtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:57 INFO - Running setup.py (path:/tmp/pip-Husx3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:57 INFO - Running setup.py (path:/tmp/pip-pmMOmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:57 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)) 22:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:57 INFO - Running setup.py (path:/tmp/pip-GIHmV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:58 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)) 22:41:58 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)) 22:41:58 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)) 22:41:58 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)) 22:41:58 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)) 22:41:58 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)) 22:41:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:41:58 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 22:41:58 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 22:41:58 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 22:41:58 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 22:41:58 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 22:41:58 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 22:41:59 INFO - Downloading blessings-1.6.tar.gz 22:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:41:59 INFO - Installing collected packages: blessings 22:41:59 INFO - Running setup.py install for blessings 22:42:00 INFO - Successfully installed blessings 22:42:00 INFO - Cleaning up... 22:42:00 INFO - Return code: 0 22:42:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:00 INFO - Reading from file tmpfile_stdout 22:42:00 INFO - Current package versions: 22:42:00 INFO - argparse == 1.2.1 22:42:00 INFO - blessings == 1.6 22:42:00 INFO - blobuploader == 1.2.4 22:42:00 INFO - docopt == 0.6.1 22:42:00 INFO - manifestparser == 1.1 22:42:00 INFO - mozInstall == 1.12 22:42:00 INFO - mozcrash == 0.17 22:42:00 INFO - mozdebug == 0.1 22:42:00 INFO - mozdevice == 0.48 22:42:00 INFO - mozfile == 1.2 22:42:00 INFO - mozhttpd == 0.7 22:42:00 INFO - mozinfo == 0.9 22:42:00 INFO - mozleak == 0.1 22:42:00 INFO - mozlog == 3.2 22:42:00 INFO - moznetwork == 0.27 22:42:00 INFO - mozprocess == 0.22 22:42:00 INFO - mozprofile == 0.28 22:42:00 INFO - mozrunner == 6.11 22:42:00 INFO - mozscreenshot == 0.1 22:42:00 INFO - mozsystemmonitor == 0.3 22:42:00 INFO - moztest == 0.7 22:42:00 INFO - mozversion == 1.4 22:42:00 INFO - psutil == 3.1.1 22:42:00 INFO - requests == 1.2.3 22:42:00 INFO - wsgiref == 0.1.2 22:42:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:00 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')]} 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 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')]} 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 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 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:42:00 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 22:42:00 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 22:42:00 INFO - Using env: {'DISPLAY': ':0', 22:42:00 INFO - 'HOME': '/home/cltbld', 22:42:00 INFO - 'LANG': 'en_US.UTF-8', 22:42:00 INFO - 'LANGUAGE': 'en_US:en', 22:42:00 INFO - 'LOGNAME': 'cltbld', 22:42:00 INFO - 'MAIL': '/var/mail/cltbld', 22:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:00 INFO - 'MOZ_NO_REMOTE': '1', 22:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:00 INFO - 'NO_EM_RESTART': '1', 22:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:00 INFO - 'PWD': '/builds/slave/test', 22:42:00 INFO - 'SHELL': '/bin/bash', 22:42:00 INFO - 'SHLVL': '1', 22:42:00 INFO - 'TERM': 'linux', 22:42:00 INFO - 'TMOUT': '86400', 22:42:00 INFO - 'USER': 'cltbld', 22:42:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:00 INFO - '_': '/tools/buildbot/bin/python'} 22:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 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)) 22:42:00 INFO - Cleaning up... 22:42:00 INFO - Return code: 0 22:42:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:42:00 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')]} 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 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')]} 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 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 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:42:00 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 22:42:00 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 22:42:00 INFO - Using env: {'DISPLAY': ':0', 22:42:00 INFO - 'HOME': '/home/cltbld', 22:42:00 INFO - 'LANG': 'en_US.UTF-8', 22:42:00 INFO - 'LANGUAGE': 'en_US:en', 22:42:00 INFO - 'LOGNAME': 'cltbld', 22:42:00 INFO - 'MAIL': '/var/mail/cltbld', 22:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:00 INFO - 'MOZ_NO_REMOTE': '1', 22:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:00 INFO - 'NO_EM_RESTART': '1', 22:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:00 INFO - 'PWD': '/builds/slave/test', 22:42:00 INFO - 'SHELL': '/bin/bash', 22:42:00 INFO - 'SHLVL': '1', 22:42:00 INFO - 'TERM': 'linux', 22:42:00 INFO - 'TMOUT': '86400', 22:42:00 INFO - 'USER': 'cltbld', 22:42:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:00 INFO - '_': '/tools/buildbot/bin/python'} 22:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:00 INFO - Downloading/unpacking jsonschema 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:02 INFO - Downloading/unpacking functools32 (from jsonschema) 22:42:02 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 22:42:02 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 22:42:02 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 22:42:02 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 22:42:02 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 22:42:02 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 22:42:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:02 INFO - warning: no files found matching '*.txt' 22:42:02 INFO - no previously-included directories found matching 'build' 22:42:02 INFO - no previously-included directories found matching 'dist' 22:42:02 INFO - no previously-included directories found matching '.git*' 22:42:02 INFO - Installing collected packages: jsonschema, functools32 22:42:03 INFO - Running setup.py install for functools32 22:42:03 INFO - warning: no files found matching '*.txt' 22:42:03 INFO - no previously-included directories found matching 'build' 22:42:03 INFO - no previously-included directories found matching 'dist' 22:42:03 INFO - no previously-included directories found matching '.git*' 22:42:03 INFO - Successfully installed jsonschema functools32 22:42:03 INFO - Cleaning up... 22:42:03 INFO - Return code: 0 22:42:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:42:03 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')]} 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:03 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')]} 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:03 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 0x7fc3e87e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, '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': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', '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 22:42:03 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 22:42:03 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 22:42:03 INFO - Using env: {'DISPLAY': ':0', 22:42:03 INFO - 'HOME': '/home/cltbld', 22:42:03 INFO - 'LANG': 'en_US.UTF-8', 22:42:03 INFO - 'LANGUAGE': 'en_US:en', 22:42:03 INFO - 'LOGNAME': 'cltbld', 22:42:03 INFO - 'MAIL': '/var/mail/cltbld', 22:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:03 INFO - 'MOZ_NO_REMOTE': '1', 22:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:03 INFO - 'NO_EM_RESTART': '1', 22:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:03 INFO - 'PWD': '/builds/slave/test', 22:42:03 INFO - 'SHELL': '/bin/bash', 22:42:03 INFO - 'SHLVL': '1', 22:42:03 INFO - 'TERM': 'linux', 22:42:03 INFO - 'TMOUT': '86400', 22:42:03 INFO - 'USER': 'cltbld', 22:42:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:03 INFO - '_': '/tools/buildbot/bin/python'} 22:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:03 INFO - Downloading/unpacking flake8 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:42:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:42:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:05 INFO - no previously-included directories found matching 'docs/_build' 22:42:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:42:06 INFO - Running setup.py install for pep8 22:42:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:06 INFO - no previously-included directories found matching 'docs/_build' 22:42:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:42:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:42:06 INFO - Cleaning up... 22:42:06 INFO - Return code: 0 22:42:06 INFO - Running post-action listener: _resource_record_post_action 22:42:06 INFO - Running post-action listener: _start_resource_monitoring 22:42:06 INFO - Starting resource monitoring. 22:42:06 INFO - ##### 22:42:06 INFO - ##### Finished create-virtualenv step (success) 22:42:06 INFO - ##### 22:42:06 INFO - ##### 22:42:06 INFO - ##### Running install step. 22:42:06 INFO - ##### 22:42:06 INFO - Running pre-action listener: _resource_record_pre_action 22:42:06 INFO - Running main action method: install 22:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:06 INFO - Reading from file tmpfile_stdout 22:42:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:42:06 INFO - Reading from file tmpfile_stdout 22:42:06 INFO - Output received: 22:42:06 INFO - Usage: mozinstall [options] installer 22:42:06 INFO - Options: 22:42:06 INFO - -h, --help show this help message and exit 22:42:06 INFO - -d DEST, --destination=DEST 22:42:06 INFO - Directory to install application into. [default: 22:42:06 INFO - "/builds/slave/test"] 22:42:06 INFO - --app=APP Application being installed. [default: firefox] 22:42:06 INFO - mkdir: /builds/slave/test/build/application 22:42:06 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'] 22:42:06 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 22:42:22 INFO - Reading from file tmpfile_stdout 22:42:22 INFO - Output received: 22:42:22 INFO - /builds/slave/test/build/application/firefox/firefox 22:42:22 INFO - Running post-action listener: _resource_record_post_action 22:42:22 INFO - ##### 22:42:22 INFO - ##### Finished install step (success) 22:42:22 INFO - ##### 22:42:22 INFO - ##### 22:42:22 INFO - ##### Running run-tests step. 22:42:22 INFO - ##### 22:42:22 INFO - Running pre-action listener: _resource_record_pre_action 22:42:22 INFO - Running main action method: run_tests 22:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:42:22 INFO - Python 2.7.3 22:42:22 INFO - Return code: 0 22:42:22 INFO - grabbing minidump binary from tooltool 22:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:22 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 0x1c7f9c0>, '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 0x1c808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:42:22 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 22:42:22 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 22:42:22 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 22:42:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:22 INFO - Return code: 0 22:42:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:42:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:42:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:42:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:42:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:42:23 INFO - Return code: 0 22:42:23 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/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 22:42:23 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/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 22:42:23 INFO - Using env: {'DISPLAY': ':0', 22:42:23 INFO - 'HOME': '/home/cltbld', 22:42:23 INFO - 'LANG': 'en_US.UTF-8', 22:42:23 INFO - 'LANGUAGE': 'en_US:en', 22:42:23 INFO - 'LOGNAME': 'cltbld', 22:42:23 INFO - 'MAIL': '/var/mail/cltbld', 22:42:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:42:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:23 INFO - 'MOZ_NO_REMOTE': '1', 22:42:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:23 INFO - 'NO_EM_RESTART': '1', 22:42:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:23 INFO - 'PWD': '/builds/slave/test', 22:42:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:42:23 INFO - 'SHELL': '/bin/bash', 22:42:23 INFO - 'SHLVL': '1', 22:42:23 INFO - 'TERM': 'linux', 22:42:23 INFO - 'TMOUT': '86400', 22:42:23 INFO - 'USER': 'cltbld', 22:42:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463463282.858536-1397964085', 22:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:23 INFO - '_': '/tools/buildbot/bin/python'} 22:42:23 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/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 22:42:23 INFO - mozversion application_buildid: 20160516220137 22:42:23 INFO - mozversion application_changeset: 4c709f7a03350ad5e36d0d726c8f12106ed2049d 22:42:23 INFO - mozversion application_display_name: Nightly 22:42:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:23 INFO - mozversion application_name: Firefox 22:42:23 INFO - mozversion application_remotingname: firefox 22:42:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:42:23 INFO - mozversion application_vendor: Mozilla 22:42:23 INFO - mozversion application_version: 49.0a1 22:42:23 INFO - mozversion platform_buildid: 20160516220137 22:42:23 INFO - mozversion platform_changeset: 4c709f7a03350ad5e36d0d726c8f12106ed2049d 22:42:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:42:23 INFO - mozversion platform_version: 49.0a1 22:42:23 INFO - using testdate: 1463463743 22:42:23 INFO - actual date: 1463463743 22:42:23 INFO - starting webserver on 'localhost:52513' 22:42:23 INFO - SUITE-START | Running 2 tests 22:42:23 INFO - TEST-START | dromaeo_css 22:42:23 INFO - operating with platform_type : linux_ 22:42:23 INFO - Initialising browser for dromaeo_css test... 22:42:23 INFO - TEST-INFO | started process 12928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLhfvCh/profile http://localhost:52513/getInfo.html) 22:42:28 INFO - PROCESS | 12928 | __metrics Screen width/height:1600/1200 22:42:28 INFO - PROCESS | 12928 | colorDepth:24 22:42:28 INFO - PROCESS | 12928 | Browser inner width/height: 1024/697 22:42:28 INFO - PROCESS | 12928 | __metrics 22:42:29 ERROR - PROCESS | 12928 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:42:30 INFO - TEST-INFO | 12928: exit 0 22:42:30 INFO - Browser initialized. 22:42:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:30 INFO - TEST-INFO | started process 13007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLhfvCh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:42 INFO - PROCESS | 13007 | RSS: Main: 154562560 22:42:42 INFO - PROCESS | 13007 | 22:43:33 INFO - PROCESS | 13007 | 1463463813932 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] 22:45:46 INFO - PROCESS | 13007 | Cycle 1(1): loaded http://localhost:52513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52513/tests/dromaeo/cssquery-ext.html) 22:45:47 INFO - PROCESS | 13007 | RSS: Main: 252866560 22:45:47 INFO - PROCESS | 13007 | 22:48:49 INFO - PROCESS | 13007 | Cycle 1(1): loaded http://localhost:52513/tests/dromaeo/cssquery-ext.html (next: http://localhost:52513/tests/dromaeo/cssquery-jquery.html) 22:48:50 INFO - PROCESS | 13007 | RSS: Main: 240144384 22:48:50 INFO - PROCESS | 13007 | 22:51:52 INFO - PROCESS | 13007 | Cycle 1(1): loaded http://localhost:52513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52513/tests/dromaeo/cssquery-mootools.html) 22:51:52 INFO - PROCESS | 13007 | RSS: Main: 246321152 22:51:52 INFO - PROCESS | 13007 | 22:54:55 INFO - PROCESS | 13007 | Cycle 1(1): loaded http://localhost:52513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52513/tests/dromaeo/cssquery-prototype.html) 22:54:55 INFO - PROCESS | 13007 | RSS: Main: 233218048 22:54:55 INFO - PROCESS | 13007 | 22:57:58 INFO - PROCESS | 13007 | Cycle 1(1): loaded http://localhost:52513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52513/tests/dromaeo/cssquery-yui.html) 22:57:59 INFO - PROCESS | 13007 | RSS: Main: 210407424 22:57:59 INFO - PROCESS | 13007 | 23:01:01 INFO - PROCESS | 13007 | Cycle 1(1): loaded http://localhost:52513/tests/dromaeo/cssquery-yui.html (next: http://localhost:52513/tests/dromaeo/cssquery-dojo.html) 23:01:02 INFO - PROCESS | 13007 | RSS: Main: 278147072 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | __start_tp_report 23:01:02 INFO - PROCESS | 13007 | _x_x_mozilla_page_load 23:01:02 INFO - PROCESS | 13007 | _x_x_mozilla_page_load_details 23:01:02 INFO - PROCESS | 13007 | |i|pagename|runs| 23:01:02 INFO - PROCESS | 13007 | |0;dojo.html;2634.2360715392538;2663.9866800665995;2686.9462610747773;2690.959635605466;2698.7975901807367;4553;4660.836870709526;4670.883227919304;4714.939138693797;4809.254565542342;4710.552497512731;4752.358431611731;4756.476787553375;4793.7363445010515;4797.184478638631;4297.03316753731;4325.848595299165;4329.848455304065;4418.845340413094;4434.113177364524;4381.583749543788;4442.222611043071;4470.619997300233;4493.573110554492;4528.864134075983;4423.469183697945;4455.04216593434;4462.799174037176;4472.798724057425;4504.009117994053;4232.4286221360335;4284.850030248957;4288.078063216423;4293.699441039129;4316.719413238129;4308.482982042144;4309.159713855799;4318.654507639413;4357.302831546969;4410.316400957857;4690.01509682967;4703.388559487279;4724.574788269072;4731.290306454025;4733.857984260478;4921.458639549646;5034.370703662043;5082.034413461467;5164.715940623264;5182;5126.61550383719;5128.179491281415;5159.58723302135;5165.767540460688;5178.119719647631;4783.1868582341085;4785.114753770529;4804.015176888729;4813.663043586916;4833.540813622701;5042.596592272609;5130.4100028497205;5189.091908915924;5245.213218017251;5251.396089449686;5040.1179793535985;5054.21659642756;5093.0577843099145;5105.693658380509;5112.335396398519;5131.25596788471;5133.178691409356;5137.922931156036;5160.432352441228;5202.609804264695;4850.539198776181;4966.329545511309;5017.071841709296;5033.043721692867;5096.898062038813;5036.874078148076;5038.571721403649;5038.571721403721;5040.798368065236;5056.367954005749;4357.586029327209;4361.760103194291;4365.4979677337515;4397.31841564558;4405.757683327448;3724.646158614927;3727.2172843703124;3762.097096696828;3792.4311353297226;3813.427985802152;4308.138372325548;4314.115606300764;4316.223079845658;4346.7609281489185;4356.520782713899;5035.370578677665;5039.823606173766;5046.571041461443;5051.747412629354;5095.414027386824;4192.140611174702;4275.87172384829;4294.7852607369505;4324.589164029412;4329.653627709776;4567.155076310827;4583.358329833826;4591.265397536378;4598.287265473857;4638.072385522909;4775.116603428377;4788.61691064721;4789.568938795455;4794.232922732346;4837.177679794373;4925.778339974638;5111.977604479193;5157.174852023658;5168.457311982188;5243.370795504564;4876.244182151772;4892.0705066037335;4895.559399654048;4933.605311575137;4945.1346014448045;5078.949210507848;5115.514026167508;5126.641135120506;5127.512886275797;5130.076586214517;4976.950230497649;4978.477259887804;5003.699778013331;5005.1241032819835;5178.459048817729;4907.60739140875;4908.141075311734;4908.779104940358;4916.704997700006;4959.280904268933;4895.63282753802;4904.975475122602;4905.681130726634;4908.779104940358;4954.752262386794;4702.952970470252;4858.125537403302;4909.018196360814;4916.508349165055;4986.32684587576;5030.949690503195;5034.370703662043;5036.949630503795;5060.49395060491;5092.414372347227;4765.332853400596;4921.630877684116;4936.259561065869;4938.580220681282;4989.451160372429 23:01:02 INFO - PROCESS | 13007 | |1;ext.html;590.1325052173304;618.0667192539265;619.2785405003169;635.7425242776676;637.9872402551952;42997.57002429975;44296.77851610746;44461;44637.10725785486;48771.26843097356;45203.77398113013;45756.31365529511;45830.31254531176;45857.54142458575;45866.312005319865;7894.17111203324;8041.276285134337;8043.758687239392;8045;8045.356371490296;7954.443188976774;8033;8041.798955026113;8042.396820238476;8044.074931382907;7963.124056353826;8063.798405039892;8067.314278286323;8071.112177660452;8078.23256790604;8004.319632831216;8032.558209298486;8035.397345199133;8042.517448953023;8044.235797599219;7889.2110788920645;7950.1254861965135;7958.363330933512;7962.840743185162;7963.4027447941635;40602.79698601488;41043.58956410427;41077.1784564307;41094.589054109376;41165.79417102925;3284.310294838087;3721.4789929409903;3893.2602805467154;3924.2543916655745;3927.7446965947124;30401.847990760125;30633.38733225323;30679.38641227185;31100;31777.52333714996;3220.259340351709;3220.5256421704207;3224.1778346521724;3299.554560134375;3306.9503957440656;265349;265999;267487;267664.9999999981;268482;30979.845100774353;31167;31238.21904452407;58206;58653.706731466926;35997.8200109003;36088.81955590205;36188;36346;36353.45469817955;13919.721605567833;14055.226962516956;14057.78913316301;14061.929690351688;14068.859311406755;11978.880211197951;12089.274643521418;12148.271103733805;12159.756804863853;12170.57402990891;8201.79495512617;8277.95861020691;8280.917190828015;8349.540775257297;8357.8328433431;3208.342289830579;3223.3714425686767;3235.902922912316;3257.7358735678476;3272.8199949003033;898.2364989758784;949.6183053656913;989.3470309595632;1019.8827134879435;1050.5220124843179;28989.85505072461;29079.854600727285;29365.706342936297;29722.702772971992;29890.70109298879;988.367444835306;991.7768502086973;993.9950300248597;1002.3737806945703;1016.3343010328247;15664.765028524582;15743.212839357986;15801.604959875865;15863.444779432664;16132.919335403249;374748;378133;378523;380503.0974845108;380641;34554.82722586371;35156;35328.29343413117;35338.293234135686;35388.469172962425;1165.4755360087825;1270.4029106320015;1297.3837427222184;1302.9869701302866;1303.1008604063165;29556.261093472836;30601.23496912595;30772.846135769178;30965.380692385577;31122.68877311198;44919.77540112409;45012.32481512846;45415.545844541135;45499.77250113728;45525.54474455213;293185;293305;293708;293718;294810;23744.287671369886;24285.600015998127;26453.33866653272;27185.86407067952;27306.317342066606;43943.340849887914;44731.32903006522;44788.05810374778;45138.322925155495;45532.77233613811;38341.23317533689;38504.80747596244;39125.2174956505;39499.40750888796;39555.60444395519;37874.31505651894;38573.80713096417;39037.804810975766;39140.804295978334;39276.2144757109;37910;38140.23719525539;38583.42124868185;38894;38970.415443768936;33710.49434258537;34649;35213.29573408466;35215;35288.29423411466;26000.219993400227;26377.340566485993;27055.86472067627;27144.321391965357;28620.856895715388 23:01:02 INFO - PROCESS | 13007 | |2;jquery.html;384.47135189114965;387.7285899870092;391.77472953051995;400.3114642814358;410.3782769104807;17140.314387424503;17591.73612395815;18507.81492185078;18539.44381668549;18571.5357116072;17261.741073883903;17388.56528586786;18050.27798888043;18139.637207255848;18199.18103685334;5062.2406639004075;5190.792368305263;5243.554297884684;5257.737113144347;5269.552088072518;5338.599605029619;5632.295963004624;5634.0703783875815;5691.686957217351;5715.37130915601;5657.773689052433;5667.659940403569;5681.715914204294;5691.886162276752;5692.715364231793;5471.972640136793;5556.833295001156;5573.916391254134;5621.522170615503;5733.627314224562;5276.9736151319385;5422.40353561108;5439.673619582798;5441.564674826004;5555.8888822223325;12001;12195.756084878252;12258.325792081432;12331.445084971198;12332.506699732;1907.1894444861018;1944.6791279438876;1951.346298989826;2030.6547886859269;2223.9555208895895;9083.500407477586;9301.162895339452;9366;9829.754256143582;9858.211343092535;1793.246836328745;1820.8816426932208;1877.6995680691025;1877.8216069473378;1879.1637721214065;69607.65196173987;71066.64466677685;71589;72581.27418725798;73108.90336645007;10005.899941000642;10097.343672661253;10208.336458130347;10265.846012309821;10509.9474502627;14145.858541414455;14229.78655320171;14271;14292.356843942047;14332.713345733027;7527.757919943258;7593.164751877289;7680.116786569504;7769.689212431553;7812.57030863308;7449.441291903129;7463.440241981873;7634.770956871303;7635.885461718079;7664.731734389381;4369.257226271541;4443.644508439317;4458.108378324348;4510.391097201836;4569.954300456953;1841.8618603604784;1865.9160337784833;1901.7622797150357;1912.5218695326168;1927.5181204698824;829.5031953818927;869.8216865542548;948.5684013773716;962.3504134709043;966.7969726357403;16943.661126777395;16999.660006799793;17373.3050677974;17374;17777.377791777224;849.3417601358873;849.9970035358336;879.683314006957;899.820035992804;963.8072385522923;8888.955555222312;9895.604175832887;9957.153641940517;9962;9988.101070903653;366930;378004;378942;383198;386068;76752.61623691846;77234;79315.20684793194;80476;81357;923.9353245272766;937.7046230437254;946.3753922411175;956.9712908612753;960.8991055939166;15366.923165384102;15647;15775.132367719885;16005.19974001272;16109.113998729714;34194.658053419145;35270.29459410849;36153.63846361608;36489.63510364862;36984.445233320985;48255.75872120617;50066;50166.749166255395;50324.24513632372;50850.745746272514;6662.933370666231;7158;7973.401994850294;7995.760127196193;8132.064812546396;12051.457684404048;12079.335636539723;12232.938835306122;12487.812682809583;12674.176178548365;10056;10223.591056357662;10646.73383165396;10676.786464270826;11127.944360278147;10399.32404393712;10492.895071049192;10748.850229954196;10814.513346899252;10898.07366373867;10672.786544268916;10857.511411986321;10943.233973621771;11117.610883619034;11151.442427878412;6930.099087118642;6940.826479338057;7016.614086225102;7091.858162836817;7145.321194486515;9378.5779639915;10237.795244095225;10277.794444111225;10519.21105917044;10600.575976960836 23:01:02 INFO - PROCESS | 13007 | |3;mootools.html;1326.8673132686727;1511.4181040299482;1531.877449804016;1715.759793628892;1865.0022238102617;6936.583804971705;7552.358049565787;7766.184550622188;7785.571793551359;7949.12559618443;7668.693252269903;7946.801329966754;7947.086085100215;8120.228578285069;8135.674573017072;2215.8448908576406;2261.8529795563236;2269.716285464317;2270.6821045053707;2271.852329598579;2201.0975500044983;2227.4074037063497;2232.0960011195493;2232.9888350558226;2238.306125101216;2195.0890380492156;2197.2419515267206;2201.2295696506253;2202.449387653087;2227.7772222777676;2033.3391647714477;2057.7324947756847;2061.309461330441;2061.6082944240547;2062.587482503498;2128.936131916045;2165.090661921981;2165.1880544795704;2167.0573300614283;2167.349795061491;7852.685892564291;7991.480553763987;8073.798155046112;8077.313428358597;8111.391645626542;4751.596114330251;4883.8779030524165;4886.99816537609;4889.657723959324;4894.461609222983;3038.270815004405;3048.725614694688;3079.9538006929915;3100.643426005993;3120.40712264669;887.7128164161926;899.7885496908222;913.2374467319796;919.1406035356896;920.4799288402098;10612.946935265352;10680.092192163675;10767.569297228101;10770.569177232901;10777.191710621657;4131.607497287753;4238.936415953764;4309.288967320357;4317.266064768997;4319.244132276839;9196.448213107102;9248.815023699488;9250.167484926389;9252.028537003653;9274.350795444388;4760.143174228603;4763.523647635278;4764.404449443819;4765.857024289207;4767.594754445841;3805.1248212911187;3885.747426417274;3995.800209989489;4200.894977625584;4238.258304796648;3698.4637227601847;3737.5701794294005;3831.712621553339;3841.961580384216;3848.153406250676;1104.1829046505527;1136.8578927634046;1144.1418935798151;1167.1946357013633;1180.8582970043649;837.9734824839522;850.3622283287534;904.3488688144525;934.8036912248504;942.7454587261539;5422.078246697992;5795.333536643256;5795.623284486495;5812.447817457335;5970.0746384310505;914.8947870994788;950.7623094226443;952.3333666433524;961.1781926452921;974.551706215149;3959.3172901517314;4006.899827504336;4074.348104303297;4121.237571049305;4170.541240463546;9595.328327017181;9927.900720992697;10035.849462258071;10044.397336159855;10056.547455364525;9921.702348929544;9923.60305587783;9924.354916930377;9931.65239216624;9934.602615895283;7333.523320984119;7590;7660.119086305146;7674.194209608022;7756.961215194001;5713.628614140068;5775.595708300547;5859.882802343844;5915.6450612961635;5948.13752005948;8571.4000019998;8686.78283042929;9000;9052.683156089506;9053.913530376398;8996.820063598821;9057.09429057089;9064.773380665536;9179.082091791035;9278.536073196448;6404.199475065617;6521.380468855451;6654.500912431684;6664.666766661744;6999.47503937217;7497.175310715926;7511.62441877893;7547.320741133324;7565.848683026419;7577.507462014952;6526.184226971629;6669.333066693292;6721.663916804238;6747.392734653708;6813.080234168324;6747.527673062838;6758.560693554903;6804.829879253059;6806.7957961261245;6919.411849992807;6011.549133814894;6144.631322120687;6470.741170353322;6546.803595892131;6552.049952756919;4666;4711.458182309078;4753.073150735711;4760.8333708321425;4789.856304310876;4753.405824271966;4831.371921650163;4851.296561998561;4913.950860491349;4915.557599816034 23:01:02 INFO - PROCESS | 13007 | |4;prototype.html;303.0801517394707;304.33654632900283;309.22539039705543;315.8831232443996;316.0754792232719;4842.322074909511;4855.295982082596;4865;4872.65891387603;4889.291052797346;4687.648426368019;4697.201475749122;4737.715737055779;4806.567408933195;4814.494478079804;3596.766210196342;3674.9448758268645;3686.548445283883;3784.2242340320304;3803.3075281499746;3764.209516001643;3773.3963065697108;3785.337565925952;3785.4889589905288;3807.9619203808024;3613.728970327236;3764.454154147647;3774.1130834253927;3779.319722449972;3788.3181027415053;3625.909352266188;3702.463142844286;3736.1978516112918;3736.785544697957;3759.924801503982;3288.786228895114;3293.440115180425;3296.3901678189613;3311.2880730642787;3314.5359649649067;4598.126355992351;4602.746848923308;4613.907721845544;4639.095376401603;4640.141573808823;4052.939205911884;4294.656427485794;4306.5262821089655;4322.805473753657;4326.199653064162;4997.9750101249265;5009.499050094998;5028.34631497903;5047.520485553867;5067.214581739836;3601.927961440783;3603.1532589841368;3613.8915832524804;3614.987803415048;3627.818609069562;5062.949370506285;5244.580433565267;5304.071787437183;5309.150535914235;5309.230161626581;3665.8167091645846;3672.1737609037755;3672.9164896355637;3674.3018826422895;3681.9263614727556;3718;3718.6467285607823;3729.701623870084;3736.75711078779;3748.55017397914;4210.263203939298;4241.384999175102;4241.660667146621;4245.745255284693;4269.380939763779;4898.21628539432;5026;5033.622478314068;5043.697378157322;5056.595472362203;1271.1356277731047;1283.4224598930332;1286.530416398008;1289.6646871813396;1289.9100260280047;833.8749187621905;841.427829076234;864.7115797461737;880.6697488441835;881.1144799476485;4384.254676704968;4389.144116897174;4394.648428125743;4396.582324679151;4403.625691816167;5073.441921388644;5095.490450954875;5119.564836988898;5152.3044389007755;5157.510036546597;4314.331278651814;4391.956080439219;4419.734815911055;4430.386072217407;4443.178012067778;2735.7401046900513;2738.589211618273;2749.752522273005;2750.6286651301816;2770.972290277112;4852.010675622978;4922.729249891218;4923.310736496894;4933.827316043921;4943.505649435099;4998.4251811042195;5140.434552199255;5198.506141916512;5263.236830659533;5286.894262114736;4826.6621336506105;4845.75771211438;4848.8302909398;4854.160316214912;4890.559849613552;5104.846854594368;5105.285260063668;5106.259592359162;5106.617003724661;5106.829597421155;4872.244802055687;5040.193569028937;5053.84838454847;5152;5160.664556803796;4934.544309428656;4950.975245123751;4953.380827396575;4964.503549645006;4965.900681986413;3642.8724994625063;3659.5425571803526;3674.154944362758;3680.2087551176623;3691.390920498195;5156.819511317086;5198.922016169685;5232.947670523246;5274.604404669589;5283.788648454019;5006.499350064964;5030.4466508684745;5033.672811267256;5034.521720436553;5047.4952504749235;5002.549770520671;5010.69935803853;5016.573591244639;5054.924176137434;5058.721770302669;4722.905541889212;4965.031818795444;4975.676581022222;4983.4518202996915;4988.8752781180765;4880;4940;5073.264376665289;5079.822206222764;5084.059449001798;4954.315532718892;4968.652194346361;4976.253561965734;4977.477364876636;4999.150144475375 23:01:02 INFO - PROCESS | 13007 | |5;yui.html;709.6664567653203;711.12531586149;739.8298391369984;750.9511881727688;789.2817536042201;12798.872011279884;12991.2205267684;13173.473061077557;13193.80209296859;13253.867461325384;12575.308358040304;12716.745665086693;12766.55317063903;12770;12811.42348594313;682.3449488491054;857.4555157475017;877.3419935048713;900.2572877376158;901.2834796336928;882.814608932125;887.6848718704831;888;888.404768804899;889.0043151670138;935.5322338830584;939.1829108675428;940.47333493244;940.5861420974784;941.0448394879203;706.4701473894579;916.3539704508306;924.7688077980505;932.3333816321328;932.5197523275484;693.4417793676089;693.639307560071;693.6947742993067;693.7121094745675;694.0144994108379;12282.938585307016;12285;12296.585892622285;12320.01439884807;12354.0734444917;12033.699157521045;12224.205426647239;12386.81419778704;12434.564790232389;12682.112252142262;11019.228653994223;11031.72420689481;11033;11046.834297485544;11057.11543076552;4095.365218391154;4138.6482149017365;4169.395437661552;4171.6036976487185;4238.173556156551;46988;47541.52458475406;49850.50149498495;49892.25161622579;49954.999999999636;9477.810443791086;9495.430274183433;9615.56729947154;9672.419654820733;9681.112183124364;17919.73120403195;17968.640627187382;17978.820211797974;18004.459866204033;18094.457166285032;6820.556663816836;6907.896381554281;6913.412359949461;7137.072180616487;7162.570245785166;3704.814759262026;3862.111714305669;3886.553046399644;3952.3083460394314;3966.6033396660105;2740.780737540992;2828.0808737160505;2828.5191517442086;2831.971680283212;2836.078274560776;523.113322917651;523.8637954131877;526.0294756174851;528.7092099345344;530.4589318894706;526.9894602107936;558.600600570594;571.3229822660161;579.959402841797;582.1704071697814;7904.960475197588;8053.879191812128;8087.797805054803;8102.635381407851;8255.958720206481;485.03478078623283;561.2030916099148;582.3768567632677;584.6141546579237;587.4037851580649;3668.192997540537;3689.5203623529305;3721.5720192177705;3743.6630703236838;3799.2781371539872;53818;56590.7170464145;56782.43217567854;56980.14529782056;57141;49673;49708.75728106754;49875;50443.49556504461;51557.74221128946;46875.29687054697;46944.29583556318;47281.76359118251;47783.761081194374;47787.28319075217;7130.964345178449;7175.31834475724;7204.927950720636;7214.603196824225;7446.180920098893;31063;31499.84250078735;31678.524822127227;31880;31965.520517192726;37876.62123378841;38138.42792358062;41479.170416590896;41719.58280417279;41948;9298.95350523243;9623.422594644344;9647.662331818634;9678.75803104928;9719;9657.09451052583;9735.464549449565;9880.950595246977;9999.750006249902;10190.184785217312;9357.719268421959;9378.67174648884;9515.191208747334;9566.760830979281;9589.712308630753;9604.807903841744;9870.309078364733;10078.546465408928;10084.243681723754;10220.693379198636;9548.618055277711;9749.707508774749;9816.2147028239;9986.201103911815;10001.449920254165;8187.26314631686;8213.685810270328;8321.95839020801;8432.789180270542;8650.091740367423;7832.882506762289;8076.232757887991;8149.959250203711;8208.261256486945;8217.383696222687 23:01:02 INFO - PROCESS | 13007 | __end_tp_report 23:01:02 INFO - PROCESS | 13007 | __start_cc_report 23:01:02 INFO - PROCESS | 13007 | _x_x_mozilla_cycle_collect,964 23:01:02 INFO - PROCESS | 13007 | __end_cc_report 23:01:02 INFO - PROCESS | 13007 | __startTimestamp1463464862136__endTimestamp 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | ------- Summary: start ------- 23:01:02 INFO - PROCESS | 13007 | Number of tests: 6 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | [#0] dojo.html Cycles:165 Average:4704.99 Median:4850.54 stddev:496.31 (10.2%) stddev-sans-first:470.50 23:01:02 INFO - PROCESS | 13007 | Values: 2634.2 2664.0 2686.9 2691.0 2698.8 4553.0 4660.8 4670.9 4714.9 4809.3 4710.6 4752.4 4756.5 4793.7 4797.2 4297.0 4325.8 4329.8 4418.8 4434.1 4381.6 4442.2 4470.6 4493.6 4528.9 4423.5 4455.0 4462.8 4472.8 4504.0 4232.4 4284.9 4288.1 4293.7 4316.7 4308.5 4309.2 4318.7 4357.3 4410.3 4690.0 4703.4 4724.6 4731.3 4733.9 4921.5 5034.4 5082.0 5164.7 5182.0 5126.6 5128.2 5159.6 5165.8 5178.1 4783.2 4785.1 4804.0 4813.7 4833.5 5042.6 5130.4 5189.1 5245.2 5251.4 5040.1 5054.2 5093.1 5105.7 5112.3 5131.3 5133.2 5137.9 5160.4 5202.6 4850.5 4966.3 5017.1 5033.0 5096.9 5036.9 5038.6 5038.6 5040.8 5056.4 4357.6 4361.8 4365.5 4397.3 4405.8 3724.6 3727.2 3762.1 3792.4 3813.4 4308.1 4314.1 4316.2 4346.8 4356.5 5035.4 5039.8 5046.6 5051.7 5095.4 4192.1 4275.9 4294.8 4324.6 4329.7 4567.2 4583.4 4591.3 4598.3 4638.1 4775.1 4788.6 4789.6 4794.2 4837.2 4925.8 5112.0 5157.2 5168.5 5243.4 4876.2 4892.1 4895.6 4933.6 4945.1 5078.9 5115.5 5126.6 5127.5 5130.1 4977.0 4978.5 5003.7 5005.1 5178.5 4907.6 4908.1 4908.8 4916.7 4959.3 4895.6 4905.0 4905.7 4908.8 4954.8 4703.0 4858.1 4909.0 4916.5 4986.3 5030.9 5034.4 5036.9 5060.5 5092.4 4765.3 4921.6 4936.3 4938.6 4989.5 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | [#1] ext.html Cycles:180 Average:46494.47 Median:378328.00 stddev:83278.22 (22.0%) stddev-sans-first:83440.52 23:01:02 INFO - PROCESS | 13007 | Values: 590.1 618.1 619.3 635.7 638.0 42997.6 44296.8 44461.0 44637.1 48771.3 45203.8 45756.3 45830.3 45857.5 45866.3 7894.2 8041.3 8043.8 8045.0 8045.4 7954.4 8033.0 8041.8 8042.4 8044.1 7963.1 8063.8 8067.3 8071.1 8078.2 8004.3 8032.6 8035.4 8042.5 8044.2 7889.2 7950.1 7958.4 7962.8 7963.4 40602.8 41043.6 41077.2 41094.6 41165.8 3284.3 3721.5 3893.3 3924.3 3927.7 30401.8 30633.4 30679.4 31100.0 31777.5 3220.3 3220.5 3224.2 3299.6 3307.0 265349.0 265999.0 267487.0 267665.0 268482.0 30979.8 31167.0 31238.2 58206.0 58653.7 35997.8 36088.8 36188.0 36346.0 36353.5 13919.7 14055.2 14057.8 14061.9 14068.9 11978.9 12089.3 12148.3 12159.8 12170.6 8201.8 8278.0 8280.9 8349.5 8357.8 3208.3 3223.4 3235.9 3257.7 3272.8 898.2 949.6 989.3 1019.9 1050.5 28989.9 29079.9 29365.7 29722.7 29890.7 988.4 991.8 994.0 1002.4 1016.3 15664.8 15743.2 15801.6 15863.4 16132.9 374748.0 378133.0 378523.0 380503.1 380641.0 34554.8 35156.0 35328.3 35338.3 35388.5 1165.5 1270.4 1297.4 1303.0 1303.1 29556.3 30601.2 30772.8 30965.4 31122.7 44919.8 45012.3 45415.5 45499.8 45525.5 293185.0 293305.0 293708.0 293718.0 294810.0 23744.3 24285.6 26453.3 27185.9 27306.3 43943.3 44731.3 44788.1 45138.3 45532.8 38341.2 38504.8 39125.2 39499.4 39555.6 37874.3 38573.8 39037.8 39140.8 39276.2 37910.0 38140.2 38583.4 38894.0 38970.4 33710.5 34649.0 35213.3 35215.0 35288.3 26000.2 26377.3 27055.9 27144.3 28620.9 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | [#2] jquery.html Cycles:180 Average:24035.29 Median:4450.88 stddev:62669.33 (1408.0%) stddev-sans-first:62819.97 23:01:02 INFO - PROCESS | 13007 | Values: 384.5 387.7 391.8 400.3 410.4 17140.3 17591.7 18507.8 18539.4 18571.5 17261.7 17388.6 18050.3 18139.6 18199.2 5062.2 5190.8 5243.6 5257.7 5269.6 5338.6 5632.3 5634.1 5691.7 5715.4 5657.8 5667.7 5681.7 5691.9 5692.7 5472.0 5556.8 5573.9 5621.5 5733.6 5277.0 5422.4 5439.7 5441.6 5555.9 12001.0 12195.8 12258.3 12331.4 12332.5 1907.2 1944.7 1951.3 2030.7 2224.0 9083.5 9301.2 9366.0 9829.8 9858.2 1793.2 1820.9 1877.7 1877.8 1879.2 69607.7 71066.6 71589.0 72581.3 73108.9 10005.9 10097.3 10208.3 10265.8 10509.9 14145.9 14229.8 14271.0 14292.4 14332.7 7527.8 7593.2 7680.1 7769.7 7812.6 7449.4 7463.4 7634.8 7635.9 7664.7 4369.3 4443.6 4458.1 4510.4 4570.0 1841.9 1865.9 1901.8 1912.5 1927.5 829.5 869.8 948.6 962.4 966.8 16943.7 16999.7 17373.3 17374.0 17777.4 849.3 850.0 879.7 899.8 963.8 8889.0 9895.6 9957.2 9962.0 9988.1 366930.0 378004.0 378942.0 383198.0 386068.0 76752.6 77234.0 79315.2 80476.0 81357.0 923.9 937.7 946.4 957.0 960.9 15366.9 15647.0 15775.1 16005.2 16109.1 34194.7 35270.3 36153.6 36489.6 36984.4 48255.8 50066.0 50166.7 50324.2 50850.7 6662.9 7158.0 7973.4 7995.8 8132.1 12051.5 12079.3 12232.9 12487.8 12674.2 10056.0 10223.6 10646.7 10676.8 11127.9 10399.3 10492.9 10748.9 10814.5 10898.1 10672.8 10857.5 10943.2 11117.6 11151.4 6930.1 6940.8 7016.6 7091.9 7145.3 9378.6 10237.8 10277.8 10519.2 10600.6 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | [#3] mootools.html Cycles:180 Average:5263.05 Median:5785.46 stddev:2909.61 (50.3%) stddev-sans-first:2902.74 23:01:02 INFO - PROCESS | 13007 | Values: 1326.9 1511.4 1531.9 1715.8 1865.0 6936.6 7552.4 7766.2 7785.6 7949.1 7668.7 7946.8 7947.1 8120.2 8135.7 2215.8 2261.9 2269.7 2270.7 2271.9 2201.1 2227.4 2232.1 2233.0 2238.3 2195.1 2197.2 2201.2 2202.4 2227.8 2033.3 2057.7 2061.3 2061.6 2062.6 2128.9 2165.1 2165.2 2167.1 2167.3 7852.7 7991.5 8073.8 8077.3 8111.4 4751.6 4883.9 4887.0 4889.7 4894.5 3038.3 3048.7 3080.0 3100.6 3120.4 887.7 899.8 913.2 919.1 920.5 10612.9 10680.1 10767.6 10770.6 10777.2 4131.6 4238.9 4309.3 4317.3 4319.2 9196.4 9248.8 9250.2 9252.0 9274.4 4760.1 4763.5 4764.4 4765.9 4767.6 3805.1 3885.7 3995.8 4200.9 4238.3 3698.5 3737.6 3831.7 3842.0 3848.2 1104.2 1136.9 1144.1 1167.2 1180.9 838.0 850.4 904.3 934.8 942.7 5422.1 5795.3 5795.6 5812.4 5970.1 914.9 950.8 952.3 961.2 974.6 3959.3 4006.9 4074.3 4121.2 4170.5 9595.3 9927.9 10035.8 10044.4 10056.5 9921.7 9923.6 9924.4 9931.7 9934.6 7333.5 7590.0 7660.1 7674.2 7757.0 5713.6 5775.6 5859.9 5915.6 5948.1 8571.4 8686.8 9000.0 9052.7 9053.9 8996.8 9057.1 9064.8 9179.1 9278.5 6404.2 6521.4 6654.5 6664.7 6999.5 7497.2 7511.6 7547.3 7565.8 7577.5 6526.2 6669.3 6721.7 6747.4 6813.1 6747.5 6758.6 6804.8 6806.8 6919.4 6011.5 6144.6 6470.7 6546.8 6552.0 4666.0 4711.5 4753.1 4760.8 4789.9 4753.4 4831.4 4851.3 4914.0 4915.6 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | [#4] prototype.html Cycles:180 Average:4176.06 Median:4820.58 stddev:1208.49 (25.1%) stddev-sans-first:1176.40 23:01:02 INFO - PROCESS | 13007 | Values: 303.1 304.3 309.2 315.9 316.1 4842.3 4855.3 4865.0 4872.7 4889.3 4687.6 4697.2 4737.7 4806.6 4814.5 3596.8 3674.9 3686.5 3784.2 3803.3 3764.2 3773.4 3785.3 3785.5 3808.0 3613.7 3764.5 3774.1 3779.3 3788.3 3625.9 3702.5 3736.2 3736.8 3759.9 3288.8 3293.4 3296.4 3311.3 3314.5 4598.1 4602.7 4613.9 4639.1 4640.1 4052.9 4294.7 4306.5 4322.8 4326.2 4998.0 5009.5 5028.3 5047.5 5067.2 3601.9 3603.2 3613.9 3615.0 3627.8 5062.9 5244.6 5304.1 5309.2 5309.2 3665.8 3672.2 3672.9 3674.3 3681.9 3718.0 3718.6 3729.7 3736.8 3748.6 4210.3 4241.4 4241.7 4245.7 4269.4 4898.2 5026.0 5033.6 5043.7 5056.6 1271.1 1283.4 1286.5 1289.7 1289.9 833.9 841.4 864.7 880.7 881.1 4384.3 4389.1 4394.6 4396.6 4403.6 5073.4 5095.5 5119.6 5152.3 5157.5 4314.3 4392.0 4419.7 4430.4 4443.2 2735.7 2738.6 2749.8 2750.6 2771.0 4852.0 4922.7 4923.3 4933.8 4943.5 4998.4 5140.4 5198.5 5263.2 5286.9 4826.7 4845.8 4848.8 4854.2 4890.6 5104.8 5105.3 5106.3 5106.6 5106.8 4872.2 5040.2 5053.8 5152.0 5160.7 4934.5 4951.0 4953.4 4964.5 4965.9 3642.9 3659.5 3674.2 3680.2 3691.4 5156.8 5198.9 5232.9 5274.6 5283.8 5006.5 5030.4 5033.7 5034.5 5047.5 5002.5 5010.7 5016.6 5054.9 5058.7 4722.9 4965.0 4975.7 4983.5 4988.9 4880.0 4940.0 5073.3 5079.8 5084.1 4954.3 4968.7 4976.3 4977.5 4999.2 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - PROCESS | 13007 | [#5] yui.html Cycles:180 Average:13121.30 Median:56686.57 stddev:15639.62 (27.6%) stddev-sans-first:15655.72 23:01:02 INFO - PROCESS | 13007 | Values: 709.7 711.1 739.8 751.0 789.3 12798.9 12991.2 13173.5 13193.8 13253.9 12575.3 12716.7 12766.6 12770.0 12811.4 682.3 857.5 877.3 900.3 901.3 882.8 887.7 888.0 888.4 889.0 935.5 939.2 940.5 940.6 941.0 706.5 916.4 924.8 932.3 932.5 693.4 693.6 693.7 693.7 694.0 12282.9 12285.0 12296.6 12320.0 12354.1 12033.7 12224.2 12386.8 12434.6 12682.1 11019.2 11031.7 11033.0 11046.8 11057.1 4095.4 4138.6 4169.4 4171.6 4238.2 46988.0 47541.5 49850.5 49892.3 49955.0 9477.8 9495.4 9615.6 9672.4 9681.1 17919.7 17968.6 17978.8 18004.5 18094.5 6820.6 6907.9 6913.4 7137.1 7162.6 3704.8 3862.1 3886.6 3952.3 3966.6 2740.8 2828.1 2828.5 2832.0 2836.1 523.1 523.9 526.0 528.7 530.5 527.0 558.6 571.3 580.0 582.2 7905.0 8053.9 8087.8 8102.6 8256.0 485.0 561.2 582.4 584.6 587.4 3668.2 3689.5 3721.6 3743.7 3799.3 53818.0 56590.7 56782.4 56980.1 57141.0 49673.0 49708.8 49875.0 50443.5 51557.7 46875.3 46944.3 47281.8 47783.8 47787.3 7131.0 7175.3 7204.9 7214.6 7446.2 31063.0 31499.8 31678.5 31880.0 31965.5 37876.6 38138.4 41479.2 41719.6 41948.0 9299.0 9623.4 9647.7 9678.8 9719.0 9657.1 9735.5 9881.0 9999.8 10190.2 9357.7 9378.7 9515.2 9566.8 9589.7 9604.8 9870.3 10078.5 10084.2 10220.7 9548.6 9749.7 9816.2 9986.2 10001.4 8187.3 8213.7 8322.0 8432.8 8650.1 7832.9 8076.2 8150.0 8208.3 8217.4 23:01:02 INFO - PROCESS | 13007 | -------- Summary: end -------- 23:01:02 INFO - PROCESS | 13007 | 23:01:02 INFO - TEST-INFO | 13007: exit 0 23:01:02 INFO - TEST-OK | dromaeo_css | took 1119370ms 23:01:02 INFO - TEST-START | kraken 23:01:02 INFO - operating with platform_type : linux_ 23:01:02 INFO - Initialising browser for kraken test... 23:01:02 INFO - TEST-INFO | started process 13179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9tp9Sx/profile http://localhost:52513/getInfo.html) 23:01:07 INFO - PROCESS | 13179 | __metrics Screen width/height:1600/1200 23:01:07 INFO - PROCESS | 13179 | colorDepth:24 23:01:07 INFO - PROCESS | 13179 | Browser inner width/height: 1024/697 23:01:07 INFO - PROCESS | 13179 | __metrics 23:01:08 ERROR - PROCESS | 13179 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:01:09 INFO - TEST-INFO | 13179: exit 0 23:01:09 INFO - Browser initialized. 23:01:09 INFO - Running cycle 1/1 for kraken test... 23:01:09 INFO - TEST-INFO | started process 13256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9tp9Sx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:21 INFO - PROCESS | 13256 | RSS: Main: 154898432 23:01:21 INFO - PROCESS | 13256 | 23:01:24 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52513/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:25 INFO - PROCESS | 13256 | RSS: Main: 210112512 23:01:25 INFO - PROCESS | 13256 | 23:01:28 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52513/tests/kraken/driver.html?testName=audio-dft) 23:01:28 INFO - PROCESS | 13256 | RSS: Main: 198049792 23:01:28 INFO - PROCESS | 13256 | 23:01:32 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52513/tests/kraken/driver.html?testName=audio-fft) 23:01:32 INFO - PROCESS | 13256 | RSS: Main: 266604544 23:01:32 INFO - PROCESS | 13256 | 23:01:34 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52513/tests/kraken/driver.html?testName=audio-oscillator) 23:01:35 INFO - PROCESS | 13256 | RSS: Main: 175869952 23:01:35 INFO - PROCESS | 13256 | 23:01:37 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:38 INFO - PROCESS | 13256 | RSS: Main: 179376128 23:01:38 INFO - PROCESS | 13256 | 23:01:41 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52513/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:42 INFO - PROCESS | 13256 | RSS: Main: 215564288 23:01:42 INFO - PROCESS | 13256 | 23:01:46 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52513/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:46 INFO - PROCESS | 13256 | RSS: Main: 213921792 23:01:46 INFO - PROCESS | 13256 | 23:01:49 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52513/tests/kraken/driver.html?testName=json-parse-financial) 23:01:50 INFO - PROCESS | 13256 | RSS: Main: 214048768 23:01:50 INFO - PROCESS | 13256 | 23:01:52 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:52 INFO - PROCESS | 13256 | RSS: Main: 207974400 23:01:52 INFO - PROCESS | 13256 | 23:01:54 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:55 INFO - PROCESS | 13256 | RSS: Main: 210206720 23:01:55 INFO - PROCESS | 13256 | 23:01:57 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:58 INFO - PROCESS | 13256 | RSS: Main: 216014848 23:01:58 INFO - PROCESS | 13256 | 23:02:01 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:02:01 INFO - PROCESS | 13256 | RSS: Main: 220086272 23:02:01 INFO - PROCESS | 13256 | 23:02:04 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:02:05 INFO - PROCESS | 13256 | RSS: Main: 220237824 23:02:05 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | Cycle 1(1): loaded http://localhost:52513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52513/tests/kraken/driver.html?testName=ai-astar) 23:02:07 INFO - PROCESS | 13256 | RSS: Main: 266002432 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | __start_tp_report 23:02:07 INFO - PROCESS | 13256 | _x_x_mozilla_page_load 23:02:07 INFO - PROCESS | 13256 | _x_x_mozilla_page_load_details 23:02:07 INFO - PROCESS | 13256 | |i|pagename|runs| 23:02:07 INFO - PROCESS | 13256 | |0;ai-astar;114;110;113;114;115;113;113;114;114;115 23:02:07 INFO - PROCESS | 13256 | |1;audio-beat-detection;165;129;150;212;131;156;164;138;181;133 23:02:07 INFO - PROCESS | 13256 | |2;audio-dft;167;164;165;163;165;164;164;163;164;162 23:02:07 INFO - PROCESS | 13256 | |3;audio-fft;77;77;75;145;75;75;77;76;128;75 23:02:07 INFO - PROCESS | 13256 | |4;audio-oscillator;93;92;145;92;92;92;127;92;92;121 23:02:07 INFO - PROCESS | 13256 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;117;117 23:02:07 INFO - PROCESS | 13256 | |6;imaging-darkroom;146;145;145;146;145;146;146;146;145;145 23:02:07 INFO - PROCESS | 13256 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 23:02:07 INFO - PROCESS | 13256 | |8;json-parse-financial;62;64;62;62;63;64;65;63;63;63 23:02:07 INFO - PROCESS | 13256 | |9;json-stringify-tinderbox;65;63;64;65;64;65;65;64;65;64 23:02:07 INFO - PROCESS | 13256 | |10;stanford-crypto-aes;82;82;82;84;82;91;90;86;149;82 23:02:07 INFO - PROCESS | 13256 | |11;stanford-crypto-ccm;132;130;129;129;129;127;130;127;150;140 23:02:07 INFO - PROCESS | 13256 | |12;stanford-crypto-pbkdf2;173;169;173;172;169;169;169;172;174;174 23:02:07 INFO - PROCESS | 13256 | |13;stanford-crypto-sha256-iterative;68;68;66;66;66;66;65;64;64;65 23:02:07 INFO - PROCESS | 13256 | __end_tp_report 23:02:07 INFO - PROCESS | 13256 | __start_cc_report 23:02:07 INFO - PROCESS | 13256 | _x_x_mozilla_cycle_collect,2032 23:02:07 INFO - PROCESS | 13256 | __end_cc_report 23:02:07 INFO - PROCESS | 13256 | __startTimestamp1463464927381__endTimestamp 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | ------- Summary: start ------- 23:02:07 INFO - PROCESS | 13256 | Number of tests: 14 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 23:02:07 INFO - PROCESS | 13256 | Values: 114.0 110.0 113.0 114.0 115.0 113.0 113.0 114.0 114.0 115.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:160.00 stddev:26.14 (16.3%) stddev-sans-first:27.52 23:02:07 INFO - PROCESS | 13256 | Values: 165.0 129.0 150.0 212.0 131.0 156.0 164.0 138.0 181.0 133.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.37 (0.8%) stddev-sans-first:0.97 23:02:07 INFO - PROCESS | 13256 | Values: 167.0 164.0 165.0 163.0 165.0 164.0 164.0 163.0 164.0 162.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#3] audio-fft Cycles:10 Average:88.00 Median:75.50 stddev:25.89 (34.3%) stddev-sans-first:27.15 23:02:07 INFO - PROCESS | 13256 | Values: 77.0 77.0 75.0 145.0 75.0 75.0 77.0 76.0 128.0 75.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:92.00 stddev:19.67 (21.4%) stddev-sans-first:20.48 23:02:07 INFO - PROCESS | 13256 | Values: 93.0 92.0 145.0 92.0 92.0 92.0 127.0 92.0 92.0 121.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:02:07 INFO - PROCESS | 13256 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 23:02:07 INFO - PROCESS | 13256 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:02:07 INFO - PROCESS | 13256 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 23:02:07 INFO - PROCESS | 13256 | Values: 62.0 64.0 62.0 62.0 63.0 64.0 65.0 63.0 63.0 63.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 23:02:07 INFO - PROCESS | 13256 | Values: 65.0 63.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 64.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:83.00 stddev:20.67 (24.9%) stddev-sans-first:21.66 23:02:07 INFO - PROCESS | 13256 | Values: 82.0 82.0 82.0 84.0 82.0 91.0 90.0 86.0 149.0 82.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:130.00 stddev:7.24 (5.6%) stddev-sans-first:7.68 23:02:07 INFO - PROCESS | 13256 | Values: 132.0 130.0 129.0 129.0 129.0 127.0 130.0 127.0 150.0 140.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.50 stddev:2.17 (1.3%) stddev-sans-first:2.22 23:02:07 INFO - PROCESS | 13256 | Values: 173.0 169.0 173.0 172.0 169.0 169.0 169.0 172.0 174.0 174.0 23:02:07 INFO - PROCESS | 13256 | 23:02:07 INFO - PROCESS | 13256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.24 23:02:07 INFO - PROCESS | 13256 | Values: 68.0 68.0 66.0 66.0 66.0 66.0 65.0 64.0 64.0 65.0 23:02:07 INFO - PROCESS | 13256 | -------- Summary: end -------- 23:02:07 INFO - PROCESS | 13256 | 23:02:08 INFO - TEST-INFO | 13256: exit 0 23:02:08 INFO - TEST-OK | kraken | took 65467ms 23:02:08 INFO - SUITE-END | took 1184s 23:02:08 INFO - Completed test suite (00:19:44) 23:02:08 INFO - javascript benchmark 23:02:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.2360715392538, 2663.9866800665995, 2686.9462610747773, 2690.959635605466, 2698.7975901807367, 4553.0, 4660.836870709526, 4670.883227919304, 4714.939138693797, 4809.254565542342, 4710.552497512731, 4752.358431611731, 4756.476787553375, 4793.7363445010515, 4797.184478638631, 4297.03316753731, 4325.848595299165, 4329.848455304065, 4418.845340413094, 4434.113177364524, 4381.583749543788, 4442.222611043071, 4470.619997300233, 4493.573110554492, 4528.864134075983, 4423.469183697945, 4455.04216593434, 4462.799174037176, 4472.798724057425, 4504.009117994053, 4232.4286221360335, 4284.850030248957, 4288.078063216423, 4293.699441039129, 4316.719413238129, 4308.482982042144, 4309.159713855799, 4318.654507639413, 4357.302831546969, 4410.316400957857, 4690.01509682967, 4703.388559487279, 4724.574788269072, 4731.290306454025, 4733.857984260478, 4921.458639549646, 5034.370703662043, 5082.034413461467, 5164.715940623264, 5182.0, 5126.61550383719, 5128.179491281415, 5159.58723302135, 5165.767540460688, 5178.119719647631, 4783.1868582341085, 4785.114753770529, 4804.015176888729, 4813.663043586916, 4833.540813622701, 5042.596592272609, 5130.4100028497205, 5189.091908915924, 5245.213218017251, 5251.396089449686, 5040.1179793535985, 5054.21659642756, 5093.0577843099145, 5105.693658380509, 5112.335396398519, 5131.25596788471, 5133.178691409356, 5137.922931156036, 5160.432352441228, 5202.609804264695, 4850.539198776181, 4966.329545511309, 5017.071841709296, 5033.043721692867, 5096.898062038813, 5036.874078148076, 5038.571721403649, 5038.571721403721, 5040.798368065236, 5056.367954005749, 4357.586029327209, 4361.760103194291, 4365.4979677337515, 4397.31841564558, 4405.757683327448, 3724.646158614927, 3727.2172843703124, 3762.097096696828, 3792.4311353297226, 3813.427985802152, 4308.138372325548, 4314.115606300764, 4316.223079845658, 4346.7609281489185, 4356.520782713899, 5035.370578677665, 5039.823606173766, 5046.571041461443, 5051.747412629354, 5095.414027386824, 4192.140611174702, 4275.87172384829, 4294.7852607369505, 4324.589164029412, 4329.653627709776, 4567.155076310827, 4583.358329833826, 4591.265397536378, 4598.287265473857, 4638.072385522909, 4775.116603428377, 4788.61691064721, 4789.568938795455, 4794.232922732346, 4837.177679794373, 4925.778339974638, 5111.977604479193, 5157.174852023658, 5168.457311982188, 5243.370795504564, 4876.244182151772, 4892.0705066037335, 4895.559399654048, 4933.605311575137, 4945.1346014448045, 5078.949210507848, 5115.514026167508, 5126.641135120506, 5127.512886275797, 5130.076586214517, 4976.950230497649, 4978.477259887804, 5003.699778013331, 5005.1241032819835, 5178.459048817729, 4907.60739140875, 4908.141075311734, 4908.779104940358, 4916.704997700006, 4959.280904268933, 4895.63282753802, 4904.975475122602, 4905.681130726634, 4908.779104940358, 4954.752262386794, 4702.952970470252, 4858.125537403302, 4909.018196360814, 4916.508349165055, 4986.32684587576, 5030.949690503195, 5034.370703662043, 5036.949630503795, 5060.49395060491, 5092.414372347227, 4765.332853400596, 4921.630877684116, 4936.259561065869, 4938.580220681282, 4989.451160372429], "value": 4673.327880814663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.1325052173304, 618.0667192539265, 619.2785405003169, 635.7425242776676, 637.9872402551952, 42997.57002429975, 44296.77851610746, 44461.0, 44637.10725785486, 48771.26843097356, 45203.77398113013, 45756.31365529511, 45830.31254531176, 45857.54142458575, 45866.312005319865, 7894.17111203324, 8041.276285134337, 8043.758687239392, 8045.0, 8045.356371490296, 7954.443188976774, 8033.0, 8041.798955026113, 8042.396820238476, 8044.074931382907, 7963.124056353826, 8063.798405039892, 8067.314278286323, 8071.112177660452, 8078.23256790604, 8004.319632831216, 8032.558209298486, 8035.397345199133, 8042.517448953023, 8044.235797599219, 7889.2110788920645, 7950.1254861965135, 7958.363330933512, 7962.840743185162, 7963.4027447941635, 40602.79698601488, 41043.58956410427, 41077.1784564307, 41094.589054109376, 41165.79417102925, 3284.310294838087, 3721.4789929409903, 3893.2602805467154, 3924.2543916655745, 3927.7446965947124, 30401.847990760125, 30633.38733225323, 30679.38641227185, 31100.0, 31777.52333714996, 3220.259340351709, 3220.5256421704207, 3224.1778346521724, 3299.554560134375, 3306.9503957440656, 265349.0, 265999.0, 267487.0, 267664.9999999981, 268482.0, 30979.845100774353, 31167.0, 31238.21904452407, 58206.0, 58653.706731466926, 35997.8200109003, 36088.81955590205, 36188.0, 36346.0, 36353.45469817955, 13919.721605567833, 14055.226962516956, 14057.78913316301, 14061.929690351688, 14068.859311406755, 11978.880211197951, 12089.274643521418, 12148.271103733805, 12159.756804863853, 12170.57402990891, 8201.79495512617, 8277.95861020691, 8280.917190828015, 8349.540775257297, 8357.8328433431, 3208.342289830579, 3223.3714425686767, 3235.902922912316, 3257.7358735678476, 3272.8199949003033, 898.2364989758784, 949.6183053656913, 989.3470309595632, 1019.8827134879435, 1050.5220124843179, 28989.85505072461, 29079.854600727285, 29365.706342936297, 29722.702772971992, 29890.70109298879, 988.367444835306, 991.7768502086973, 993.9950300248597, 1002.3737806945703, 1016.3343010328247, 15664.765028524582, 15743.212839357986, 15801.604959875865, 15863.444779432664, 16132.919335403249, 374748.0, 378133.0, 378523.0, 380503.0974845108, 380641.0, 34554.82722586371, 35156.0, 35328.29343413117, 35338.293234135686, 35388.469172962425, 1165.4755360087825, 1270.4029106320015, 1297.3837427222184, 1302.9869701302866, 1303.1008604063165, 29556.261093472836, 30601.23496912595, 30772.846135769178, 30965.380692385577, 31122.68877311198, 44919.77540112409, 45012.32481512846, 45415.545844541135, 45499.77250113728, 45525.54474455213, 293185.0, 293305.0, 293708.0, 293718.0, 294810.0, 23744.287671369886, 24285.600015998127, 26453.33866653272, 27185.86407067952, 27306.317342066606, 43943.340849887914, 44731.32903006522, 44788.05810374778, 45138.322925155495, 45532.77233613811, 38341.23317533689, 38504.80747596244, 39125.2174956505, 39499.40750888796, 39555.60444395519, 37874.31505651894, 38573.80713096417, 39037.804810975766, 39140.804295978334, 39276.2144757109, 37910.0, 38140.23719525539, 38583.42124868185, 38894.0, 38970.415443768936, 33710.49434258537, 34649.0, 35213.29573408466, 35215.0, 35288.29423411466, 26000.219993400227, 26377.340566485993, 27055.86472067627, 27144.321391965357, 28620.856895715388], "value": 17094.750433131874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.47135189114965, 387.7285899870092, 391.77472953051995, 400.3114642814358, 410.3782769104807, 17140.314387424503, 17591.73612395815, 18507.81492185078, 18539.44381668549, 18571.5357116072, 17261.741073883903, 17388.56528586786, 18050.27798888043, 18139.637207255848, 18199.18103685334, 5062.2406639004075, 5190.792368305263, 5243.554297884684, 5257.737113144347, 5269.552088072518, 5338.599605029619, 5632.295963004624, 5634.0703783875815, 5691.686957217351, 5715.37130915601, 5657.773689052433, 5667.659940403569, 5681.715914204294, 5691.886162276752, 5692.715364231793, 5471.972640136793, 5556.833295001156, 5573.916391254134, 5621.522170615503, 5733.627314224562, 5276.9736151319385, 5422.40353561108, 5439.673619582798, 5441.564674826004, 5555.8888822223325, 12001.0, 12195.756084878252, 12258.325792081432, 12331.445084971198, 12332.506699732, 1907.1894444861018, 1944.6791279438876, 1951.346298989826, 2030.6547886859269, 2223.9555208895895, 9083.500407477586, 9301.162895339452, 9366.0, 9829.754256143582, 9858.211343092535, 1793.246836328745, 1820.8816426932208, 1877.6995680691025, 1877.8216069473378, 1879.1637721214065, 69607.65196173987, 71066.64466677685, 71589.0, 72581.27418725798, 73108.90336645007, 10005.899941000642, 10097.343672661253, 10208.336458130347, 10265.846012309821, 10509.9474502627, 14145.858541414455, 14229.78655320171, 14271.0, 14292.356843942047, 14332.713345733027, 7527.757919943258, 7593.164751877289, 7680.116786569504, 7769.689212431553, 7812.57030863308, 7449.441291903129, 7463.440241981873, 7634.770956871303, 7635.885461718079, 7664.731734389381, 4369.257226271541, 4443.644508439317, 4458.108378324348, 4510.391097201836, 4569.954300456953, 1841.8618603604784, 1865.9160337784833, 1901.7622797150357, 1912.5218695326168, 1927.5181204698824, 829.5031953818927, 869.8216865542548, 948.5684013773716, 962.3504134709043, 966.7969726357403, 16943.661126777395, 16999.660006799793, 17373.3050677974, 17374.0, 17777.377791777224, 849.3417601358873, 849.9970035358336, 879.683314006957, 899.820035992804, 963.8072385522923, 8888.955555222312, 9895.604175832887, 9957.153641940517, 9962.0, 9988.101070903653, 366930.0, 378004.0, 378942.0, 383198.0, 386068.0, 76752.61623691846, 77234.0, 79315.20684793194, 80476.0, 81357.0, 923.9353245272766, 937.7046230437254, 946.3753922411175, 956.9712908612753, 960.8991055939166, 15366.923165384102, 15647.0, 15775.132367719885, 16005.19974001272, 16109.113998729714, 34194.658053419145, 35270.29459410849, 36153.63846361608, 36489.63510364862, 36984.445233320985, 48255.75872120617, 50066.0, 50166.749166255395, 50324.24513632372, 50850.745746272514, 6662.933370666231, 7158.0, 7973.401994850294, 7995.760127196193, 8132.064812546396, 12051.457684404048, 12079.335636539723, 12232.938835306122, 12487.812682809583, 12674.176178548365, 10056.0, 10223.591056357662, 10646.73383165396, 10676.786464270826, 11127.944360278147, 10399.32404393712, 10492.895071049192, 10748.850229954196, 10814.513346899252, 10898.07366373867, 10672.786544268916, 10857.511411986321, 10943.233973621771, 11117.610883619034, 11151.442427878412, 6930.099087118642, 6940.826479338057, 7016.614086225102, 7091.858162836817, 7145.321194486515, 9378.5779639915, 10237.795244095225, 10277.794444111225, 10519.21105917044, 10600.575976960836], "value": 8310.60676397363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.8673132686727, 1511.4181040299482, 1531.877449804016, 1715.759793628892, 1865.0022238102617, 6936.583804971705, 7552.358049565787, 7766.184550622188, 7785.571793551359, 7949.12559618443, 7668.693252269903, 7946.801329966754, 7947.086085100215, 8120.228578285069, 8135.674573017072, 2215.8448908576406, 2261.8529795563236, 2269.716285464317, 2270.6821045053707, 2271.852329598579, 2201.0975500044983, 2227.4074037063497, 2232.0960011195493, 2232.9888350558226, 2238.306125101216, 2195.0890380492156, 2197.2419515267206, 2201.2295696506253, 2202.449387653087, 2227.7772222777676, 2033.3391647714477, 2057.7324947756847, 2061.309461330441, 2061.6082944240547, 2062.587482503498, 2128.936131916045, 2165.090661921981, 2165.1880544795704, 2167.0573300614283, 2167.349795061491, 7852.685892564291, 7991.480553763987, 8073.798155046112, 8077.313428358597, 8111.391645626542, 4751.596114330251, 4883.8779030524165, 4886.99816537609, 4889.657723959324, 4894.461609222983, 3038.270815004405, 3048.725614694688, 3079.9538006929915, 3100.643426005993, 3120.40712264669, 887.7128164161926, 899.7885496908222, 913.2374467319796, 919.1406035356896, 920.4799288402098, 10612.946935265352, 10680.092192163675, 10767.569297228101, 10770.569177232901, 10777.191710621657, 4131.607497287753, 4238.936415953764, 4309.288967320357, 4317.266064768997, 4319.244132276839, 9196.448213107102, 9248.815023699488, 9250.167484926389, 9252.028537003653, 9274.350795444388, 4760.143174228603, 4763.523647635278, 4764.404449443819, 4765.857024289207, 4767.594754445841, 3805.1248212911187, 3885.747426417274, 3995.800209989489, 4200.894977625584, 4238.258304796648, 3698.4637227601847, 3737.5701794294005, 3831.712621553339, 3841.961580384216, 3848.153406250676, 1104.1829046505527, 1136.8578927634046, 1144.1418935798151, 1167.1946357013633, 1180.8582970043649, 837.9734824839522, 850.3622283287534, 904.3488688144525, 934.8036912248504, 942.7454587261539, 5422.078246697992, 5795.333536643256, 5795.623284486495, 5812.447817457335, 5970.0746384310505, 914.8947870994788, 950.7623094226443, 952.3333666433524, 961.1781926452921, 974.551706215149, 3959.3172901517314, 4006.899827504336, 4074.348104303297, 4121.237571049305, 4170.541240463546, 9595.328327017181, 9927.900720992697, 10035.849462258071, 10044.397336159855, 10056.547455364525, 9921.702348929544, 9923.60305587783, 9924.354916930377, 9931.65239216624, 9934.602615895283, 7333.523320984119, 7590.0, 7660.119086305146, 7674.194209608022, 7756.961215194001, 5713.628614140068, 5775.595708300547, 5859.882802343844, 5915.6450612961635, 5948.13752005948, 8571.4000019998, 8686.78283042929, 9000.0, 9052.683156089506, 9053.913530376398, 8996.820063598821, 9057.09429057089, 9064.773380665536, 9179.082091791035, 9278.536073196448, 6404.199475065617, 6521.380468855451, 6654.500912431684, 6664.666766661744, 6999.47503937217, 7497.175310715926, 7511.62441877893, 7547.320741133324, 7565.848683026419, 7577.507462014952, 6526.184226971629, 6669.333066693292, 6721.663916804238, 6747.392734653708, 6813.080234168324, 6747.527673062838, 6758.560693554903, 6804.829879253059, 6806.7957961261245, 6919.411849992807, 6011.549133814894, 6144.631322120687, 6470.741170353322, 6546.803595892131, 6552.049952756919, 4666.0, 4711.458182309078, 4753.073150735711, 4760.8333708321425, 4789.856304310876, 4753.405824271966, 4831.371921650163, 4851.296561998561, 4913.950860491349, 4915.557599816034], "value": 4252.614325350564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.0801517394707, 304.33654632900283, 309.22539039705543, 315.8831232443996, 316.0754792232719, 4842.322074909511, 4855.295982082596, 4865.0, 4872.65891387603, 4889.291052797346, 4687.648426368019, 4697.201475749122, 4737.715737055779, 4806.567408933195, 4814.494478079804, 3596.766210196342, 3674.9448758268645, 3686.548445283883, 3784.2242340320304, 3803.3075281499746, 3764.209516001643, 3773.3963065697108, 3785.337565925952, 3785.4889589905288, 3807.9619203808024, 3613.728970327236, 3764.454154147647, 3774.1130834253927, 3779.319722449972, 3788.3181027415053, 3625.909352266188, 3702.463142844286, 3736.1978516112918, 3736.785544697957, 3759.924801503982, 3288.786228895114, 3293.440115180425, 3296.3901678189613, 3311.2880730642787, 3314.5359649649067, 4598.126355992351, 4602.746848923308, 4613.907721845544, 4639.095376401603, 4640.141573808823, 4052.939205911884, 4294.656427485794, 4306.5262821089655, 4322.805473753657, 4326.199653064162, 4997.9750101249265, 5009.499050094998, 5028.34631497903, 5047.520485553867, 5067.214581739836, 3601.927961440783, 3603.1532589841368, 3613.8915832524804, 3614.987803415048, 3627.818609069562, 5062.949370506285, 5244.580433565267, 5304.071787437183, 5309.150535914235, 5309.230161626581, 3665.8167091645846, 3672.1737609037755, 3672.9164896355637, 3674.3018826422895, 3681.9263614727556, 3718.0, 3718.6467285607823, 3729.701623870084, 3736.75711078779, 3748.55017397914, 4210.263203939298, 4241.384999175102, 4241.660667146621, 4245.745255284693, 4269.380939763779, 4898.21628539432, 5026.0, 5033.622478314068, 5043.697378157322, 5056.595472362203, 1271.1356277731047, 1283.4224598930332, 1286.530416398008, 1289.6646871813396, 1289.9100260280047, 833.8749187621905, 841.427829076234, 864.7115797461737, 880.6697488441835, 881.1144799476485, 4384.254676704968, 4389.144116897174, 4394.648428125743, 4396.582324679151, 4403.625691816167, 5073.441921388644, 5095.490450954875, 5119.564836988898, 5152.3044389007755, 5157.510036546597, 4314.331278651814, 4391.956080439219, 4419.734815911055, 4430.386072217407, 4443.178012067778, 2735.7401046900513, 2738.589211618273, 2749.752522273005, 2750.6286651301816, 2770.972290277112, 4852.010675622978, 4922.729249891218, 4923.310736496894, 4933.827316043921, 4943.505649435099, 4998.4251811042195, 5140.434552199255, 5198.506141916512, 5263.236830659533, 5286.894262114736, 4826.6621336506105, 4845.75771211438, 4848.8302909398, 4854.160316214912, 4890.559849613552, 5104.846854594368, 5105.285260063668, 5106.259592359162, 5106.617003724661, 5106.829597421155, 4872.244802055687, 5040.193569028937, 5053.84838454847, 5152.0, 5160.664556803796, 4934.544309428656, 4950.975245123751, 4953.380827396575, 4964.503549645006, 4965.900681986413, 3642.8724994625063, 3659.5425571803526, 3674.154944362758, 3680.2087551176623, 3691.390920498195, 5156.819511317086, 5198.922016169685, 5232.947670523246, 5274.604404669589, 5283.788648454019, 5006.499350064964, 5030.4466508684745, 5033.672811267256, 5034.521720436553, 5047.4952504749235, 5002.549770520671, 5010.69935803853, 5016.573591244639, 5054.924176137434, 5058.721770302669, 4722.905541889212, 4965.031818795444, 4975.676581022222, 4983.4518202996915, 4988.8752781180765, 4880.0, 4940.0, 5073.264376665289, 5079.822206222764, 5084.059449001798, 4954.315532718892, 4968.652194346361, 4976.253561965734, 4977.477364876636, 4999.150144475375], "value": 3795.6520088871143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.6664567653203, 711.12531586149, 739.8298391369984, 750.9511881727688, 789.2817536042201, 12798.872011279884, 12991.2205267684, 13173.473061077557, 13193.80209296859, 13253.867461325384, 12575.308358040304, 12716.745665086693, 12766.55317063903, 12770.0, 12811.42348594313, 682.3449488491054, 857.4555157475017, 877.3419935048713, 900.2572877376158, 901.2834796336928, 882.814608932125, 887.6848718704831, 888.0, 888.404768804899, 889.0043151670138, 935.5322338830584, 939.1829108675428, 940.47333493244, 940.5861420974784, 941.0448394879203, 706.4701473894579, 916.3539704508306, 924.7688077980505, 932.3333816321328, 932.5197523275484, 693.4417793676089, 693.639307560071, 693.6947742993067, 693.7121094745675, 694.0144994108379, 12282.938585307016, 12285.0, 12296.585892622285, 12320.01439884807, 12354.0734444917, 12033.699157521045, 12224.205426647239, 12386.81419778704, 12434.564790232389, 12682.112252142262, 11019.228653994223, 11031.72420689481, 11033.0, 11046.834297485544, 11057.11543076552, 4095.365218391154, 4138.6482149017365, 4169.395437661552, 4171.6036976487185, 4238.173556156551, 46988.0, 47541.52458475406, 49850.50149498495, 49892.25161622579, 49954.999999999636, 9477.810443791086, 9495.430274183433, 9615.56729947154, 9672.419654820733, 9681.112183124364, 17919.73120403195, 17968.640627187382, 17978.820211797974, 18004.459866204033, 18094.457166285032, 6820.556663816836, 6907.896381554281, 6913.412359949461, 7137.072180616487, 7162.570245785166, 3704.814759262026, 3862.111714305669, 3886.553046399644, 3952.3083460394314, 3966.6033396660105, 2740.780737540992, 2828.0808737160505, 2828.5191517442086, 2831.971680283212, 2836.078274560776, 523.113322917651, 523.8637954131877, 526.0294756174851, 528.7092099345344, 530.4589318894706, 526.9894602107936, 558.600600570594, 571.3229822660161, 579.959402841797, 582.1704071697814, 7904.960475197588, 8053.879191812128, 8087.797805054803, 8102.635381407851, 8255.958720206481, 485.03478078623283, 561.2030916099148, 582.3768567632677, 584.6141546579237, 587.4037851580649, 3668.192997540537, 3689.5203623529305, 3721.5720192177705, 3743.6630703236838, 3799.2781371539872, 53818.0, 56590.7170464145, 56782.43217567854, 56980.14529782056, 57141.0, 49673.0, 49708.75728106754, 49875.0, 50443.49556504461, 51557.74221128946, 46875.29687054697, 46944.29583556318, 47281.76359118251, 47783.761081194374, 47787.28319075217, 7130.964345178449, 7175.31834475724, 7204.927950720636, 7214.603196824225, 7446.180920098893, 31063.0, 31499.84250078735, 31678.524822127227, 31880.0, 31965.520517192726, 37876.62123378841, 38138.42792358062, 41479.170416590896, 41719.58280417279, 41948.0, 9298.95350523243, 9623.422594644344, 9647.662331818634, 9678.75803104928, 9719.0, 9657.09451052583, 9735.464549449565, 9880.950595246977, 9999.750006249902, 10190.184785217312, 9357.719268421959, 9378.67174648884, 9515.191208747334, 9566.760830979281, 9589.712308630753, 9604.807903841744, 9870.309078364733, 10078.546465408928, 10084.243681723754, 10220.693379198636, 9548.618055277711, 9749.707508774749, 9816.2147028239, 9986.201103911815, 10001.449920254165, 8187.26314631686, 8213.685810270328, 8321.95839020801, 8432.789180270542, 8650.091740367423, 7832.882506762289, 8076.232757887991, 8149.959250203711, 8208.261256486945, 8217.383696222687], "value": 5974.154305288572, "unit": "score"}], "name": "dromaeo_css", "value": 6325.061256243699, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 113.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 129.0, 150.0, 212.0, 131.0, 156.0, 164.0, 138.0, 181.0, 133.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 165.0, 163.0, 165.0, 164.0, 164.0, 163.0, 164.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 145.0, 75.0, 75.0, 77.0, 76.0, 128.0, 75.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 145.0, 92.0, 92.0, 92.0, 127.0, 92.0, 92.0, 121.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 64.0, 65.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 84.0, 82.0, 91.0, 90.0, 86.0, 149.0, 82.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 129.0, 129.0, 129.0, 127.0, 130.0, 127.0, 150.0, 140.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 173.0, 172.0, 169.0, 169.0, 169.0, 172.0, 174.0, 174.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 66.0, 66.0, 65.0, 64.0, 64.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1570.7, "alertThreshold": 2.0}]} 23:02:08 INFO - Return code: 0 23:02:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:02:08 ERROR - # TBPL SUCCESS # 23:02:08 INFO - Running post-action listener: _resource_record_post_action 23:02:08 INFO - ##### 23:02:08 INFO - ##### Finished run-tests step (success) 23:02:08 INFO - ##### 23:02:08 INFO - Running post-run listener: _resource_record_post_run 23:02:08 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 528621568; Read time: 0; Write time: 468856 23:02:08 INFO - TinderboxPrint: CPU usage
13.1% 23:02:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:02:08 INFO - TinderboxPrint: I/O write bytes / time
528,621,568 / 468,856 23:02:08 INFO - TinderboxPrint: CPU idle
8,338.9 (86.9%) 23:02:08 INFO - TinderboxPrint: CPU user
1,211.8 (12.6%) 23:02:08 INFO - TinderboxPrint: Swap in / out
0 / 0 23:02:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236421120; Read time: 0; Write time: 241824 23:02:08 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292200448; Read time: 0; Write time: 227032 23:02:09 INFO - Running post-run listener: _upload_blobber_files 23:02:09 INFO - Blob upload gear active. 23:02:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:02:09 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 23:02:09 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'] 23:02:09 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 23:02:09 INFO - (blobuploader) - INFO - Open directory for files ... 23:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:02:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:10 INFO - (blobuploader) - INFO - Done attempting. 23:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:11 INFO - (blobuploader) - INFO - Done attempting. 23:02:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:02:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:16 INFO - (blobuploader) - INFO - Done attempting. 23:02:16 INFO - (blobuploader) - INFO - Iteration through files over. 23:02:16 INFO - Return code: 0 23:02:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:02:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:02:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5522a3753da59f695d4445c768c8bd3aae1cbc08f1012d6e53f3e4676dfb4cf6b3ec86d90eb2c562fea92e41b4b7dd26cd0df032f6077edf0758898e2396967d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4914b8b696f82caa078ea8a5d01bc540cf1a7d19b83f8b9f21d50f386d34fbe2e723ddbe51f1c489ee83aba18b1dd611a7f160959249157577ed589db48395a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c1a4235a514ec038456c4505b3a480de94803cdc125efa275bad900fca6211d480167155dd7ace2cd13191e643090e2ce1d120fa4d7b571faa2cfa2cd8411f0"} 23:02:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:02:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:02:16 INFO - Contents: 23:02:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5522a3753da59f695d4445c768c8bd3aae1cbc08f1012d6e53f3e4676dfb4cf6b3ec86d90eb2c562fea92e41b4b7dd26cd0df032f6077edf0758898e2396967d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4914b8b696f82caa078ea8a5d01bc540cf1a7d19b83f8b9f21d50f386d34fbe2e723ddbe51f1c489ee83aba18b1dd611a7f160959249157577ed589db48395a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c1a4235a514ec038456c4505b3a480de94803cdc125efa275bad900fca6211d480167155dd7ace2cd13191e643090e2ce1d120fa4d7b571faa2cfa2cd8411f0"} 23:02:16 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:16 INFO - Copying logs to upload dir... 23:02:16 INFO - mkdir: /builds/slave/test/build/upload/logs 23:02:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.564270 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-16 23:02:16.003099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:16.007456) ========= 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=7de08804244eb36560b44971000001c3-1463463282.858536-1397964085 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/5522a3753da59f695d4445c768c8bd3aae1cbc08f1012d6e53f3e4676dfb4cf6b3ec86d90eb2c562fea92e41b4b7dd26cd0df032f6077edf0758898e2396967d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4914b8b696f82caa078ea8a5d01bc540cf1a7d19b83f8b9f21d50f386d34fbe2e723ddbe51f1c489ee83aba18b1dd611a7f160959249157577ed589db48395a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c1a4235a514ec038456c4505b3a480de94803cdc125efa275bad900fca6211d480167155dd7ace2cd13191e643090e2ce1d120fa4d7b571faa2cfa2cd8411f0"} build_url:https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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/5522a3753da59f695d4445c768c8bd3aae1cbc08f1012d6e53f3e4676dfb4cf6b3ec86d90eb2c562fea92e41b4b7dd26cd0df032f6077edf0758898e2396967d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4914b8b696f82caa078ea8a5d01bc540cf1a7d19b83f8b9f21d50f386d34fbe2e723ddbe51f1c489ee83aba18b1dd611a7f160959249157577ed589db48395a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c1a4235a514ec038456c4505b3a480de94803cdc125efa275bad900fca6211d480167155dd7ace2cd13191e643090e2ce1d120fa4d7b571faa2cfa2cd8411f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:16.041088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:16.042006) ========= 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=7de08804244eb36560b44971000001c3-1463463282.858536-1397964085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:16.123473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:02:16.123899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:02:16.124256) ========= ========= Total master_lag: 0.19 =========