builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1463465361.67 results: success (0) buildid: 20160516203022 builduid: efc89e00935144db8a7ba6e2355dcf1f revision: c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.667978) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.668461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.668831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.684730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.685000) ========= 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=62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 23:09:21-- 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% 226M=0s 2016-05-16 23:09:22 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.784566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.784865) ========= 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=62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.833951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:21.834274) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c --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 c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c --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=62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 23:09:22,165 truncating revision to first 12 chars 2016-05-16 23:09:22,165 Setting DEBUG logging. 2016-05-16 23:09:22,165 attempt 1/10 2016-05-16 23:09:22,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c5cfd82c36e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 23:09:22,766 unpacking tar archive at: fx-team-c5cfd82c36e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.911993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:22.758937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:22.759254) ========= script_repo_revision: c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:22.759642) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:22.759921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 23:09:22.769405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-16 23:09:22.769747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:23 INFO - MultiFileLogger online at 20160516 23:09:23 in /builds/slave/test 23:09:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:23 INFO - {'append_to_log': False, 23:09:23 INFO - 'base_work_dir': '/builds/slave/test', 23:09:23 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:23 INFO - 'branch': 'Fx-Team', 23:09:23 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:23 INFO - 'config_files': ('talos/linux_config.py',), 23:09:23 INFO - 'default_actions': ('clobber', 23:09:23 INFO - 'read-buildbot-config', 23:09:23 INFO - 'download-and-extract', 23:09:23 INFO - 'populate-webroot', 23:09:23 INFO - 'create-virtualenv', 23:09:23 INFO - 'install', 23:09:23 INFO - 'run-tests'), 23:09:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:23 INFO - 'download_minidump_stackwalk': True, 23:09:23 INFO - 'download_symbols': 'ondemand', 23:09:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:23 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:23 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:23 INFO - 'installer_path': 'installer.exe', 23:09:23 INFO - 'log_level': 'info', 23:09:23 INFO - 'log_name': 'talos', 23:09:23 INFO - 'log_to_console': True, 23:09:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:23 INFO - 'opt_config_files': (), 23:09:23 INFO - 'pip_index': False, 23:09:23 INFO - 'sps_profile': False, 23:09:23 INFO - 'sps_profile_interval': 0, 23:09:23 INFO - 'suite': 'dromaeojs', 23:09:23 INFO - 'system_bits': '32', 23:09:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:23 INFO - 'title': 'talos-linux64-ix-018', 23:09:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:23 INFO - 'use_talos_json': True, 23:09:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:23 INFO - 'work_dir': 'build'} 23:09:23 INFO - ##### 23:09:23 INFO - ##### Running clobber step. 23:09:23 INFO - ##### 23:09:23 INFO - Running pre-action listener: _resource_record_pre_action 23:09:23 INFO - Running main action method: clobber 23:09:23 INFO - rmtree: /builds/slave/test/build 23:09:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:23 INFO - Running post-action listener: _resource_record_post_action 23:09:23 INFO - ##### 23:09:23 INFO - ##### Finished clobber step (success) 23:09:23 INFO - ##### 23:09:23 INFO - ##### 23:09:23 INFO - ##### Running read-buildbot-config step. 23:09:23 INFO - ##### 23:09:23 INFO - Running pre-action listener: _resource_record_pre_action 23:09:23 INFO - Running main action method: read_buildbot_config 23:09:23 INFO - Using buildbot properties: 23:09:23 INFO - { 23:09:23 INFO - "project": "", 23:09:23 INFO - "product": "firefox", 23:09:23 INFO - "script_repo_revision": "production", 23:09:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:09:23 INFO - "repository": "", 23:09:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:09:23 INFO - "buildid": "20160516203022", 23:09:23 INFO - "pgo_build": "True", 23:09:23 INFO - "basedir": "/builds/slave/test", 23:09:23 INFO - "buildnumber": 688, 23:09:23 INFO - "slavename": "talos-linux64-ix-018", 23:09:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:09:23 INFO - "platform": "ubuntu64_hw", 23:09:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:23 INFO - "branch": "fx-team", 23:09:23 INFO - "repo_path": "integration/fx-team", 23:09:23 INFO - "revision": "c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c", 23:09:23 INFO - "stage_platform": "linux64-pgo", 23:09:23 INFO - "builduid": "efc89e00935144db8a7ba6e2355dcf1f", 23:09:23 INFO - "slavebuilddir": "test" 23:09:23 INFO - } 23:09:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:23 INFO - Running post-action listener: _resource_record_post_action 23:09:23 INFO - ##### 23:09:23 INFO - ##### Finished read-buildbot-config step (success) 23:09:23 INFO - ##### 23:09:23 INFO - ##### 23:09:23 INFO - ##### Running download-and-extract step. 23:09:23 INFO - ##### 23:09:23 INFO - Running pre-action listener: _resource_record_pre_action 23:09:23 INFO - Running main action method: download_and_extract 23:09:23 INFO - mkdir: /builds/slave/test/build/tests 23:09:23 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')]} 23:09:23 INFO - https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:27 INFO - Downloaded 1361 bytes. 23:09:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:27 INFO - Using the following test package requirements: 23:09:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'jsshell-linux-x86_64.zip'], 23:09:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:30 INFO - Downloaded 24023930 bytes. 23:09:30 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'] 23:09:30 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 23:09:32 INFO - Return code: 0 23:09:32 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 23:09:32 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')]} 23:09:32 INFO - https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:36 INFO - Downloaded 24023930 bytes. 23:09: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'] 23:09: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 23:09:37 INFO - Return code: 0 23:09: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')]} 23:09:37 INFO - https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:39 INFO - Downloaded 10840194 bytes. 23:09:39 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'] 23:09:39 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 23:09:39 INFO - Return code: 0 23:09: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')]} 23:09:39 INFO - https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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 23:09:41 INFO - Downloaded 58419539 bytes. 23:09:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:41 INFO - mkdir: /builds/slave/test/properties 23:09:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:41 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:41 INFO - Contents: 23:09:41 INFO - build_url:https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:42 INFO - Running post-action listener: _resource_record_post_action 23:09:42 INFO - Running post-action listener: set_extra_try_arguments 23:09:42 INFO - ##### 23:09:42 INFO - ##### Finished download-and-extract step (success) 23:09:42 INFO - ##### 23:09:42 INFO - ##### 23:09:42 INFO - ##### Running populate-webroot step. 23:09:42 INFO - ##### 23:09:42 INFO - Running pre-action listener: _resource_record_pre_action 23:09:42 INFO - Running main action method: populate_webroot 23:09:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:42 INFO - '--tppagecycles', 23:09:42 INFO - '7'], 23:09:42 INFO - 'tests': ['tsvgm']}}, 23:09:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['damp', 'tps']}, 23:09:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'tests': ['damp', 'tps']}, 23:09:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['dromaeo_dom']}, 23:09:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['a11yr', 23:09:42 INFO - 'ts_paint', 23:09:42 INFO - 'tpaint', 23:09:42 INFO - 'sessionrestore', 23:09:42 INFO - 'sessionrestore_no_auto_restore', 23:09:42 INFO - 'tabpaint']}, 23:09:42 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:42 INFO - 'ts_paint', 23:09:42 INFO - 'tpaint', 23:09:42 INFO - 'sessionrestore', 23:09:42 INFO - 'sessionrestore_no_auto_restore', 23:09:42 INFO - 'tabpaint']}, 23:09:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:42 INFO - 'ts_paint', 23:09:42 INFO - 'tpaint', 23:09:42 INFO - 'sessionrestore', 23:09:42 INFO - 'sessionrestore_no_auto_restore', 23:09:42 INFO - 'tabpaint']}, 23:09:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:42 INFO - 'ts_paint', 23:09:42 INFO - 'tpaint', 23:09:42 INFO - 'sessionrestore', 23:09:42 INFO - 'sessionrestore_no_auto_restore', 23:09:42 INFO - 'tabpaint']}, 23:09:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['a11yr', 23:09:42 INFO - 'ts_paint', 23:09:42 INFO - 'tpaint', 23:09:42 INFO - 'sessionrestore', 23:09:42 INFO - 'sessionrestore_no_auto_restore', 23:09:42 INFO - 'tabpaint']}, 23:09:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['a11yr', 23:09:42 INFO - 'ts_paint', 23:09:42 INFO - 'tpaint', 23:09:42 INFO - 'sessionrestore', 23:09:42 INFO - 'sessionrestore_no_auto_restore', 23:09:42 INFO - 'tabpaint']}, 23:09:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['tsvgx', 23:09:42 INFO - 'tsvgr_opacity', 23:09:42 INFO - 'tart', 23:09:42 INFO - 'tscrollx', 23:09:42 INFO - 'cart']}, 23:09:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:42 INFO - 'tsvgr_opacity', 23:09:42 INFO - 'tart', 23:09:42 INFO - 'tscrollx', 23:09:42 INFO - 'cart']}, 23:09:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'talos_options': ['--disable-e10s'], 23:09:42 INFO - 'tests': ['tp5o']}, 23:09:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'tests': ['tp5o']}, 23:09:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'talos_options': ['--disable-e10s', 23:09:42 INFO - '--xperf_path', 23:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:42 INFO - 'tests': ['tp5n']}, 23:09:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:42 INFO - 'talos_options': ['--xperf_path', 23:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:42 INFO - 'tests': ['tp5n']}}, 23:09:42 INFO - 'talos.zip': {'path': '', 23:09:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:42 INFO - Running post-action listener: _resource_record_post_action 23:09:42 INFO - ##### 23:09:42 INFO - ##### Finished populate-webroot step (success) 23:09:42 INFO - ##### 23:09:42 INFO - ##### 23:09:42 INFO - ##### Running create-virtualenv step. 23:09:42 INFO - ##### 23:09:42 INFO - Running pre-action listener: _resource_record_pre_action 23:09:42 INFO - Running main action method: create_virtualenv 23:09:42 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:42 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 23:09:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:42 INFO - Using real prefix '/usr' 23:09:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:42 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:44 INFO - Installing pip.................done. 23:09:44 INFO - Return code: 0 23:09:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:09: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 23:09: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 23:09:44 INFO - Using env: {'DISPLAY': ':0', 23:09:44 INFO - 'HOME': '/home/cltbld', 23:09:44 INFO - 'LANG': 'en_US.UTF-8', 23:09:44 INFO - 'LANGUAGE': 'en_US:en', 23:09:44 INFO - 'LOGNAME': 'cltbld', 23:09:44 INFO - 'MAIL': '/var/mail/cltbld', 23:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:44 INFO - 'MOZ_NO_REMOTE': '1', 23:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:44 INFO - 'NO_EM_RESTART': '1', 23:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:44 INFO - 'PWD': '/builds/slave/test', 23:09:44 INFO - 'SHELL': '/bin/bash', 23:09:44 INFO - 'SHLVL': '1', 23:09:44 INFO - 'TERM': 'linux', 23:09:44 INFO - 'TMOUT': '86400', 23:09:44 INFO - 'USER': 'cltbld', 23:09:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:44 INFO - '_': '/tools/buildbot/bin/python'} 23:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09: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 23:09:44 INFO - Cleaning up... 23:09:44 INFO - Return code: 0 23:09:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:09: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 23:09: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 23:09:44 INFO - Using env: {'DISPLAY': ':0', 23:09:44 INFO - 'HOME': '/home/cltbld', 23:09:44 INFO - 'LANG': 'en_US.UTF-8', 23:09:44 INFO - 'LANGUAGE': 'en_US:en', 23:09:44 INFO - 'LOGNAME': 'cltbld', 23:09:44 INFO - 'MAIL': '/var/mail/cltbld', 23:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:44 INFO - 'MOZ_NO_REMOTE': '1', 23:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:44 INFO - 'NO_EM_RESTART': '1', 23:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:44 INFO - 'PWD': '/builds/slave/test', 23:09:44 INFO - 'SHELL': '/bin/bash', 23:09:44 INFO - 'SHLVL': '1', 23:09:44 INFO - 'TERM': 'linux', 23:09:44 INFO - 'TMOUT': '86400', 23:09:44 INFO - 'USER': 'cltbld', 23:09:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:44 INFO - '_': '/tools/buildbot/bin/python'} 23:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:45 INFO - Downloading/unpacking psutil>=3.1.1 23:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:47 INFO - Installing collected packages: psutil 23:09:47 INFO - Running setup.py install for psutil 23:09:47 INFO - building 'psutil._psutil_linux' extension 23:09: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 23:09: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 23:09:47 INFO - building 'psutil._psutil_posix' extension 23:09: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 23:09: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 23:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:47 INFO - Successfully installed psutil 23:09:47 INFO - Cleaning up... 23:09:47 INFO - Return code: 0 23:09:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:09: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 23:09: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 23:09:47 INFO - Using env: {'DISPLAY': ':0', 23:09:47 INFO - 'HOME': '/home/cltbld', 23:09:47 INFO - 'LANG': 'en_US.UTF-8', 23:09:47 INFO - 'LANGUAGE': 'en_US:en', 23:09:47 INFO - 'LOGNAME': 'cltbld', 23:09:47 INFO - 'MAIL': '/var/mail/cltbld', 23:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:47 INFO - 'MOZ_NO_REMOTE': '1', 23:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:47 INFO - 'NO_EM_RESTART': '1', 23:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:47 INFO - 'PWD': '/builds/slave/test', 23:09:47 INFO - 'SHELL': '/bin/bash', 23:09:47 INFO - 'SHLVL': '1', 23:09:47 INFO - 'TERM': 'linux', 23:09:47 INFO - 'TMOUT': '86400', 23:09:47 INFO - 'USER': 'cltbld', 23:09:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:47 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:49 INFO - Installing collected packages: mozsystemmonitor 23:09:49 INFO - Running setup.py install for mozsystemmonitor 23:09:49 INFO - Successfully installed mozsystemmonitor 23:09:49 INFO - Cleaning up... 23:09:49 INFO - Return code: 0 23:09:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:09: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 23:09: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 23:09:49 INFO - Using env: {'DISPLAY': ':0', 23:09:49 INFO - 'HOME': '/home/cltbld', 23:09:49 INFO - 'LANG': 'en_US.UTF-8', 23:09:49 INFO - 'LANGUAGE': 'en_US:en', 23:09:49 INFO - 'LOGNAME': 'cltbld', 23:09:49 INFO - 'MAIL': '/var/mail/cltbld', 23:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:49 INFO - 'MOZ_NO_REMOTE': '1', 23:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:49 INFO - 'NO_EM_RESTART': '1', 23:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:49 INFO - 'PWD': '/builds/slave/test', 23:09:49 INFO - 'SHELL': '/bin/bash', 23:09:49 INFO - 'SHLVL': '1', 23:09:49 INFO - 'TERM': 'linux', 23:09:49 INFO - 'TMOUT': '86400', 23:09:49 INFO - 'USER': 'cltbld', 23:09:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:49 INFO - '_': '/tools/buildbot/bin/python'} 23:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:52 INFO - Downloading docopt-0.6.1.tar.gz 23:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:52 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:52 INFO - Running setup.py install for blobuploader 23:09:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:52 INFO - Running setup.py install for requests 23:09:53 INFO - Running setup.py install for docopt 23:09:53 INFO - Successfully installed blobuploader requests docopt 23:09:53 INFO - Cleaning up... 23:09:53 INFO - Return code: 0 23:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:09: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 23:09: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 23:09:53 INFO - Using env: {'DISPLAY': ':0', 23:09:53 INFO - 'HOME': '/home/cltbld', 23:09:53 INFO - 'LANG': 'en_US.UTF-8', 23:09:53 INFO - 'LANGUAGE': 'en_US:en', 23:09:53 INFO - 'LOGNAME': 'cltbld', 23:09:53 INFO - 'MAIL': '/var/mail/cltbld', 23:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:53 INFO - 'MOZ_NO_REMOTE': '1', 23:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:53 INFO - 'NO_EM_RESTART': '1', 23:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:53 INFO - 'PWD': '/builds/slave/test', 23:09:53 INFO - 'SHELL': '/bin/bash', 23:09:53 INFO - 'SHLVL': '1', 23:09:53 INFO - 'TERM': 'linux', 23:09:53 INFO - 'TMOUT': '86400', 23:09:53 INFO - 'USER': 'cltbld', 23:09:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:53 INFO - '_': '/tools/buildbot/bin/python'} 23:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:53 INFO - Running setup.py (path:/tmp/pip-Eb88R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:53 INFO - Running setup.py (path:/tmp/pip-xGqbfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:53 INFO - Running setup.py (path:/tmp/pip-f2CB2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:53 INFO - Running setup.py (path:/tmp/pip-dT5EDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:53 INFO - Running setup.py (path:/tmp/pip-EeD3a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:53 INFO - Running setup.py (path:/tmp/pip-DWqwdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:54 INFO - Running setup.py (path:/tmp/pip-B7qMtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:54 INFO - Running setup.py (path:/tmp/pip-jXJH7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:54 INFO - Running setup.py (path:/tmp/pip-VgdU6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:54 INFO - Running setup.py (path:/tmp/pip-IPMYzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:54 INFO - Running setup.py (path:/tmp/pip-mY_4Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:54 INFO - Running setup.py (path:/tmp/pip-sVWyEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:54 INFO - Running setup.py (path:/tmp/pip-w9q7bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:54 INFO - Running setup.py (path:/tmp/pip-udCpt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:54 INFO - Running setup.py (path:/tmp/pip-uEDEHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:54 INFO - Running setup.py (path:/tmp/pip-PsG0fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:54 INFO - Running setup.py (path:/tmp/pip-SQ4rP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:54 INFO - Running setup.py install for manifestparser 23:09:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:54 INFO - Running setup.py install for mozcrash 23:09:55 INFO - Running setup.py install for mozdebug 23:09:55 INFO - Running setup.py install for mozdevice 23:09:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Running setup.py install for mozfile 23:09:55 INFO - Running setup.py install for mozhttpd 23:09:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Running setup.py install for mozinfo 23:09:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Running setup.py install for mozInstall 23:09:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Running setup.py install for mozleak 23:09:55 INFO - Running setup.py install for mozlog 23:09:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Running setup.py install for moznetwork 23:09:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:55 INFO - Running setup.py install for mozprocess 23:09:56 INFO - Running setup.py install for mozprofile 23:09:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:56 INFO - Running setup.py install for mozrunner 23:09:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:56 INFO - Running setup.py install for mozscreenshot 23:09:56 INFO - Running setup.py install for moztest 23:09:56 INFO - Running setup.py install for mozversion 23:09:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:56 INFO - Cleaning up... 23:09:56 INFO - Return code: 0 23:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:09: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 23:09: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 23:09:56 INFO - Using env: {'DISPLAY': ':0', 23:09:56 INFO - 'HOME': '/home/cltbld', 23:09:56 INFO - 'LANG': 'en_US.UTF-8', 23:09:56 INFO - 'LANGUAGE': 'en_US:en', 23:09:56 INFO - 'LOGNAME': 'cltbld', 23:09:56 INFO - 'MAIL': '/var/mail/cltbld', 23:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:56 INFO - 'MOZ_NO_REMOTE': '1', 23:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:56 INFO - 'NO_EM_RESTART': '1', 23:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:56 INFO - 'PWD': '/builds/slave/test', 23:09:56 INFO - 'SHELL': '/bin/bash', 23:09:56 INFO - 'SHLVL': '1', 23:09:56 INFO - 'TERM': 'linux', 23:09:56 INFO - 'TMOUT': '86400', 23:09:56 INFO - 'USER': 'cltbld', 23:09:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:56 INFO - '_': '/tools/buildbot/bin/python'} 23:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:56 INFO - Running setup.py (path:/tmp/pip-z7gT1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09: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)) 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:56 INFO - Running setup.py (path:/tmp/pip-1Rs3OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:57 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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:57 INFO - Running setup.py (path:/tmp/pip-ucEa5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:57 INFO - Running setup.py (path:/tmp/pip-wXB67X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:57 INFO - Running setup.py (path:/tmp/pip-8bNxyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:57 INFO - Running setup.py (path:/tmp/pip-3B9AYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:57 INFO - Running setup.py (path:/tmp/pip-WzL04W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:57 INFO - Running setup.py (path:/tmp/pip-gNlOv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:57 INFO - Running setup.py (path:/tmp/pip-Pr_KeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:57 INFO - Running setup.py (path:/tmp/pip-Oc8dxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:57 INFO - Running setup.py (path:/tmp/pip-8XAbfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:57 INFO - Running setup.py (path:/tmp/pip-1wXtGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:57 INFO - Running setup.py (path:/tmp/pip-eiCvfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:57 INFO - Running setup.py (path:/tmp/pip-cFWFat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:57 INFO - Running setup.py (path:/tmp/pip-JI5z_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09: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)) 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:57 INFO - Running setup.py (path:/tmp/pip-2AgkOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:58 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)) 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:58 INFO - Running setup.py (path:/tmp/pip-rQ7p6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09: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)) 23:09: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)) 23:09: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)) 23:09: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)) 23:09: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)) 23:09: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)) 23:09:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:59 INFO - Downloading blessings-1.6.tar.gz 23:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:00 INFO - Installing collected packages: blessings 23:10:00 INFO - Running setup.py install for blessings 23:10:00 INFO - Successfully installed blessings 23:10:00 INFO - Cleaning up... 23:10:00 INFO - Return code: 0 23:10:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:00 INFO - Reading from file tmpfile_stdout 23:10:00 INFO - Current package versions: 23:10:00 INFO - argparse == 1.2.1 23:10:00 INFO - blessings == 1.6 23:10:00 INFO - blobuploader == 1.2.4 23:10:00 INFO - docopt == 0.6.1 23:10:00 INFO - manifestparser == 1.1 23:10:00 INFO - mozInstall == 1.12 23:10:00 INFO - mozcrash == 0.17 23:10:00 INFO - mozdebug == 0.1 23:10:00 INFO - mozdevice == 0.48 23:10:00 INFO - mozfile == 1.2 23:10:00 INFO - mozhttpd == 0.7 23:10:00 INFO - mozinfo == 0.9 23:10:00 INFO - mozleak == 0.1 23:10:00 INFO - mozlog == 3.2 23:10:00 INFO - moznetwork == 0.27 23:10:00 INFO - mozprocess == 0.22 23:10:00 INFO - mozprofile == 0.28 23:10:00 INFO - mozrunner == 6.11 23:10:00 INFO - mozscreenshot == 0.1 23:10:00 INFO - mozsystemmonitor == 0.3 23:10:00 INFO - moztest == 0.7 23:10:00 INFO - mozversion == 1.4 23:10:00 INFO - psutil == 3.1.1 23:10:00 INFO - requests == 1.2.3 23:10:00 INFO - wsgiref == 0.1.2 23:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:10: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 23:10: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 23:10:00 INFO - Using env: {'DISPLAY': ':0', 23:10:00 INFO - 'HOME': '/home/cltbld', 23:10:00 INFO - 'LANG': 'en_US.UTF-8', 23:10:00 INFO - 'LANGUAGE': 'en_US:en', 23:10:00 INFO - 'LOGNAME': 'cltbld', 23:10:00 INFO - 'MAIL': '/var/mail/cltbld', 23:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:00 INFO - 'MOZ_NO_REMOTE': '1', 23:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:00 INFO - 'NO_EM_RESTART': '1', 23:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:00 INFO - 'PWD': '/builds/slave/test', 23:10:00 INFO - 'SHELL': '/bin/bash', 23:10:00 INFO - 'SHLVL': '1', 23:10:00 INFO - 'TERM': 'linux', 23:10:00 INFO - 'TMOUT': '86400', 23:10:00 INFO - 'USER': 'cltbld', 23:10:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:00 INFO - '_': '/tools/buildbot/bin/python'} 23:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10: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)) 23:10:00 INFO - Cleaning up... 23:10:00 INFO - Return code: 0 23:10:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:10: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 23:10: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 23:10:00 INFO - Using env: {'DISPLAY': ':0', 23:10:00 INFO - 'HOME': '/home/cltbld', 23:10:00 INFO - 'LANG': 'en_US.UTF-8', 23:10:00 INFO - 'LANGUAGE': 'en_US:en', 23:10:00 INFO - 'LOGNAME': 'cltbld', 23:10:00 INFO - 'MAIL': '/var/mail/cltbld', 23:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:00 INFO - 'MOZ_NO_REMOTE': '1', 23:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:00 INFO - 'NO_EM_RESTART': '1', 23:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:00 INFO - 'PWD': '/builds/slave/test', 23:10:00 INFO - 'SHELL': '/bin/bash', 23:10:00 INFO - 'SHLVL': '1', 23:10:00 INFO - 'TERM': 'linux', 23:10:00 INFO - 'TMOUT': '86400', 23:10:00 INFO - 'USER': 'cltbld', 23:10:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:00 INFO - '_': '/tools/buildbot/bin/python'} 23:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:00 INFO - Downloading/unpacking jsonschema 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:02 INFO - Downloading/unpacking functools32 (from jsonschema) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:03 INFO - warning: no files found matching '*.txt' 23:10:03 INFO - no previously-included directories found matching 'build' 23:10:03 INFO - no previously-included directories found matching 'dist' 23:10:03 INFO - no previously-included directories found matching '.git*' 23:10:03 INFO - Installing collected packages: jsonschema, functools32 23:10:03 INFO - Running setup.py install for functools32 23:10:03 INFO - warning: no files found matching '*.txt' 23:10:03 INFO - no previously-included directories found matching 'build' 23:10:03 INFO - no previously-included directories found matching 'dist' 23:10:03 INFO - no previously-included directories found matching '.git*' 23:10:03 INFO - Successfully installed jsonschema functools32 23:10:03 INFO - Cleaning up... 23:10:03 INFO - Return code: 0 23:10:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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 0x7fbf36cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe78770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', '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 23:10: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 23:10: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 23:10:03 INFO - Using env: {'DISPLAY': ':0', 23:10:03 INFO - 'HOME': '/home/cltbld', 23:10:03 INFO - 'LANG': 'en_US.UTF-8', 23:10:03 INFO - 'LANGUAGE': 'en_US:en', 23:10:03 INFO - 'LOGNAME': 'cltbld', 23:10:03 INFO - 'MAIL': '/var/mail/cltbld', 23:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:03 INFO - 'MOZ_NO_REMOTE': '1', 23:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:03 INFO - 'NO_EM_RESTART': '1', 23:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:03 INFO - 'PWD': '/builds/slave/test', 23:10:03 INFO - 'SHELL': '/bin/bash', 23:10:03 INFO - 'SHLVL': '1', 23:10:03 INFO - 'TERM': 'linux', 23:10:03 INFO - 'TMOUT': '86400', 23:10:03 INFO - 'USER': 'cltbld', 23:10:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:03 INFO - '_': '/tools/buildbot/bin/python'} 23:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:03 INFO - Downloading/unpacking flake8 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:06 INFO - no previously-included directories found matching 'docs/_build' 23:10:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:06 INFO - Running setup.py install for pep8 23:10:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:06 INFO - no previously-included directories found matching 'docs/_build' 23:10:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:06 INFO - Cleaning up... 23:10:06 INFO - Return code: 0 23:10:06 INFO - Running post-action listener: _resource_record_post_action 23:10:06 INFO - Running post-action listener: _start_resource_monitoring 23:10:06 INFO - Starting resource monitoring. 23:10:06 INFO - ##### 23:10:06 INFO - ##### Finished create-virtualenv step (success) 23:10:06 INFO - ##### 23:10:06 INFO - ##### 23:10:06 INFO - ##### Running install step. 23:10:06 INFO - ##### 23:10:06 INFO - Running pre-action listener: _resource_record_pre_action 23:10:06 INFO - Running main action method: install 23:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:06 INFO - Reading from file tmpfile_stdout 23:10:06 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:06 INFO - Reading from file tmpfile_stdout 23:10:06 INFO - Output received: 23:10:06 INFO - Usage: mozinstall [options] installer 23:10:06 INFO - Options: 23:10:06 INFO - -h, --help show this help message and exit 23:10:06 INFO - -d DEST, --destination=DEST 23:10:06 INFO - Directory to install application into. [default: 23:10:06 INFO - "/builds/slave/test"] 23:10:06 INFO - --app=APP Application being installed. [default: firefox] 23:10:06 INFO - mkdir: /builds/slave/test/build/application 23:10: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'] 23:10: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 23:10:23 INFO - Reading from file tmpfile_stdout 23:10:23 INFO - Output received: 23:10:23 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:23 INFO - Running post-action listener: _resource_record_post_action 23:10:23 INFO - ##### 23:10:23 INFO - ##### Finished install step (success) 23:10:23 INFO - ##### 23:10:23 INFO - ##### 23:10:23 INFO - ##### Running run-tests step. 23:10:23 INFO - ##### 23:10:23 INFO - Running pre-action listener: _resource_record_pre_action 23:10:23 INFO - Running main action method: run_tests 23:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:23 INFO - Python 2.7.3 23:10:23 INFO - Return code: 0 23:10:23 INFO - grabbing minidump binary from tooltool 23:10:23 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')]} 23:10:23 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 0xf079c0>, '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 0xf088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:23 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 23:10:23 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 23:10:23 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 23:10:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:23 INFO - Return code: 0 23:10:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:24 INFO - Return code: 0 23:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 23:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 23:10:24 INFO - Using env: {'DISPLAY': ':0', 23:10:24 INFO - 'HOME': '/home/cltbld', 23:10:24 INFO - 'LANG': 'en_US.UTF-8', 23:10:24 INFO - 'LANGUAGE': 'en_US:en', 23:10:24 INFO - 'LOGNAME': 'cltbld', 23:10:24 INFO - 'MAIL': '/var/mail/cltbld', 23:10:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:24 INFO - 'MOZ_NO_REMOTE': '1', 23:10:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:24 INFO - 'NO_EM_RESTART': '1', 23:10:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:24 INFO - 'PWD': '/builds/slave/test', 23:10:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:24 INFO - 'SHELL': '/bin/bash', 23:10:24 INFO - 'SHLVL': '1', 23:10:24 INFO - 'TERM': 'linux', 23:10:24 INFO - 'TMOUT': '86400', 23:10:24 INFO - 'USER': 'cltbld', 23:10:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375', 23:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:24 INFO - '_': '/tools/buildbot/bin/python'} 23:10:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 23:10:24 INFO - mozversion application_buildid: 20160516203022 23:10:24 INFO - mozversion application_changeset: c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c 23:10:24 INFO - mozversion application_display_name: Nightly 23:10:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:24 INFO - mozversion application_name: Firefox 23:10:24 INFO - mozversion application_remotingname: firefox 23:10:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:10:24 INFO - mozversion application_vendor: Mozilla 23:10:24 INFO - mozversion application_version: 49.0a1 23:10:24 INFO - mozversion platform_buildid: 20160516203022 23:10:24 INFO - mozversion platform_changeset: c5cfd82c36e54ca7e027e6bf82de7fcbc6863e7c 23:10:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:10:24 INFO - mozversion platform_version: 49.0a1 23:10:24 INFO - using testdate: 1463465424 23:10:24 INFO - actual date: 1463465424 23:10:24 INFO - starting webserver on 'localhost:40403' 23:10:24 INFO - SUITE-START | Running 2 tests 23:10:24 INFO - TEST-START | dromaeo_css 23:10:24 INFO - operating with platform_type : linux_ 23:10:24 INFO - Initialising browser for dromaeo_css test... 23:10:24 INFO - TEST-INFO | started process 388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg1J7pO/profile http://localhost:40403/getInfo.html) 23:10:28 INFO - PROCESS | 388 | __metrics Screen width/height:1600/1200 23:10:28 INFO - PROCESS | 388 | colorDepth:24 23:10:28 INFO - PROCESS | 388 | Browser inner width/height: 1024/697 23:10:28 INFO - PROCESS | 388 | __metrics 23:10:29 ERROR - PROCESS | 388 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:10:30 INFO - TEST-INFO | 388: exit 0 23:10:30 INFO - Browser initialized. 23:10:30 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:30 INFO - TEST-INFO | started process 469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg1J7pO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:41 INFO - PROCESS | 469 | RSS: Main: 152633344 23:10:41 INFO - PROCESS | 469 | 23:11:32 INFO - PROCESS | 469 | 1463465492802 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] 23:13:40 INFO - PROCESS | 469 | Cycle 1(1): loaded http://localhost:40403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40403/tests/dromaeo/cssquery-ext.html) 23:13:41 INFO - PROCESS | 469 | RSS: Main: 259837952 23:13:41 INFO - PROCESS | 469 | 23:16:43 INFO - PROCESS | 469 | Cycle 1(1): loaded http://localhost:40403/tests/dromaeo/cssquery-ext.html (next: http://localhost:40403/tests/dromaeo/cssquery-jquery.html) 23:16:44 INFO - PROCESS | 469 | RSS: Main: 234065920 23:16:44 INFO - PROCESS | 469 | 23:19:46 INFO - PROCESS | 469 | Cycle 1(1): loaded http://localhost:40403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40403/tests/dromaeo/cssquery-mootools.html) 23:19:47 INFO - PROCESS | 469 | RSS: Main: 246063104 23:19:47 INFO - PROCESS | 469 | 23:22:49 INFO - PROCESS | 469 | Cycle 1(1): loaded http://localhost:40403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40403/tests/dromaeo/cssquery-prototype.html) 23:22:49 INFO - PROCESS | 469 | RSS: Main: 232398848 23:22:49 INFO - PROCESS | 469 | 23:25:52 INFO - PROCESS | 469 | Cycle 1(1): loaded http://localhost:40403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40403/tests/dromaeo/cssquery-yui.html) 23:25:52 INFO - PROCESS | 469 | RSS: Main: 220635136 23:25:52 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | Cycle 1(1): loaded http://localhost:40403/tests/dromaeo/cssquery-yui.html (next: http://localhost:40403/tests/dromaeo/cssquery-dojo.html) 23:28:55 INFO - PROCESS | 469 | RSS: Main: 262164480 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | __start_tp_report 23:28:55 INFO - PROCESS | 469 | _x_x_mozilla_page_load 23:28:55 INFO - PROCESS | 469 | _x_x_mozilla_page_load_details 23:28:55 INFO - PROCESS | 469 | |i|pagename|runs| 23:28:55 INFO - PROCESS | 469 | |0;dojo.html;3152.448321543731;3157.305392813581;3161.573187619672;3212.052444528864;3217.6138863336405;5190.688558686482;5239.502247286502;5284.339457567804;5372.274742909706;5419.26839876617;5285.6300058995885;5318.654287471311;5333.413324534308;5334.706591137486;5346.625736198468;4805.183118869783;4809.302651115586;4913.3612630358;4916.680415772981;4954.628402869781;4853.029394121172;4870.780814863339;4919;4926.704397736129;4935.383077115361;4730.219513780222;4839.7096174229655;4841.15279826029;4905.435874874382;4913.263010548446;4901.240307752304;4912.312276281288;4916.877078073041;4934.432540257881;4961.231009193581;4720.291956206562;4791.808327666889;4900.754962251873;4912.238603016538;4933.629977751647;5208.088584497697;5268.6575372600655;5269.499397557226;5310.309659744208;5312.203169524563;5650.208970744099;5736.082226843727;5736.4550367715;5739.799107031234;5745.511631511326;5641.464060914206;5678.517326027292;5680.7727690892725;5737.684427356494;5800.53595712342;5369.731513424314;5410.648307859977;5413.810516631899;5417.431169727161;5418.593605479566;5844.1818145459665;5852.092925596539;5865.3254875689845;5867.70661466925;5871.530277577784;5439;5529.474699903502;5571.331440227199;5582.637128586629;5675.4892059714;5657.660540367591;5664.093745000862;5677.034904066319;5677.489025987681;5689.544836413077;5662.320521537442;5663.1505274208375;5663.461971112738;5666.773329066791;5668.489835914787;5500.064988951888;5672.177534257509;5713.800016999468;5740.68426236561;5785.82642520725;4410.845620403271;4426.867193984185;4428.756418397019;4440;4472.038511719996;3857.9807100964877;3916.4321173429694;3938.5470670873215;3974.841006359771;4004.7797371144284;5345.251664766935;5375.677459352373;5385.78456861729;5401;5404.648697834628;5659.688717120598;5688.48803607669;5692.174634677948;5692.430756924357;5703.54371650267;5290.365156181283;5346.117890548094;5405.864853378618;5412.729363531807;5471.534919531884;4943.332650092263;4944.950550494521;4945.109880221523;4945.604351651931;5004.9499505005215;5909.025010873243;5979.133025711248;5979.312379076462;5983.970080149658;5988.431099045583;5527.226188333556;5706.172604972338;5738.311402631627;5756.194132821324;5786.797462088806;6049.092636104443;6068.271807383142;6072.423119803611;6081.6655083969035;6101.7559297627595;5572.804951826666;5585.301837270341;5586.804461843816;5591.776328946797;5597.188407680945;5571.387147413862;5653.462921022497;5658.236138121466;5664.546836253007;5699.715014249188;5581.386047534686;5584.329880414376;5584.944150558605;5586.413426590149;5588.524975377139;5523.483997893582;5535.944640553543;5576.525995290446;5578;5581.10702287632;5381.811636592857;5456.91814622773;5488.588355873246;5513.228148059195;5556.916646250229;5669.461401166883;5675;5681.971590142023;5706.28671416073;5723.5707321950185;5369.677819330853;5535.916961245665;5538.196961440649;5540.63985840919;5580.274564306615 23:28:55 INFO - PROCESS | 469 | |1;ext.html;620.1132380695603;649.3960616626537;656.7241758461446;662.4236913884921;665.4742753224953;43853.561464385384;45074.54925450749;45106.54893451065;45208.547914520845;49380.259296110584;46707;47273.39996300202;47310;47322.053558928885;47389.289160662614;8937.597808098635;9130.726078217664;9131.771705707344;9134.314926380515;9135.54322283883;8877.112288771135;8945.0607686193;8951.194392504673;8956;8991.820163596723;9041.14109159632;9081.409708368968;9088.045755195708;9091.727248182531;9094.136057074567;8976.416532925372;8989.190972812445;9003.864942025875;9006.234470070052;9010.774730631721;8949.776255593597;9006.414583052081;9024.187823095886;9031.548422578844;9036;42046.36930446046;42573.57426425727;42587.7870610645;42593.148137037395;42607.57392426067;3773.339665558544;3844.6347596978244;3866.420036994445;3941.4679018332445;4113.239050775616;32098.839505802556;32624;32716.6728332716;32931.50602740961;32952;4241.851535196284;4255.446791917062;4331.45856767904;4339.457567804025;4356.869293921188;353004;354204;355772;356113.21943390375;356255;59162.11256831151;59386.70306648526;59879.401205987386;59896.401035989955;59941;55337.1699424509;58443.70778146082;62769.058464123074;62801.68599156975;62823;14927.776083358758;15604;15628.2185890705;15651.765223521656;15659.921700391425;11797.29216247028;11979.10156738248;11982.88017119835;11991.820122698167;12006.399680015964;15437.691246175014;16073.758893616605;16380.508584742476;16617.750733739005;16699.165041748107;6138.294096178996;6198.411150940653;6204.3795620437595;6293.433590976834;6382;1009.8232809258351;1018.5874720738113;1154.9826752598717;1168.4683469021575;1170.9590164344206;30533.236669083006;31927.840360798513;31935.201619959687;32069.35861282761;32444.675553244637;1126.994365028186;1198.836100837996;1218.1009198108445;1236.9072319576069;1251.5431867368345;17007.149642517823;17027.148642567823;17085.829141708673;17191.57021074458;17212.225449854788;543128;544787;547449;548662;552200;59979.40020599825;60122.39877601255;60165.09752353718;60188;60276;1368.774152264885;1396.8253968253969;1405.0586107307925;1421.3248706864363;1429.4925301518226;30632.081037568907;31127;31373.215669608442;31880.202994925312;31953.360932781678;50679.74660126676;50918.745406272734;51045.744771277394;51153.74423128009;51225.487745122075;448712;456849;457672;458627;458810;24941;28407.431851362442;28793.42413151767;28899.711002890544;29642.85178574093;47391.52608473871;48772.75613621909;49253.75373123112;52522.47477525176;53897.730511347196;39743.2051358977;40264.194716104925;41006;43743.34384984292;45554.77222613866;40416.59583404128;41297;41519.792401037805;41521;42693.14613707647;41778.74663760092;42265;42552.57447425486;42646.57353426426;42689.14621707611;35417;36666.63333366739;36705;37302.253954920205;37385.252294954495;28486.287842804097;28855.42289154163;29110.417791643624;29142;29218.123456296344 23:28:55 INFO - PROCESS | 469 | |2;jquery.html;369.88903329001295;398.40836358008363;406.5934065934066;411.2638377304625;418.5830962192978;16559.586010349747;19932.800671993275;20131.698024529625;20192.899035504837;22279.108835646595;18541.16564754586;18884.33904813332;19501.21995120197;20482.385528434133;20483.795162048376;5706.99999999999;5895;5998.700064996755;6608.636524991123;6623.105880706091;6413;6596.7691130810435;6622.966885165568;6656.534042617019;6707;6551.508636852232;6586.176727909012;6588.176477940257;6588.407043366096;6591.209054913417;6487.448566871822;6544.509161812859;6546.11627430298;6551.574147680433;6568.573042752206;5637.548996080303;5738.512226460756;5766.509846663039;5777.768889244425;5801.216835727208;22771.430714232112;23922.64116038261;24341.87829060861;24386.390340241458;24405.51188976228;2622.462395208978;2714.0510557139314;2739.849308288043;2753.3391985923436;3138.7959782614057;14222.359993800304;14493.130412175304;14514.201718905457;14590.489332873405;14780.408783648641;1922.2887531613253;1993.900304984745;2027.7161197432372;2084.4372019554785;2152.3435352217566;73283.63358183175;75481.24518754797;76878;80263;85796.57101714514;17326.353996370326;17701.645967080585;17728.202230899642;17742.467725968243;17891.1948962297;31382.843085784425;31414.528782068286;31622.525662115087;31664.208394790316;31802.2049448761;9562.856557151648;9719.65981190655;9807.558659860324;9946.950265248772;9963.501824908726;8049.597520124087;8105;8267.421280510307;8286.70996515131;8291.543965081979;9025.81948361029;9084.636614535477;9152.267818574499;9191.632334706537;9219.631214751334;3215.7266632336045;3322.9335413291597;3385.509101180315;3451.447768357101;3577.94633080504;940.722486866376;1016.974575635615;1023.0741179232806;1069.2996087562503;1088.7822435512928;18508.722369164472;19125.713114303297;19490.610187796447;19648.70526942097;19799.40601781949;1010.9696709098739;1027.1628622672497;1028.7428142964259;1045.628801775374;1051.3901936876593;10766.838497422545;11072.335659860435;11114.388708620942;11115.944420277847;11152.330860148417;172004;172270;499553;513812;522546;94716;104228.47885760522;104980.22608756591;105012;106429.46785266024;1023.7901230247782;1061.8778840433295;1102.1293178388983;1104.47537419725;1109.2734259060328;17471;17483.82516174822;17545.210465528828;17735.911320443316;17801.46595602134;30786;34050.14874628154;36962;37436.812815935744;37801.81099094487;46934.53065469438;57751.4224857746;57754.422455776585;58106.418935811795;58477;7641.6561254742555;7929.5242285463055;8589;8628.827423451621;8872.866906996529;13536.12015219047;13700.45198192061;13867.029307948347;13924.721505570034;13944.930275348965;12089.637310880687;12199.207051541622;12284.683135553172;12570.603896588545;12581.308028058545;11507.482163302504;12020.459079341275;12133.393330333625;12156.149069565046;12394.380280986095;12222.572209972608;12291.32397718134;12560.811587826372;12573.811392829299;12673.302968336462;7948.40386970991;8015.519068855887;8108.2297181767635;8196.42625016243;8360.623771930399;11684.941575292069;11954.760904781682;12030.939845300718;12212.08409369283;12256.693582660148 23:28:55 INFO - PROCESS | 469 | |3;mootools.html;1358.443038354275;1505.7816616590594;1532.4023630783993;1693;1834.5963887944656;8517.446365986214;8842.204201621853;8866.024737278894;9145.771355716093;9154.771130721736;8849.867251991225;9067.047959964208;9074.319426043041;9076.273898088153;9096.909030909688;2086.7704552499213;2137.700721898935;2253.267688001398;2359.056377449021;2391.8325717199714;2367.479154585997;2370.1349007612184;2371.419002344428;2372.027468737809;2374.7387787343378;2327.5577640248384;2350;2353.235198560466;2353.788159065684;2360.881955902198;1993.2027189124321;2242.416971587399;2300.5283916797016;2316.6061769499224;2325.802306803924;2308.4344335637707;2333.8833058347186;2353.094058787362;2355.470019245673;2355.905763769464;8918.866217006751;8957.731268061969;8970.686025989124;8975.147361000694;8975.416597921114;5323.01524218017;5450.018996580614;5451.64564303319;5464.207689884985;5467.890642187173;3333.0500807269814;3359.0930448778936;3389.915252118692;3478.008767501275;3488.302339532104;1048.821700310949;1055.1927775251938;1071.2019545438698;1088.3089238333637;1094.409019129669;12471;12476.313802740846;12506.937465312616;12516.311602861839;12517;4789.640776941744;4790.9329448972985;4847.079054979543;4872.1473742094995;4890.437599676012;10574.259801813952;10574.89425105739;10581.947090264654;10591.152707783513;10598.841017384746;5417.458254174551;5422.0511410503;5422.213779002022;5430.56555475561;5432.7555260012605;4411.448568928884;4883.58489528387;5017.096922553976;5022.673526220784;5104.591632669378;4117.258893399157;4138.6482149017065;4162.6698641087005;4184.100418409996;4216.198922204771;1289.1298373597783;1323.3846261488454;1331.766940785378;1349.4602159136423;1350.7906274527268;819.1521774962885;882.7484167012499;973.8587904753771;987.6098940918297;1004.2568499310457;6099.115628233882;6100.0849872519475;6229.4393504583895;6256.405641464054;6258.249010118815;485.0807719371771;486.4624589828189;486.7152715661307;493.5015634209403;498.7456397237435;4364.148990946735;4529.773511324421;4561.657875659339;4569.565891240327;4583.954160458419;10869.728256793644;11150.107991360672;11190.832137517944;11236.325820450798;11271.718207044889;10881.238313317992;11187.440627968568;11194.720131996764;11196.832047519294;11212.943935280435;8208.917910820936;8297.294729948022;8378.245957863699;8389.370797190113;8402;6087.543434242538;6211.9689401554515;6319.557630965788;6334.461570766536;6401.071844582602;10201.234907381828;10378.42918639482;10485.108765754996;10499.107575855833;10522.31604945676;10449.373037617766;10559.260851740612;10563.735906602396;10587.258891877495;10730.73173170677;7327.450441217036;7626.4661473698525;7847.293743563107;7944.801379965547;8051.597420128853;8725.825483490422;8796.868046979173;8819.514926678838;8826.073262307365;8830.116988301119;7700.691972321044;7715.4599178057;7809.726659566888;7839.294463498084;8000.439969202333;7730.149683534919;7795.181505941794;7858.292753652198;7882.369410447036;7896.210378962058;7198.100237470317;7244.130704315516;7291.161516425679;7302.56184628924;7309.451791115581;5454.29094217765;5504.091824849015;5564.1931919870585;5607.663540187602;5614.101743720985;5343.3587969443915;5397.8380648580605;5541.362743284412;5588.86027849307;5670.064439367623 23:28:55 INFO - PROCESS | 469 | |4;prototype.html;327.5114412904526;336.8097025180773;340.5521738913327;344.66395264617;344.9017030146409;5286.154215325549;5301.628885977983;5308.601854860886;5313.628046036779;5352.892942141165;5228.555572776309;5233.398159211692;5267.28891599634;5267.47325267473;5267.762950667219;3968.226195891802;4202.894927626803;4205.642520385763;4211.347241177622;4226.1336426032585;3947.427622994664;4024.416459613354;4071.71497995139;4153.833846646131;4159.438475805773;4101.507819061717;4126.607972242632;4129.834806607732;4135.338345864662;4163.20899029185;4130.586941305875;4144.316187829005;4157.708960372775;4177;4178.435911151986;3511.4030614795547;3616.65641764032;3711.721620878445;3714.9257014859822;3720.6233693533295;5105.463926287761;5117.744112794383;5126.846194614168;5127;5157.458466860963;4774.641901857374;4785.306130611077;4787.40157480315;4802.447718512346;4804.759762011886;5378.327709036371;5466.715321899351;5474.835754927359;5498.367687715924;5520.420355862617;4051.210014047262;4064.3700226464944;4069.3895915612597;4072.490938632671;4087.0804069084516;5481.040817856899;5484.451554844523;5715.257016587859;5728.22668939692;5732.426757324234;4123.670106391482;4132.483439570054;4136.400221967858;4140.296149654566;4142.275101857163;4198.005947175128;4208.600182982673;4219.852305169305;4229.830806767756;4234.597713217239;4554.63562914966;4746.528576141407;4768.451628062817;4779.354787103766;4794.232922732346;5538.723063846792;5543.223948647112;5574.16387541872;5579.609427340048;5598.188262701967;1431.4059665239017;1444.8410674825761;1453.7643003447197;1462.8756555692673;1462.9122252664874;906.6781292641017;936.162134889284;945.8439357505935;956;963.9566219520138;4830.734309613005;4868.513148685103;4871.732054737024;4919;4945.922712460775;5165.405978312467;5179.203230255695;5183.092958732207;5187.662801917863;5196.584273258206;4489.846397387988;4855.732934688626;4886.706797592155;4895.779689913962;4921.064997650435;2700.4734076854825;2706.8917243310048;2708.349996000946;2724.4823483538066;2726.7682247009225;5322.467753224724;5329.360476742816;5345.717027913351;5354.544863686552;5365.731713414314;4851.708897466164;5084.245935152367;5161.716105614152;5168.948310516922;5208.9739551302;5279.788808447619;5329.307190065267;5330.626856120034;5333.373321137013;5355.839324820339;5043.697378157322;5049.6465247432325;5139.434662187082;5170.267960233364;5202.505761952609;4773.952260477351;5047.41954675217;5055.7472126392795;5063.392392912874;5070.340855688737;5718.399568045295;5824.650520968756;5903.881922361615;5955.451582588472;5978.3423823378525;4181.519125300508;4186.351115576968;4189.329707246826;4204.663626909779;4224.239636865394;5539.534906966523;5588.580856435702;5656.6888821115235;5711.428857114422;5738.282714660668;5506.421825708403;5513.58648101386;5514.283143191359;5521.254630624814;5521.447855214607;5511.53151982086;5528.75120619565;5551.666899985852;5556.277683901067;5573.470520300565;5171.586273098218;5501.697406642673;5505.614606977473;5514.2004409359615;5563.610547261653;5665.49010589049;5668.121441176624;5682.232898558807;5685.744141513725;5688.573356998324;5462.562994960314;5478.890422191614;5570.693611851387;5581.609287349846;5602.963451761437 23:28:55 INFO - PROCESS | 469 | |5;yui.html;809.7449303469407;846.2257034813147;849.3502470609984;855.7603870916141;891.5230351761807;14355.569332920002;14373.78439323411;14383.712325753491;14536.491222807204;15102.546923592296;12509.68725781856;12914.935425322883;12940.48238070476;13287.202767833936;13367.732645347087;706.1984647425159;817.8323443694028;848.6223630484421;849.2781136034353;855.3499340501202;835.9749207523754;849.5624753252049;851.8892543969275;852.2585350744861;852.8678054901469;882.2368651116802;887.4896934262792;888.2139306713541;888.4180861535705;888.6623083228365;730.8026832755179;867.5445391169686;879.6789171952255;880.6521424037502;880.7886107334258;638.7285403703407;639.2871947778241;639.9520035997319;640.186962557554;641.8908785506428;14251.643708907257;14276.500322488768;14288.642783930381;14306.141631502143;14330.49843255481;12220.877791222063;12320.445579948924;12410.379481026002;12487.875121248762;12716.237025778482;11891.28652280866;12091.334976576285;12278.508859645603;12482.875171248263;12540.937295313464;4458.8439404621;4542.182407166709;4546.045330480603;4559.224931761575;4581.977090114528;51229.48770512322;53082.734586327206;57046.14430783541;57550.7122464385;57659.71170144164;10397.168226541859;10585.576576936835;10777.568897244179;10885.83671244932;11158.832617510743;19381;19383.51541211481;19433;19440.319588814324;19441.708374374397;8127;8274.917250827535;8275;8297;8426.789330266669;4607.883055105906;4682.157211701859;4767.713937163781;4892.217245240816;4964.032013757283;3451.861925523001;3528.770629909048;3529.2059286660296;3529.7176225901867;3539.8407071681836;630.3098107572201;636.9649669268234;644.6196743921109;646.6152639179775;671.4091599392601;682.9453643708491;686.6120641837346;696.4393663101253;762.1920763990188;781.9022622172229;9902.851457228147;9959.950200249097;10070.546825392876;10094.343867648578;10094.646687366054;711.3283240253837;721.5200551809003;743.9702411903571;750.5459197185734;765.12775436003;4532.4334458192725;4644.187267228222;4656.3713898623255;4692.249240121632;4738.265568836836;63851.49019821447;64949.35050649528;68119.65940170268;68863;69173.30826691669;58729;59032.21129570068;60134.69932650309;60352.39647603556;60593;51318.48681513137;51624;51681.7415912918;51917.48082519202;52008.21987670188;8755;8898.45818793758;8900.643974240958;8954.417962832395;9051.773705657411;36143.81928090343;37405.2518949614;37531.2493750118;38053.23893522169;38420.807895960344;46257;52011.21983170331;52103.73948130235;53742;54591.72704136454;12647.873521265037;12845.871541284467;12846.550370736979;13163.67090822737;14038.017338786187;13877.306134693426;14430.783538246726;14438.278086095443;14800;14898.553043408716;9538.666146684833;10875.510602023087;12949.417276222404;13350.132241404277;14011.719765604426;13861.4455421782;13948;14055.367508462348;14077.929610351883;14094.029591811364;13701.109427887155;13845.161741842696;14004.229767362893;14120.646983825487;14740.631484212981;10876.945615271872;11264.38045907483;11355.886441135483;11394.601188958346;11698.35659038761;10454.335070248007;10468.68593942183;10511.164824474776;10550.103241224582;10574.89425105739 23:28:55 INFO - PROCESS | 469 | __end_tp_report 23:28:55 INFO - PROCESS | 469 | __start_cc_report 23:28:55 INFO - PROCESS | 469 | _x_x_mozilla_cycle_collect,855 23:28:55 INFO - PROCESS | 469 | __end_cc_report 23:28:55 INFO - PROCESS | 469 | __startTimestamp1463466535589__endTimestamp 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | ------- Summary: start ------- 23:28:55 INFO - PROCESS | 469 | Number of tests: 6 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | [#0] dojo.html Cycles:165 Average:5313.76 Median:5523.48 stddev:586.37 (10.6%) stddev-sans-first:563.12 23:28:55 INFO - PROCESS | 469 | Values: 3152.4 3157.3 3161.6 3212.1 3217.6 5190.7 5239.5 5284.3 5372.3 5419.3 5285.6 5318.7 5333.4 5334.7 5346.6 4805.2 4809.3 4913.4 4916.7 4954.6 4853.0 4870.8 4919.0 4926.7 4935.4 4730.2 4839.7 4841.2 4905.4 4913.3 4901.2 4912.3 4916.9 4934.4 4961.2 4720.3 4791.8 4900.8 4912.2 4933.6 5208.1 5268.7 5269.5 5310.3 5312.2 5650.2 5736.1 5736.5 5739.8 5745.5 5641.5 5678.5 5680.8 5737.7 5800.5 5369.7 5410.6 5413.8 5417.4 5418.6 5844.2 5852.1 5865.3 5867.7 5871.5 5439.0 5529.5 5571.3 5582.6 5675.5 5657.7 5664.1 5677.0 5677.5 5689.5 5662.3 5663.2 5663.5 5666.8 5668.5 5500.1 5672.2 5713.8 5740.7 5785.8 4410.8 4426.9 4428.8 4440.0 4472.0 3858.0 3916.4 3938.5 3974.8 4004.8 5345.3 5375.7 5385.8 5401.0 5404.6 5659.7 5688.5 5692.2 5692.4 5703.5 5290.4 5346.1 5405.9 5412.7 5471.5 4943.3 4945.0 4945.1 4945.6 5004.9 5909.0 5979.1 5979.3 5984.0 5988.4 5527.2 5706.2 5738.3 5756.2 5786.8 6049.1 6068.3 6072.4 6081.7 6101.8 5572.8 5585.3 5586.8 5591.8 5597.2 5571.4 5653.5 5658.2 5664.5 5699.7 5581.4 5584.3 5584.9 5586.4 5588.5 5523.5 5535.9 5576.5 5578.0 5581.1 5381.8 5456.9 5488.6 5513.2 5556.9 5669.5 5675.0 5682.0 5706.3 5723.6 5369.7 5535.9 5538.2 5540.6 5580.3 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | [#1] ext.html Cycles:180 Average:61549.27 Median:42600.36 stddev:121917.53 (286.2%) stddev-sans-first:122173.71 23:28:55 INFO - PROCESS | 469 | Values: 620.1 649.4 656.7 662.4 665.5 43853.6 45074.5 45106.5 45208.5 49380.3 46707.0 47273.4 47310.0 47322.1 47389.3 8937.6 9130.7 9131.8 9134.3 9135.5 8877.1 8945.1 8951.2 8956.0 8991.8 9041.1 9081.4 9088.0 9091.7 9094.1 8976.4 8989.2 9003.9 9006.2 9010.8 8949.8 9006.4 9024.2 9031.5 9036.0 42046.4 42573.6 42587.8 42593.1 42607.6 3773.3 3844.6 3866.4 3941.5 4113.2 32098.8 32624.0 32716.7 32931.5 32952.0 4241.9 4255.4 4331.5 4339.5 4356.9 353004.0 354204.0 355772.0 356113.2 356255.0 59162.1 59386.7 59879.4 59896.4 59941.0 55337.2 58443.7 62769.1 62801.7 62823.0 14927.8 15604.0 15628.2 15651.8 15659.9 11797.3 11979.1 11982.9 11991.8 12006.4 15437.7 16073.8 16380.5 16617.8 16699.2 6138.3 6198.4 6204.4 6293.4 6382.0 1009.8 1018.6 1155.0 1168.5 1171.0 30533.2 31927.8 31935.2 32069.4 32444.7 1127.0 1198.8 1218.1 1236.9 1251.5 17007.1 17027.1 17085.8 17191.6 17212.2 543128.0 544787.0 547449.0 548662.0 552200.0 59979.4 60122.4 60165.1 60188.0 60276.0 1368.8 1396.8 1405.1 1421.3 1429.5 30632.1 31127.0 31373.2 31880.2 31953.4 50679.7 50918.7 51045.7 51153.7 51225.5 448712.0 456849.0 457672.0 458627.0 458810.0 24941.0 28407.4 28793.4 28899.7 29642.9 47391.5 48772.8 49253.8 52522.5 53897.7 39743.2 40264.2 41006.0 43743.3 45554.8 40416.6 41297.0 41519.8 41521.0 42693.1 41778.7 42265.0 42552.6 42646.6 42689.1 35417.0 36666.6 36705.0 37302.3 37385.3 28486.3 28855.4 29110.4 29142.0 29218.1 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | [#2] jquery.html Cycles:180 Average:27039.69 Median:2668.26 stddev:68732.60 (2575.9%) stddev-sans-first:68896.24 23:28:55 INFO - PROCESS | 469 | Values: 369.9 398.4 406.6 411.3 418.6 16559.6 19932.8 20131.7 20192.9 22279.1 18541.2 18884.3 19501.2 20482.4 20483.8 5707.0 5895.0 5998.7 6608.6 6623.1 6413.0 6596.8 6623.0 6656.5 6707.0 6551.5 6586.2 6588.2 6588.4 6591.2 6487.4 6544.5 6546.1 6551.6 6568.6 5637.5 5738.5 5766.5 5777.8 5801.2 22771.4 23922.6 24341.9 24386.4 24405.5 2622.5 2714.1 2739.8 2753.3 3138.8 14222.4 14493.1 14514.2 14590.5 14780.4 1922.3 1993.9 2027.7 2084.4 2152.3 73283.6 75481.2 76878.0 80263.0 85796.6 17326.4 17701.6 17728.2 17742.5 17891.2 31382.8 31414.5 31622.5 31664.2 31802.2 9562.9 9719.7 9807.6 9947.0 9963.5 8049.6 8105.0 8267.4 8286.7 8291.5 9025.8 9084.6 9152.3 9191.6 9219.6 3215.7 3322.9 3385.5 3451.4 3577.9 940.7 1017.0 1023.1 1069.3 1088.8 18508.7 19125.7 19490.6 19648.7 19799.4 1011.0 1027.2 1028.7 1045.6 1051.4 10766.8 11072.3 11114.4 11115.9 11152.3 172004.0 172270.0 499553.0 513812.0 522546.0 94716.0 104228.5 104980.2 105012.0 106429.5 1023.8 1061.9 1102.1 1104.5 1109.3 17471.0 17483.8 17545.2 17735.9 17801.5 30786.0 34050.1 36962.0 37436.8 37801.8 46934.5 57751.4 57754.4 58106.4 58477.0 7641.7 7929.5 8589.0 8628.8 8872.9 13536.1 13700.5 13867.0 13924.7 13944.9 12089.6 12199.2 12284.7 12570.6 12581.3 11507.5 12020.5 12133.4 12156.1 12394.4 12222.6 12291.3 12560.8 12573.8 12673.3 7948.4 8015.5 8108.2 8196.4 8360.6 11684.9 11954.8 12030.9 12212.1 12256.7 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | [#3] mootools.html Cycles:180 Average:5950.23 Median:485.77 stddev:3399.43 (699.8%) stddev-sans-first:3391.44 23:28:55 INFO - PROCESS | 469 | Values: 1358.4 1505.8 1532.4 1693.0 1834.6 8517.4 8842.2 8866.0 9145.8 9154.8 8849.9 9067.0 9074.3 9076.3 9096.9 2086.8 2137.7 2253.3 2359.1 2391.8 2367.5 2370.1 2371.4 2372.0 2374.7 2327.6 2350.0 2353.2 2353.8 2360.9 1993.2 2242.4 2300.5 2316.6 2325.8 2308.4 2333.9 2353.1 2355.5 2355.9 8918.9 8957.7 8970.7 8975.1 8975.4 5323.0 5450.0 5451.6 5464.2 5467.9 3333.1 3359.1 3389.9 3478.0 3488.3 1048.8 1055.2 1071.2 1088.3 1094.4 12471.0 12476.3 12506.9 12516.3 12517.0 4789.6 4790.9 4847.1 4872.1 4890.4 10574.3 10574.9 10581.9 10591.2 10598.8 5417.5 5422.1 5422.2 5430.6 5432.8 4411.4 4883.6 5017.1 5022.7 5104.6 4117.3 4138.6 4162.7 4184.1 4216.2 1289.1 1323.4 1331.8 1349.5 1350.8 819.2 882.7 973.9 987.6 1004.3 6099.1 6100.1 6229.4 6256.4 6258.2 485.1 486.5 486.7 493.5 498.7 4364.1 4529.8 4561.7 4569.6 4584.0 10869.7 11150.1 11190.8 11236.3 11271.7 10881.2 11187.4 11194.7 11196.8 11212.9 8208.9 8297.3 8378.2 8389.4 8402.0 6087.5 6212.0 6319.6 6334.5 6401.1 10201.2 10378.4 10485.1 10499.1 10522.3 10449.4 10559.3 10563.7 10587.3 10730.7 7327.5 7626.5 7847.3 7944.8 8051.6 8725.8 8796.9 8819.5 8826.1 8830.1 7700.7 7715.5 7809.7 7839.3 8000.4 7730.1 7795.2 7858.3 7882.4 7896.2 7198.1 7244.1 7291.2 7302.6 7309.5 5454.3 5504.1 5564.2 5607.7 5614.1 5343.4 5397.8 5541.4 5588.9 5670.1 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | [#4] prototype.html Cycles:180 Average:4559.34 Median:5122.30 stddev:1306.93 (25.5%) stddev-sans-first:1271.41 23:28:55 INFO - PROCESS | 469 | Values: 327.5 336.8 340.6 344.7 344.9 5286.2 5301.6 5308.6 5313.6 5352.9 5228.6 5233.4 5267.3 5267.5 5267.8 3968.2 4202.9 4205.6 4211.3 4226.1 3947.4 4024.4 4071.7 4153.8 4159.4 4101.5 4126.6 4129.8 4135.3 4163.2 4130.6 4144.3 4157.7 4177.0 4178.4 3511.4 3616.7 3711.7 3714.9 3720.6 5105.5 5117.7 5126.8 5127.0 5157.5 4774.6 4785.3 4787.4 4802.4 4804.8 5378.3 5466.7 5474.8 5498.4 5520.4 4051.2 4064.4 4069.4 4072.5 4087.1 5481.0 5484.5 5715.3 5728.2 5732.4 4123.7 4132.5 4136.4 4140.3 4142.3 4198.0 4208.6 4219.9 4229.8 4234.6 4554.6 4746.5 4768.5 4779.4 4794.2 5538.7 5543.2 5574.2 5579.6 5598.2 1431.4 1444.8 1453.8 1462.9 1462.9 906.7 936.2 945.8 956.0 964.0 4830.7 4868.5 4871.7 4919.0 4945.9 5165.4 5179.2 5183.1 5187.7 5196.6 4489.8 4855.7 4886.7 4895.8 4921.1 2700.5 2706.9 2708.3 2724.5 2726.8 5322.5 5329.4 5345.7 5354.5 5365.7 4851.7 5084.2 5161.7 5168.9 5209.0 5279.8 5329.3 5330.6 5333.4 5355.8 5043.7 5049.6 5139.4 5170.3 5202.5 4774.0 5047.4 5055.7 5063.4 5070.3 5718.4 5824.7 5903.9 5955.5 5978.3 4181.5 4186.4 4189.3 4204.7 4224.2 5539.5 5588.6 5656.7 5711.4 5738.3 5506.4 5513.6 5514.3 5521.3 5521.4 5511.5 5528.8 5551.7 5556.3 5573.5 5171.6 5501.7 5505.6 5514.2 5563.6 5665.5 5668.1 5682.2 5685.7 5688.6 5462.6 5478.9 5570.7 5581.6 5603.0 23:28:55 INFO - PROCESS | 469 | 23:28:55 INFO - PROCESS | 469 | [#5] yui.html Cycles:180 Average:15586.37 Median:4650.28 stddev:18334.12 (394.3%) stddev-sans-first:18351.97 23:28:55 INFO - PROCESS | 469 | Values: 809.7 846.2 849.4 855.8 891.5 14355.6 14373.8 14383.7 14536.5 15102.5 12509.7 12914.9 12940.5 13287.2 13367.7 706.2 817.8 848.6 849.3 855.3 836.0 849.6 851.9 852.3 852.9 882.2 887.5 888.2 888.4 888.7 730.8 867.5 879.7 880.7 880.8 638.7 639.3 640.0 640.2 641.9 14251.6 14276.5 14288.6 14306.1 14330.5 12220.9 12320.4 12410.4 12487.9 12716.2 11891.3 12091.3 12278.5 12482.9 12540.9 4458.8 4542.2 4546.0 4559.2 4582.0 51229.5 53082.7 57046.1 57550.7 57659.7 10397.2 10585.6 10777.6 10885.8 11158.8 19381.0 19383.5 19433.0 19440.3 19441.7 8127.0 8274.9 8275.0 8297.0 8426.8 4607.9 4682.2 4767.7 4892.2 4964.0 3451.9 3528.8 3529.2 3529.7 3539.8 630.3 637.0 644.6 646.6 671.4 682.9 686.6 696.4 762.2 781.9 9902.9 9960.0 10070.5 10094.3 10094.6 711.3 721.5 744.0 750.5 765.1 4532.4 4644.2 4656.4 4692.2 4738.3 63851.5 64949.4 68119.7 68863.0 69173.3 58729.0 59032.2 60134.7 60352.4 60593.0 51318.5 51624.0 51681.7 51917.5 52008.2 8755.0 8898.5 8900.6 8954.4 9051.8 36143.8 37405.3 37531.2 38053.2 38420.8 46257.0 52011.2 52103.7 53742.0 54591.7 12647.9 12845.9 12846.6 13163.7 14038.0 13877.3 14430.8 14438.3 14800.0 14898.6 9538.7 10875.5 12949.4 13350.1 14011.7 13861.4 13948.0 14055.4 14077.9 14094.0 13701.1 13845.2 14004.2 14120.6 14740.6 10876.9 11264.4 11355.9 11394.6 11698.4 10454.3 10468.7 10511.2 10550.1 10574.9 23:28:55 INFO - PROCESS | 469 | -------- Summary: end -------- 23:28:55 INFO - PROCESS | 469 | 23:28:56 INFO - TEST-INFO | 469: exit 0 23:28:56 INFO - TEST-OK | dromaeo_css | took 1111926ms 23:28:56 INFO - TEST-START | kraken 23:28:56 INFO - operating with platform_type : linux_ 23:28:56 INFO - Initialising browser for kraken test... 23:28:56 INFO - TEST-INFO | started process 651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4erAQE/profile http://localhost:40403/getInfo.html) 23:29:00 INFO - PROCESS | 651 | __metrics Screen width/height:1600/1200 23:29:00 INFO - PROCESS | 651 | colorDepth:24 23:29:00 INFO - PROCESS | 651 | Browser inner width/height: 1024/697 23:29:00 INFO - PROCESS | 651 | __metrics 23:29:00 ERROR - PROCESS | 651 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:29:01 INFO - TEST-INFO | 651: exit 0 23:29:01 INFO - Browser initialized. 23:29:01 INFO - Running cycle 1/1 for kraken test... 23:29:01 INFO - TEST-INFO | started process 735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4erAQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:13 INFO - PROCESS | 735 | RSS: Main: 152637440 23:29:13 INFO - PROCESS | 735 | 23:29:16 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40403/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:17 INFO - PROCESS | 735 | RSS: Main: 208662528 23:29:17 INFO - PROCESS | 735 | 23:29:19 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40403/tests/kraken/driver.html?testName=audio-dft) 23:29:20 INFO - PROCESS | 735 | RSS: Main: 197758976 23:29:20 INFO - PROCESS | 735 | 23:29:23 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40403/tests/kraken/driver.html?testName=audio-fft) 23:29:24 INFO - PROCESS | 735 | RSS: Main: 265023488 23:29:24 INFO - PROCESS | 735 | 23:29:26 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40403/tests/kraken/driver.html?testName=audio-oscillator) 23:29:26 INFO - PROCESS | 735 | RSS: Main: 174911488 23:29:26 INFO - PROCESS | 735 | 23:29:29 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:29 INFO - PROCESS | 735 | RSS: Main: 178958336 23:29:29 INFO - PROCESS | 735 | 23:29:33 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40403/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:33 INFO - PROCESS | 735 | RSS: Main: 214577152 23:29:33 INFO - PROCESS | 735 | 23:29:37 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40403/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:37 INFO - PROCESS | 735 | RSS: Main: 211832832 23:29:37 INFO - PROCESS | 735 | 23:29:40 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40403/tests/kraken/driver.html?testName=json-parse-financial) 23:29:41 INFO - PROCESS | 735 | RSS: Main: 212979712 23:29:41 INFO - PROCESS | 735 | 23:29:43 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:43 INFO - PROCESS | 735 | RSS: Main: 205254656 23:29:43 INFO - PROCESS | 735 | 23:29:45 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:46 INFO - PROCESS | 735 | RSS: Main: 209035264 23:29:46 INFO - PROCESS | 735 | 23:29:48 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:48 INFO - PROCESS | 735 | RSS: Main: 216408064 23:29:48 INFO - PROCESS | 735 | 23:29:51 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:52 INFO - PROCESS | 735 | RSS: Main: 223227904 23:29:52 INFO - PROCESS | 735 | 23:29:54 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:55 INFO - PROCESS | 735 | RSS: Main: 219516928 23:29:55 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:40403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40403/tests/kraken/driver.html?testName=ai-astar) 23:29:57 INFO - PROCESS | 735 | RSS: Main: 265641984 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | __start_tp_report 23:29:57 INFO - PROCESS | 735 | _x_x_mozilla_page_load 23:29:57 INFO - PROCESS | 735 | _x_x_mozilla_page_load_details 23:29:57 INFO - PROCESS | 735 | |i|pagename|runs| 23:29:57 INFO - PROCESS | 735 | |0;ai-astar;110;104;110;110;108;111;109;109;110;111 23:29:57 INFO - PROCESS | 735 | |1;audio-beat-detection;152;130;147;217;124;152;156;131;184;124 23:29:57 INFO - PROCESS | 735 | |2;audio-dft;162;161;161;161;165;162;161;159;160;160 23:29:57 INFO - PROCESS | 735 | |3;audio-fft;76;75;77;162;76;74;75;74;132;75 23:29:57 INFO - PROCESS | 735 | |4;audio-oscillator;92;92;147;93;91;92;127;92;92;121 23:29:57 INFO - PROCESS | 735 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;127;117;118 23:29:57 INFO - PROCESS | 735 | |6;imaging-darkroom;145;145;146;145;145;145;145;145;145;145 23:29:57 INFO - PROCESS | 735 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 23:29:57 INFO - PROCESS | 735 | |8;json-parse-financial;55;54;54;54;54;55;53;106;52;54 23:29:57 INFO - PROCESS | 735 | |9;json-stringify-tinderbox;58;59;59;59;59;58;59;58;59;59 23:29:57 INFO - PROCESS | 735 | |10;stanford-crypto-aes;78;79;79;79;77;78;79;79;79;79 23:29:57 INFO - PROCESS | 735 | |11;stanford-crypto-ccm;119;118;136;120;126;115;118;121;194;134 23:29:57 INFO - PROCESS | 735 | |12;stanford-crypto-pbkdf2;166;161;162;162;168;159;158;166;162;161 23:29:57 INFO - PROCESS | 735 | |13;stanford-crypto-sha256-iterative;63;63;63;62;63;62;62;61;62;61 23:29:57 INFO - PROCESS | 735 | __end_tp_report 23:29:57 INFO - PROCESS | 735 | __start_cc_report 23:29:57 INFO - PROCESS | 735 | _x_x_mozilla_cycle_collect,1821 23:29:57 INFO - PROCESS | 735 | __end_cc_report 23:29:57 INFO - PROCESS | 735 | __startTimestamp1463466597375__endTimestamp 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | ------- Summary: start ------- 23:29:57 INFO - PROCESS | 735 | Number of tests: 14 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.04 (1.9%) stddev-sans-first:2.15 23:29:57 INFO - PROCESS | 735 | Values: 110.0 104.0 110.0 110.0 108.0 111.0 109.0 109.0 110.0 111.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:152.00 stddev:29.41 (19.3%) stddev-sans-first:31.19 23:29:57 INFO - PROCESS | 735 | Values: 152.0 130.0 147.0 217.0 124.0 152.0 156.0 131.0 184.0 124.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 23:29:57 INFO - PROCESS | 735 | Values: 162.0 161.0 161.0 161.0 165.0 162.0 161.0 159.0 160.0 160.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#3] audio-fft Cycles:10 Average:89.60 Median:75.00 stddev:31.08 (41.4%) stddev-sans-first:32.57 23:29:57 INFO - PROCESS | 735 | Values: 76.0 75.0 77.0 162.0 76.0 74.0 75.0 74.0 132.0 75.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:92.00 stddev:20.21 (22.0%) stddev-sans-first:20.97 23:29:57 INFO - PROCESS | 735 | Values: 92.0 92.0 147.0 93.0 91.0 92.0 127.0 92.0 92.0 121.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:3.29 (2.8%) stddev-sans-first:3.48 23:29:57 INFO - PROCESS | 735 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 127.0 117.0 118.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 23:29:57 INFO - PROCESS | 735 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:29:57 INFO - PROCESS | 735 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:54.00 stddev:16.50 (30.6%) stddev-sans-first:17.44 23:29:57 INFO - PROCESS | 735 | Values: 55.0 54.0 54.0 54.0 54.0 55.0 53.0 106.0 52.0 54.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 23:29:57 INFO - PROCESS | 735 | Values: 58.0 59.0 59.0 59.0 59.0 58.0 59.0 58.0 59.0 59.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 23:29:57 INFO - PROCESS | 735 | Values: 78.0 79.0 79.0 79.0 77.0 78.0 79.0 79.0 79.0 79.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:123.50 stddev:23.52 (19.0%) stddev-sans-first:24.60 23:29:57 INFO - PROCESS | 735 | Values: 119.0 118.0 136.0 120.0 126.0 115.0 118.0 121.0 194.0 134.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.00 stddev:3.21 (2.0%) stddev-sans-first:3.14 23:29:57 INFO - PROCESS | 735 | Values: 166.0 161.0 162.0 162.0 168.0 159.0 158.0 166.0 162.0 161.0 23:29:57 INFO - PROCESS | 735 | 23:29:57 INFO - PROCESS | 735 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.78 23:29:57 INFO - PROCESS | 735 | Values: 63.0 63.0 63.0 62.0 63.0 62.0 62.0 61.0 62.0 61.0 23:29:57 INFO - PROCESS | 735 | -------- Summary: end -------- 23:29:57 INFO - PROCESS | 735 | 23:29:58 INFO - TEST-INFO | 735: exit 0 23:29:58 INFO - TEST-OK | kraken | took 62109ms 23:29:58 INFO - SUITE-END | took 1174s 23:29:58 INFO - Completed test suite (00:19:34) 23:29:58 INFO - javascript benchmark 23:29:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.448321543731, 3157.305392813581, 3161.573187619672, 3212.052444528864, 3217.6138863336405, 5190.688558686482, 5239.502247286502, 5284.339457567804, 5372.274742909706, 5419.26839876617, 5285.6300058995885, 5318.654287471311, 5333.413324534308, 5334.706591137486, 5346.625736198468, 4805.183118869783, 4809.302651115586, 4913.3612630358, 4916.680415772981, 4954.628402869781, 4853.029394121172, 4870.780814863339, 4919.0, 4926.704397736129, 4935.383077115361, 4730.219513780222, 4839.7096174229655, 4841.15279826029, 4905.435874874382, 4913.263010548446, 4901.240307752304, 4912.312276281288, 4916.877078073041, 4934.432540257881, 4961.231009193581, 4720.291956206562, 4791.808327666889, 4900.754962251873, 4912.238603016538, 4933.629977751647, 5208.088584497697, 5268.6575372600655, 5269.499397557226, 5310.309659744208, 5312.203169524563, 5650.208970744099, 5736.082226843727, 5736.4550367715, 5739.799107031234, 5745.511631511326, 5641.464060914206, 5678.517326027292, 5680.7727690892725, 5737.684427356494, 5800.53595712342, 5369.731513424314, 5410.648307859977, 5413.810516631899, 5417.431169727161, 5418.593605479566, 5844.1818145459665, 5852.092925596539, 5865.3254875689845, 5867.70661466925, 5871.530277577784, 5439.0, 5529.474699903502, 5571.331440227199, 5582.637128586629, 5675.4892059714, 5657.660540367591, 5664.093745000862, 5677.034904066319, 5677.489025987681, 5689.544836413077, 5662.320521537442, 5663.1505274208375, 5663.461971112738, 5666.773329066791, 5668.489835914787, 5500.064988951888, 5672.177534257509, 5713.800016999468, 5740.68426236561, 5785.82642520725, 4410.845620403271, 4426.867193984185, 4428.756418397019, 4440.0, 4472.038511719996, 3857.9807100964877, 3916.4321173429694, 3938.5470670873215, 3974.841006359771, 4004.7797371144284, 5345.251664766935, 5375.677459352373, 5385.78456861729, 5401.0, 5404.648697834628, 5659.688717120598, 5688.48803607669, 5692.174634677948, 5692.430756924357, 5703.54371650267, 5290.365156181283, 5346.117890548094, 5405.864853378618, 5412.729363531807, 5471.534919531884, 4943.332650092263, 4944.950550494521, 4945.109880221523, 4945.604351651931, 5004.9499505005215, 5909.025010873243, 5979.133025711248, 5979.312379076462, 5983.970080149658, 5988.431099045583, 5527.226188333556, 5706.172604972338, 5738.311402631627, 5756.194132821324, 5786.797462088806, 6049.092636104443, 6068.271807383142, 6072.423119803611, 6081.6655083969035, 6101.7559297627595, 5572.804951826666, 5585.301837270341, 5586.804461843816, 5591.776328946797, 5597.188407680945, 5571.387147413862, 5653.462921022497, 5658.236138121466, 5664.546836253007, 5699.715014249188, 5581.386047534686, 5584.329880414376, 5584.944150558605, 5586.413426590149, 5588.524975377139, 5523.483997893582, 5535.944640553543, 5576.525995290446, 5578.0, 5581.10702287632, 5381.811636592857, 5456.91814622773, 5488.588355873246, 5513.228148059195, 5556.916646250229, 5669.461401166883, 5675.0, 5681.971590142023, 5706.28671416073, 5723.5707321950185, 5369.677819330853, 5535.916961245665, 5538.196961440649, 5540.63985840919, 5580.274564306615], "value": 5275.804812398227, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.1132380695603, 649.3960616626537, 656.7241758461446, 662.4236913884921, 665.4742753224953, 43853.561464385384, 45074.54925450749, 45106.54893451065, 45208.547914520845, 49380.259296110584, 46707.0, 47273.39996300202, 47310.0, 47322.053558928885, 47389.289160662614, 8937.597808098635, 9130.726078217664, 9131.771705707344, 9134.314926380515, 9135.54322283883, 8877.112288771135, 8945.0607686193, 8951.194392504673, 8956.0, 8991.820163596723, 9041.14109159632, 9081.409708368968, 9088.045755195708, 9091.727248182531, 9094.136057074567, 8976.416532925372, 8989.190972812445, 9003.864942025875, 9006.234470070052, 9010.774730631721, 8949.776255593597, 9006.414583052081, 9024.187823095886, 9031.548422578844, 9036.0, 42046.36930446046, 42573.57426425727, 42587.7870610645, 42593.148137037395, 42607.57392426067, 3773.339665558544, 3844.6347596978244, 3866.420036994445, 3941.4679018332445, 4113.239050775616, 32098.839505802556, 32624.0, 32716.6728332716, 32931.50602740961, 32952.0, 4241.851535196284, 4255.446791917062, 4331.45856767904, 4339.457567804025, 4356.869293921188, 353004.0, 354204.0, 355772.0, 356113.21943390375, 356255.0, 59162.11256831151, 59386.70306648526, 59879.401205987386, 59896.401035989955, 59941.0, 55337.1699424509, 58443.70778146082, 62769.058464123074, 62801.68599156975, 62823.0, 14927.776083358758, 15604.0, 15628.2185890705, 15651.765223521656, 15659.921700391425, 11797.29216247028, 11979.10156738248, 11982.88017119835, 11991.820122698167, 12006.399680015964, 15437.691246175014, 16073.758893616605, 16380.508584742476, 16617.750733739005, 16699.165041748107, 6138.294096178996, 6198.411150940653, 6204.3795620437595, 6293.433590976834, 6382.0, 1009.8232809258351, 1018.5874720738113, 1154.9826752598717, 1168.4683469021575, 1170.9590164344206, 30533.236669083006, 31927.840360798513, 31935.201619959687, 32069.35861282761, 32444.675553244637, 1126.994365028186, 1198.836100837996, 1218.1009198108445, 1236.9072319576069, 1251.5431867368345, 17007.149642517823, 17027.148642567823, 17085.829141708673, 17191.57021074458, 17212.225449854788, 543128.0, 544787.0, 547449.0, 548662.0, 552200.0, 59979.40020599825, 60122.39877601255, 60165.09752353718, 60188.0, 60276.0, 1368.774152264885, 1396.8253968253969, 1405.0586107307925, 1421.3248706864363, 1429.4925301518226, 30632.081037568907, 31127.0, 31373.215669608442, 31880.202994925312, 31953.360932781678, 50679.74660126676, 50918.745406272734, 51045.744771277394, 51153.74423128009, 51225.487745122075, 448712.0, 456849.0, 457672.0, 458627.0, 458810.0, 24941.0, 28407.431851362442, 28793.42413151767, 28899.711002890544, 29642.85178574093, 47391.52608473871, 48772.75613621909, 49253.75373123112, 52522.47477525176, 53897.730511347196, 39743.2051358977, 40264.194716104925, 41006.0, 43743.34384984292, 45554.77222613866, 40416.59583404128, 41297.0, 41519.792401037805, 41521.0, 42693.14613707647, 41778.74663760092, 42265.0, 42552.57447425486, 42646.57353426426, 42689.14621707611, 35417.0, 36666.63333366739, 36705.0, 37302.253954920205, 37385.252294954495, 28486.287842804097, 28855.42289154163, 29110.417791643624, 29142.0, 29218.123456296344], "value": 20353.365809543622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.88903329001295, 398.40836358008363, 406.5934065934066, 411.2638377304625, 418.5830962192978, 16559.586010349747, 19932.800671993275, 20131.698024529625, 20192.899035504837, 22279.108835646595, 18541.16564754586, 18884.33904813332, 19501.21995120197, 20482.385528434133, 20483.795162048376, 5706.99999999999, 5895.0, 5998.700064996755, 6608.636524991123, 6623.105880706091, 6413.0, 6596.7691130810435, 6622.966885165568, 6656.534042617019, 6707.0, 6551.508636852232, 6586.176727909012, 6588.176477940257, 6588.407043366096, 6591.209054913417, 6487.448566871822, 6544.509161812859, 6546.11627430298, 6551.574147680433, 6568.573042752206, 5637.548996080303, 5738.512226460756, 5766.509846663039, 5777.768889244425, 5801.216835727208, 22771.430714232112, 23922.64116038261, 24341.87829060861, 24386.390340241458, 24405.51188976228, 2622.462395208978, 2714.0510557139314, 2739.849308288043, 2753.3391985923436, 3138.7959782614057, 14222.359993800304, 14493.130412175304, 14514.201718905457, 14590.489332873405, 14780.408783648641, 1922.2887531613253, 1993.900304984745, 2027.7161197432372, 2084.4372019554785, 2152.3435352217566, 73283.63358183175, 75481.24518754797, 76878.0, 80263.0, 85796.57101714514, 17326.353996370326, 17701.645967080585, 17728.202230899642, 17742.467725968243, 17891.1948962297, 31382.843085784425, 31414.528782068286, 31622.525662115087, 31664.208394790316, 31802.2049448761, 9562.856557151648, 9719.65981190655, 9807.558659860324, 9946.950265248772, 9963.501824908726, 8049.597520124087, 8105.0, 8267.421280510307, 8286.70996515131, 8291.543965081979, 9025.81948361029, 9084.636614535477, 9152.267818574499, 9191.632334706537, 9219.631214751334, 3215.7266632336045, 3322.9335413291597, 3385.509101180315, 3451.447768357101, 3577.94633080504, 940.722486866376, 1016.974575635615, 1023.0741179232806, 1069.2996087562503, 1088.7822435512928, 18508.722369164472, 19125.713114303297, 19490.610187796447, 19648.70526942097, 19799.40601781949, 1010.9696709098739, 1027.1628622672497, 1028.7428142964259, 1045.628801775374, 1051.3901936876593, 10766.838497422545, 11072.335659860435, 11114.388708620942, 11115.944420277847, 11152.330860148417, 172004.0, 172270.0, 499553.0, 513812.0, 522546.0, 94716.0, 104228.47885760522, 104980.22608756591, 105012.0, 106429.46785266024, 1023.7901230247782, 1061.8778840433295, 1102.1293178388983, 1104.47537419725, 1109.2734259060328, 17471.0, 17483.82516174822, 17545.210465528828, 17735.911320443316, 17801.46595602134, 30786.0, 34050.14874628154, 36962.0, 37436.812815935744, 37801.81099094487, 46934.53065469438, 57751.4224857746, 57754.422455776585, 58106.418935811795, 58477.0, 7641.6561254742555, 7929.5242285463055, 8589.0, 8628.827423451621, 8872.866906996529, 13536.12015219047, 13700.45198192061, 13867.029307948347, 13924.721505570034, 13944.930275348965, 12089.637310880687, 12199.207051541622, 12284.683135553172, 12570.603896588545, 12581.308028058545, 11507.482163302504, 12020.459079341275, 12133.393330333625, 12156.149069565046, 12394.380280986095, 12222.572209972608, 12291.32397718134, 12560.811587826372, 12573.811392829299, 12673.302968336462, 7948.40386970991, 8015.519068855887, 8108.2297181767635, 8196.42625016243, 8360.623771930399, 11684.941575292069, 11954.760904781682, 12030.939845300718, 12212.08409369283, 12256.693582660148], "value": 10237.51019411755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.443038354275, 1505.7816616590594, 1532.4023630783993, 1693.0, 1834.5963887944656, 8517.446365986214, 8842.204201621853, 8866.024737278894, 9145.771355716093, 9154.771130721736, 8849.867251991225, 9067.047959964208, 9074.319426043041, 9076.273898088153, 9096.909030909688, 2086.7704552499213, 2137.700721898935, 2253.267688001398, 2359.056377449021, 2391.8325717199714, 2367.479154585997, 2370.1349007612184, 2371.419002344428, 2372.027468737809, 2374.7387787343378, 2327.5577640248384, 2350.0, 2353.235198560466, 2353.788159065684, 2360.881955902198, 1993.2027189124321, 2242.416971587399, 2300.5283916797016, 2316.6061769499224, 2325.802306803924, 2308.4344335637707, 2333.8833058347186, 2353.094058787362, 2355.470019245673, 2355.905763769464, 8918.866217006751, 8957.731268061969, 8970.686025989124, 8975.147361000694, 8975.416597921114, 5323.01524218017, 5450.018996580614, 5451.64564303319, 5464.207689884985, 5467.890642187173, 3333.0500807269814, 3359.0930448778936, 3389.915252118692, 3478.008767501275, 3488.302339532104, 1048.821700310949, 1055.1927775251938, 1071.2019545438698, 1088.3089238333637, 1094.409019129669, 12471.0, 12476.313802740846, 12506.937465312616, 12516.311602861839, 12517.0, 4789.640776941744, 4790.9329448972985, 4847.079054979543, 4872.1473742094995, 4890.437599676012, 10574.259801813952, 10574.89425105739, 10581.947090264654, 10591.152707783513, 10598.841017384746, 5417.458254174551, 5422.0511410503, 5422.213779002022, 5430.56555475561, 5432.7555260012605, 4411.448568928884, 4883.58489528387, 5017.096922553976, 5022.673526220784, 5104.591632669378, 4117.258893399157, 4138.6482149017065, 4162.6698641087005, 4184.100418409996, 4216.198922204771, 1289.1298373597783, 1323.3846261488454, 1331.766940785378, 1349.4602159136423, 1350.7906274527268, 819.1521774962885, 882.7484167012499, 973.8587904753771, 987.6098940918297, 1004.2568499310457, 6099.115628233882, 6100.0849872519475, 6229.4393504583895, 6256.405641464054, 6258.249010118815, 485.0807719371771, 486.4624589828189, 486.7152715661307, 493.5015634209403, 498.7456397237435, 4364.148990946735, 4529.773511324421, 4561.657875659339, 4569.565891240327, 4583.954160458419, 10869.728256793644, 11150.107991360672, 11190.832137517944, 11236.325820450798, 11271.718207044889, 10881.238313317992, 11187.440627968568, 11194.720131996764, 11196.832047519294, 11212.943935280435, 8208.917910820936, 8297.294729948022, 8378.245957863699, 8389.370797190113, 8402.0, 6087.543434242538, 6211.9689401554515, 6319.557630965788, 6334.461570766536, 6401.071844582602, 10201.234907381828, 10378.42918639482, 10485.108765754996, 10499.107575855833, 10522.31604945676, 10449.373037617766, 10559.260851740612, 10563.735906602396, 10587.258891877495, 10730.73173170677, 7327.450441217036, 7626.4661473698525, 7847.293743563107, 7944.801379965547, 8051.597420128853, 8725.825483490422, 8796.868046979173, 8819.514926678838, 8826.073262307365, 8830.116988301119, 7700.691972321044, 7715.4599178057, 7809.726659566888, 7839.294463498084, 8000.439969202333, 7730.149683534919, 7795.181505941794, 7858.292753652198, 7882.369410447036, 7896.210378962058, 7198.100237470317, 7244.130704315516, 7291.161516425679, 7302.56184628924, 7309.451791115581, 5454.29094217765, 5504.091824849015, 5564.1931919870585, 5607.663540187602, 5614.101743720985, 5343.3587969443915, 5397.8380648580605, 5541.362743284412, 5588.86027849307, 5670.064439367623], "value": 4663.886419523902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5114412904526, 336.8097025180773, 340.5521738913327, 344.66395264617, 344.9017030146409, 5286.154215325549, 5301.628885977983, 5308.601854860886, 5313.628046036779, 5352.892942141165, 5228.555572776309, 5233.398159211692, 5267.28891599634, 5267.47325267473, 5267.762950667219, 3968.226195891802, 4202.894927626803, 4205.642520385763, 4211.347241177622, 4226.1336426032585, 3947.427622994664, 4024.416459613354, 4071.71497995139, 4153.833846646131, 4159.438475805773, 4101.507819061717, 4126.607972242632, 4129.834806607732, 4135.338345864662, 4163.20899029185, 4130.586941305875, 4144.316187829005, 4157.708960372775, 4177.0, 4178.435911151986, 3511.4030614795547, 3616.65641764032, 3711.721620878445, 3714.9257014859822, 3720.6233693533295, 5105.463926287761, 5117.744112794383, 5126.846194614168, 5127.0, 5157.458466860963, 4774.641901857374, 4785.306130611077, 4787.40157480315, 4802.447718512346, 4804.759762011886, 5378.327709036371, 5466.715321899351, 5474.835754927359, 5498.367687715924, 5520.420355862617, 4051.210014047262, 4064.3700226464944, 4069.3895915612597, 4072.490938632671, 4087.0804069084516, 5481.040817856899, 5484.451554844523, 5715.257016587859, 5728.22668939692, 5732.426757324234, 4123.670106391482, 4132.483439570054, 4136.400221967858, 4140.296149654566, 4142.275101857163, 4198.005947175128, 4208.600182982673, 4219.852305169305, 4229.830806767756, 4234.597713217239, 4554.63562914966, 4746.528576141407, 4768.451628062817, 4779.354787103766, 4794.232922732346, 5538.723063846792, 5543.223948647112, 5574.16387541872, 5579.609427340048, 5598.188262701967, 1431.4059665239017, 1444.8410674825761, 1453.7643003447197, 1462.8756555692673, 1462.9122252664874, 906.6781292641017, 936.162134889284, 945.8439357505935, 956.0, 963.9566219520138, 4830.734309613005, 4868.513148685103, 4871.732054737024, 4919.0, 4945.922712460775, 5165.405978312467, 5179.203230255695, 5183.092958732207, 5187.662801917863, 5196.584273258206, 4489.846397387988, 4855.732934688626, 4886.706797592155, 4895.779689913962, 4921.064997650435, 2700.4734076854825, 2706.8917243310048, 2708.349996000946, 2724.4823483538066, 2726.7682247009225, 5322.467753224724, 5329.360476742816, 5345.717027913351, 5354.544863686552, 5365.731713414314, 4851.708897466164, 5084.245935152367, 5161.716105614152, 5168.948310516922, 5208.9739551302, 5279.788808447619, 5329.307190065267, 5330.626856120034, 5333.373321137013, 5355.839324820339, 5043.697378157322, 5049.6465247432325, 5139.434662187082, 5170.267960233364, 5202.505761952609, 4773.952260477351, 5047.41954675217, 5055.7472126392795, 5063.392392912874, 5070.340855688737, 5718.399568045295, 5824.650520968756, 5903.881922361615, 5955.451582588472, 5978.3423823378525, 4181.519125300508, 4186.351115576968, 4189.329707246826, 4204.663626909779, 4224.239636865394, 5539.534906966523, 5588.580856435702, 5656.6888821115235, 5711.428857114422, 5738.282714660668, 5506.421825708403, 5513.58648101386, 5514.283143191359, 5521.254630624814, 5521.447855214607, 5511.53151982086, 5528.75120619565, 5551.666899985852, 5556.277683901067, 5573.470520300565, 5171.586273098218, 5501.697406642673, 5505.614606977473, 5514.2004409359615, 5563.610547261653, 5665.49010589049, 5668.121441176624, 5682.232898558807, 5685.744141513725, 5688.573356998324, 5462.562994960314, 5478.890422191614, 5570.693611851387, 5581.609287349846, 5602.963451761437], "value": 4147.971678924358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.7449303469407, 846.2257034813147, 849.3502470609984, 855.7603870916141, 891.5230351761807, 14355.569332920002, 14373.78439323411, 14383.712325753491, 14536.491222807204, 15102.546923592296, 12509.68725781856, 12914.935425322883, 12940.48238070476, 13287.202767833936, 13367.732645347087, 706.1984647425159, 817.8323443694028, 848.6223630484421, 849.2781136034353, 855.3499340501202, 835.9749207523754, 849.5624753252049, 851.8892543969275, 852.2585350744861, 852.8678054901469, 882.2368651116802, 887.4896934262792, 888.2139306713541, 888.4180861535705, 888.6623083228365, 730.8026832755179, 867.5445391169686, 879.6789171952255, 880.6521424037502, 880.7886107334258, 638.7285403703407, 639.2871947778241, 639.9520035997319, 640.186962557554, 641.8908785506428, 14251.643708907257, 14276.500322488768, 14288.642783930381, 14306.141631502143, 14330.49843255481, 12220.877791222063, 12320.445579948924, 12410.379481026002, 12487.875121248762, 12716.237025778482, 11891.28652280866, 12091.334976576285, 12278.508859645603, 12482.875171248263, 12540.937295313464, 4458.8439404621, 4542.182407166709, 4546.045330480603, 4559.224931761575, 4581.977090114528, 51229.48770512322, 53082.734586327206, 57046.14430783541, 57550.7122464385, 57659.71170144164, 10397.168226541859, 10585.576576936835, 10777.568897244179, 10885.83671244932, 11158.832617510743, 19381.0, 19383.51541211481, 19433.0, 19440.319588814324, 19441.708374374397, 8127.0, 8274.917250827535, 8275.0, 8297.0, 8426.789330266669, 4607.883055105906, 4682.157211701859, 4767.713937163781, 4892.217245240816, 4964.032013757283, 3451.861925523001, 3528.770629909048, 3529.2059286660296, 3529.7176225901867, 3539.8407071681836, 630.3098107572201, 636.9649669268234, 644.6196743921109, 646.6152639179775, 671.4091599392601, 682.9453643708491, 686.6120641837346, 696.4393663101253, 762.1920763990188, 781.9022622172229, 9902.851457228147, 9959.950200249097, 10070.546825392876, 10094.343867648578, 10094.646687366054, 711.3283240253837, 721.5200551809003, 743.9702411903571, 750.5459197185734, 765.12775436003, 4532.4334458192725, 4644.187267228222, 4656.3713898623255, 4692.249240121632, 4738.265568836836, 63851.49019821447, 64949.35050649528, 68119.65940170268, 68863.0, 69173.30826691669, 58729.0, 59032.21129570068, 60134.69932650309, 60352.39647603556, 60593.0, 51318.48681513137, 51624.0, 51681.7415912918, 51917.48082519202, 52008.21987670188, 8755.0, 8898.45818793758, 8900.643974240958, 8954.417962832395, 9051.773705657411, 36143.81928090343, 37405.2518949614, 37531.2493750118, 38053.23893522169, 38420.807895960344, 46257.0, 52011.21983170331, 52103.73948130235, 53742.0, 54591.72704136454, 12647.873521265037, 12845.871541284467, 12846.550370736979, 13163.67090822737, 14038.017338786187, 13877.306134693426, 14430.783538246726, 14438.278086095443, 14800.0, 14898.553043408716, 9538.666146684833, 10875.510602023087, 12949.417276222404, 13350.132241404277, 14011.719765604426, 13861.4455421782, 13948.0, 14055.367508462348, 14077.929610351883, 14094.029591811364, 13701.109427887155, 13845.161741842696, 14004.229767362893, 14120.646983825487, 14740.631484212981, 10876.945615271872, 11264.38045907483, 11355.886441135483, 11394.601188958346, 11698.35659038761, 10454.335070248007, 10468.68593942183, 10511.164824474776, 10550.103241224582, 10574.89425105739], "value": 7001.931309681141, "unit": "score"}], "name": "dromaeo_css", "value": 7280.504639244754, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 110.0, 108.0, 111.0, 109.0, 109.0, 110.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 147.0, 217.0, 124.0, 152.0, 156.0, 131.0, 184.0, 124.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 165.0, 162.0, 161.0, 159.0, 160.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 162.0, 76.0, 74.0, 75.0, 74.0, 132.0, 75.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 93.0, 91.0, 92.0, 127.0, 92.0, 92.0, 121.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 127.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 106.0, 52.0, 54.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 79.0, 77.0, 78.0, 79.0, 79.0, 79.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 136.0, 120.0, 126.0, 115.0, 118.0, 121.0, 194.0, 134.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 162.0, 162.0, 168.0, 159.0, 158.0, 166.0, 162.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1524.5999999999997, "alertThreshold": 2.0}]} 23:29:58 INFO - Return code: 0 23:29:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:29:58 ERROR - # TBPL SUCCESS # 23:29:58 INFO - Running post-action listener: _resource_record_post_action 23:29:58 INFO - ##### 23:29:58 INFO - ##### Finished run-tests step (success) 23:29:58 INFO - ##### 23:29:58 INFO - Running post-run listener: _resource_record_post_run 23:29:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 537231360; Read time: 0; Write time: 591448 23:29:58 INFO - TinderboxPrint: CPU usage
13.2% 23:29:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:29:58 INFO - TinderboxPrint: I/O write bytes / time
537,231,360 / 591,448 23:29:58 INFO - TinderboxPrint: CPU idle
8,260.5 (86.8%) 23:29:58 INFO - TinderboxPrint: CPU user
1,207.1 (12.7%) 23:29:58 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:58 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 246280192; Read time: 0; Write time: 380860 23:29:58 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290951168; Read time: 0; Write time: 210588 23:29:59 INFO - Running post-run listener: _upload_blobber_files 23:29:59 INFO - Blob upload gear active. 23:29:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29:59 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:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:29:59 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:29:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:00 INFO - (blobuploader) - INFO - Done attempting. 23:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:01 INFO - (blobuploader) - INFO - Done attempting. 23:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:05 INFO - (blobuploader) - INFO - Done attempting. 23:30:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:05 INFO - Return code: 0 23:30:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1060efcb78ff610c153e8da5366048c3f09a5b6339885a5aeaa02855e383ac40e63351e79b34327218a2abf7eac0bbf0a4d484a4d05a17b9d8bff0eee4a2a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0315cef16379198ff1fbd3c036ce36a67693ca1ed69b29a44f77b74e5764dd33e899825dd512b13e662e04ded2bd846c1bee79a9bcd2e1c12a5de13de3224fd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e2a6bd38708fa4a87202b9da59878e8bf9d48f99734dae2df0ce8024bd4809e3e88006e6b5ec79c0afc46a02b94280bed9f363635c42948fe3ebdce2236d2cf"} 23:30:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:05 INFO - Contents: 23:30:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1060efcb78ff610c153e8da5366048c3f09a5b6339885a5aeaa02855e383ac40e63351e79b34327218a2abf7eac0bbf0a4d484a4d05a17b9d8bff0eee4a2a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0315cef16379198ff1fbd3c036ce36a67693ca1ed69b29a44f77b74e5764dd33e899825dd512b13e662e04ded2bd846c1bee79a9bcd2e1c12a5de13de3224fd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e2a6bd38708fa4a87202b9da59878e8bf9d48f99734dae2df0ce8024bd4809e3e88006e6b5ec79c0afc46a02b94280bed9f363635c42948fe3ebdce2236d2cf"} 23:30:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:05 INFO - Copying logs to upload dir... 23:30:05 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.449033 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-16 23:30:05.245996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:30:05.250001) ========= 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=62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1060efcb78ff610c153e8da5366048c3f09a5b6339885a5aeaa02855e383ac40e63351e79b34327218a2abf7eac0bbf0a4d484a4d05a17b9d8bff0eee4a2a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0315cef16379198ff1fbd3c036ce36a67693ca1ed69b29a44f77b74e5764dd33e899825dd512b13e662e04ded2bd846c1bee79a9bcd2e1c12a5de13de3224fd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e2a6bd38708fa4a87202b9da59878e8bf9d48f99734dae2df0ce8024bd4809e3e88006e6b5ec79c0afc46a02b94280bed9f363635c42948fe3ebdce2236d2cf"} build_url:https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/L8mhixN-T7mZRG5kmg-7Ww/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/sha512/a1060efcb78ff610c153e8da5366048c3f09a5b6339885a5aeaa02855e383ac40e63351e79b34327218a2abf7eac0bbf0a4d484a4d05a17b9d8bff0eee4a2a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0315cef16379198ff1fbd3c036ce36a67693ca1ed69b29a44f77b74e5764dd33e899825dd512b13e662e04ded2bd846c1bee79a9bcd2e1c12a5de13de3224fd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e2a6bd38708fa4a87202b9da59878e8bf9d48f99734dae2df0ce8024bd4809e3e88006e6b5ec79c0afc46a02b94280bed9f363635c42948fe3ebdce2236d2cf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:30:05.276281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:30:05.276750) ========= 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=62c568580acbfdaac3eec7be000001dc-1463465335.501410-389531375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004364 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:30:05.359380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:30:05.359714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:30:05.360026) ========= ========= Total master_lag: 0.18 =========