builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1464372850.26 results: success (0) buildid: 20160527083030 builduid: 9ee2b1d347ba4810bf412250fb09bf60 revision: dd3e899cfa818fcbb47b3d7432e0977e835702ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.262062) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.262546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.262840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.277743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.278140) ========= 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=0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 11:14:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.0M=0s 2016-05-27 11:14:10 (90.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.344902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.639605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.640154) ========= 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=0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018825 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:10.690951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 11:14:10.691385) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd3e899cfa818fcbb47b3d7432e0977e835702ee --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 dd3e899cfa818fcbb47b3d7432e0977e835702ee --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=0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 11:14:10,853 truncating revision to first 12 chars 2016-05-27 11:14:10,853 Setting DEBUG logging. 2016-05-27 11:14:10,853 attempt 1/10 2016-05-27 11:14:10,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd3e899cfa81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 11:14:11,439 unpacking tar archive at: fx-team-dd3e899cfa81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316387 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 11:14:12.022017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:12.022360) ========= script_repo_revision: dd3e899cfa818fcbb47b3d7432e0977e835702ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:12.022785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:12.023060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 11:14:12.034019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-27 11:14:12.034366) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:12 INFO - MultiFileLogger online at 20160527 11:14:12 in /builds/slave/test 11:14:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:14:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:12 INFO - {'append_to_log': False, 11:14:12 INFO - 'base_work_dir': '/builds/slave/test', 11:14:12 INFO - 'blob_upload_branch': 'Fx-Team', 11:14:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:12 INFO - 'branch': 'Fx-Team', 11:14:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:12 INFO - 'config_files': ('talos/linux_config.py',), 11:14:12 INFO - 'default_actions': ('clobber', 11:14:12 INFO - 'read-buildbot-config', 11:14:12 INFO - 'download-and-extract', 11:14:12 INFO - 'populate-webroot', 11:14:12 INFO - 'create-virtualenv', 11:14:12 INFO - 'install', 11:14:12 INFO - 'run-tests'), 11:14:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:12 INFO - 'download_minidump_stackwalk': True, 11:14:12 INFO - 'download_symbols': 'ondemand', 11:14:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:12 INFO - 'installer_path': 'installer.exe', 11:14:12 INFO - 'log_level': 'info', 11:14:12 INFO - 'log_name': 'talos', 11:14:12 INFO - 'log_to_console': True, 11:14:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:12 INFO - 'opt_config_files': (), 11:14:12 INFO - 'pip_index': False, 11:14:12 INFO - 'sps_profile': False, 11:14:12 INFO - 'sps_profile_interval': 0, 11:14:12 INFO - 'suite': 'dromaeojs-e10s', 11:14:12 INFO - 'system_bits': '32', 11:14:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:12 INFO - 'title': 'talos-linux64-ix-017', 11:14:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:12 INFO - 'use_talos_json': True, 11:14:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:12 INFO - 'work_dir': 'build'} 11:14:12 INFO - ##### 11:14:12 INFO - ##### Running clobber step. 11:14:12 INFO - ##### 11:14:12 INFO - Running pre-action listener: _resource_record_pre_action 11:14:12 INFO - Running main action method: clobber 11:14:12 INFO - rmtree: /builds/slave/test/build 11:14:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:12 INFO - Running post-action listener: _resource_record_post_action 11:14:12 INFO - ##### 11:14:12 INFO - ##### Finished clobber step (success) 11:14:12 INFO - ##### 11:14:12 INFO - ##### 11:14:12 INFO - ##### Running read-buildbot-config step. 11:14:12 INFO - ##### 11:14:12 INFO - Running pre-action listener: _resource_record_pre_action 11:14:12 INFO - Running main action method: read_buildbot_config 11:14:12 INFO - Using buildbot properties: 11:14:12 INFO - { 11:14:12 INFO - "project": "", 11:14:12 INFO - "product": "firefox", 11:14:12 INFO - "script_repo_revision": "production", 11:14:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:14:12 INFO - "repository": "", 11:14:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:14:12 INFO - "buildid": "20160527083030", 11:14:12 INFO - "pgo_build": "True", 11:14:12 INFO - "basedir": "/builds/slave/test", 11:14:12 INFO - "buildnumber": 384, 11:14:12 INFO - "slavename": "talos-linux64-ix-017", 11:14:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:14:12 INFO - "platform": "ubuntu64_hw", 11:14:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:14:12 INFO - "branch": "fx-team", 11:14:12 INFO - "repo_path": "integration/fx-team", 11:14:12 INFO - "revision": "dd3e899cfa818fcbb47b3d7432e0977e835702ee", 11:14:12 INFO - "stage_platform": "linux64-pgo", 11:14:12 INFO - "builduid": "9ee2b1d347ba4810bf412250fb09bf60", 11:14:12 INFO - "slavebuilddir": "test" 11:14:12 INFO - } 11:14:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:14:12 INFO - Running post-action listener: _resource_record_post_action 11:14:12 INFO - ##### 11:14:12 INFO - ##### Finished read-buildbot-config step (success) 11:14:12 INFO - ##### 11:14:12 INFO - ##### 11:14:12 INFO - ##### Running download-and-extract step. 11:14:12 INFO - ##### 11:14:12 INFO - Running pre-action listener: _resource_record_pre_action 11:14:12 INFO - Running main action method: download_and_extract 11:14:12 INFO - mkdir: /builds/slave/test/build/tests 11:14:12 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')]} 11:14:12 INFO - https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:13 INFO - Downloaded 1361 bytes. 11:14:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:14:13 INFO - Using the following test package requirements: 11:14:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:14:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'jsshell-linux-x86_64.zip'], 11:14:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:13 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')]} 11:14:13 INFO - https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:14 INFO - Downloaded 24410571 bytes. 11:14:14 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'] 11:14:14 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 11:14:15 INFO - Return code: 0 11:14:15 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 11:14:15 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')]} 11:14:15 INFO - https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:16 INFO - Downloaded 24410571 bytes. 11:14:16 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'] 11:14:16 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 11:14:18 INFO - Return code: 0 11:14:18 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')]} 11:14:18 INFO - https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:19 INFO - Downloaded 10834034 bytes. 11:14:19 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'] 11:14:19 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 11:14:19 INFO - Return code: 0 11:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:19 INFO - https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9HtPD4GS0ivV37WlWws5Q/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 11:14:20 INFO - Downloaded 58750465 bytes. 11:14:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:14:20 INFO - mkdir: /builds/slave/test/properties 11:14:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:20 INFO - Contents: 11:14:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:14:21 INFO - Running post-action listener: _resource_record_post_action 11:14:21 INFO - Running post-action listener: set_extra_try_arguments 11:14:21 INFO - ##### 11:14:21 INFO - ##### Finished download-and-extract step (success) 11:14:21 INFO - ##### 11:14:21 INFO - ##### 11:14:21 INFO - ##### Running populate-webroot step. 11:14:21 INFO - ##### 11:14:21 INFO - Running pre-action listener: _resource_record_pre_action 11:14:21 INFO - Running main action method: populate_webroot 11:14:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:21 INFO - '--tppagecycles', 11:14:21 INFO - '7'], 11:14:21 INFO - 'tests': ['tsvgm']}}, 11:14:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:14:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:14:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:14:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['damp', 'tps']}, 11:14:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'tests': ['damp', 'tps']}, 11:14:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['dromaeo_dom']}, 11:14:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['a11yr', 11:14:21 INFO - 'ts_paint', 11:14:21 INFO - 'tpaint', 11:14:21 INFO - 'sessionrestore', 11:14:21 INFO - 'sessionrestore_no_auto_restore', 11:14:21 INFO - 'tabpaint']}, 11:14:21 INFO - 'other-e10s': {'tests': ['a11yr', 11:14:21 INFO - 'ts_paint', 11:14:21 INFO - 'tpaint', 11:14:21 INFO - 'sessionrestore', 11:14:21 INFO - 'sessionrestore_no_auto_restore', 11:14:21 INFO - 'tabpaint']}, 11:14:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:14:21 INFO - 'ts_paint', 11:14:21 INFO - 'tpaint', 11:14:21 INFO - 'sessionrestore', 11:14:21 INFO - 'sessionrestore_no_auto_restore', 11:14:21 INFO - 'tabpaint']}, 11:14:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:14:21 INFO - 'ts_paint', 11:14:21 INFO - 'tpaint', 11:14:21 INFO - 'sessionrestore', 11:14:21 INFO - 'sessionrestore_no_auto_restore', 11:14:21 INFO - 'tabpaint']}, 11:14:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['a11yr', 11:14:21 INFO - 'ts_paint', 11:14:21 INFO - 'tpaint', 11:14:21 INFO - 'sessionrestore', 11:14:21 INFO - 'sessionrestore_no_auto_restore', 11:14:21 INFO - 'tabpaint']}, 11:14:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['a11yr', 11:14:21 INFO - 'ts_paint', 11:14:21 INFO - 'tpaint', 11:14:21 INFO - 'sessionrestore', 11:14:21 INFO - 'sessionrestore_no_auto_restore', 11:14:21 INFO - 'tabpaint']}, 11:14:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['tsvgx', 11:14:21 INFO - 'tsvgr_opacity', 11:14:21 INFO - 'tart', 11:14:21 INFO - 'tscrollx', 11:14:21 INFO - 'cart']}, 11:14:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:14:21 INFO - 'tsvgr_opacity', 11:14:21 INFO - 'tart', 11:14:21 INFO - 'tscrollx', 11:14:21 INFO - 'cart']}, 11:14:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'talos_options': ['--disable-e10s'], 11:14:21 INFO - 'tests': ['tp5o']}, 11:14:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'tests': ['tp5o']}, 11:14:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'talos_options': ['--disable-e10s', 11:14:21 INFO - '--xperf_path', 11:14:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:21 INFO - 'tests': ['tp5n']}, 11:14:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:21 INFO - 'talos_options': ['--xperf_path', 11:14:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:21 INFO - 'tests': ['tp5n']}}, 11:14:21 INFO - 'talos.zip': {'path': '', 11:14:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:21 INFO - Running post-action listener: _resource_record_post_action 11:14:21 INFO - ##### 11:14:21 INFO - ##### Finished populate-webroot step (success) 11:14:21 INFO - ##### 11:14:21 INFO - ##### 11:14:21 INFO - ##### Running create-virtualenv step. 11:14:21 INFO - ##### 11:14:21 INFO - Running pre-action listener: _resource_record_pre_action 11:14:21 INFO - Running main action method: create_virtualenv 11:14:21 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:21 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 11:14:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:21 INFO - Using real prefix '/usr' 11:14:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:22 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:24 INFO - Installing pip.................done. 11:14:24 INFO - Return code: 0 11:14:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:24 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:24 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 11:14:24 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 11:14:24 INFO - Using env: {'DISPLAY': ':0', 11:14:24 INFO - 'HOME': '/home/cltbld', 11:14:24 INFO - 'LANG': 'en_US.UTF-8', 11:14:24 INFO - 'LANGUAGE': 'en_US:en', 11:14:24 INFO - 'LOGNAME': 'cltbld', 11:14:24 INFO - 'MAIL': '/var/mail/cltbld', 11:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:24 INFO - 'MOZ_NO_REMOTE': '1', 11:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:24 INFO - 'NO_EM_RESTART': '1', 11:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:24 INFO - 'PWD': '/builds/slave/test', 11:14:24 INFO - 'SHELL': '/bin/bash', 11:14:24 INFO - 'SHLVL': '1', 11:14:24 INFO - 'TERM': 'linux', 11:14:24 INFO - 'TMOUT': '86400', 11:14:24 INFO - 'USER': 'cltbld', 11:14:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:24 INFO - '_': '/tools/buildbot/bin/python'} 11:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:24 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 11:14:24 INFO - Cleaning up... 11:14:24 INFO - Return code: 0 11:14:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:24 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:24 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 11:14:24 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 11:14:24 INFO - Using env: {'DISPLAY': ':0', 11:14:24 INFO - 'HOME': '/home/cltbld', 11:14:24 INFO - 'LANG': 'en_US.UTF-8', 11:14:24 INFO - 'LANGUAGE': 'en_US:en', 11:14:24 INFO - 'LOGNAME': 'cltbld', 11:14:24 INFO - 'MAIL': '/var/mail/cltbld', 11:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:24 INFO - 'MOZ_NO_REMOTE': '1', 11:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:24 INFO - 'NO_EM_RESTART': '1', 11:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:24 INFO - 'PWD': '/builds/slave/test', 11:14:24 INFO - 'SHELL': '/bin/bash', 11:14:24 INFO - 'SHLVL': '1', 11:14:24 INFO - 'TERM': 'linux', 11:14:24 INFO - 'TMOUT': '86400', 11:14:24 INFO - 'USER': 'cltbld', 11:14:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:24 INFO - '_': '/tools/buildbot/bin/python'} 11:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:24 INFO - Downloading/unpacking psutil>=3.1.1 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:26 INFO - Installing collected packages: psutil 11:14:26 INFO - Running setup.py install for psutil 11:14:26 INFO - building 'psutil._psutil_linux' extension 11:14:26 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 11:14:26 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 11:14:27 INFO - building 'psutil._psutil_posix' extension 11:14:27 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 11:14:27 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 11:14:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:27 INFO - Successfully installed psutil 11:14:27 INFO - Cleaning up... 11:14:27 INFO - Return code: 0 11:14:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:27 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:27 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 11:14:27 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 11:14:27 INFO - Using env: {'DISPLAY': ':0', 11:14:27 INFO - 'HOME': '/home/cltbld', 11:14:27 INFO - 'LANG': 'en_US.UTF-8', 11:14:27 INFO - 'LANGUAGE': 'en_US:en', 11:14:27 INFO - 'LOGNAME': 'cltbld', 11:14:27 INFO - 'MAIL': '/var/mail/cltbld', 11:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:27 INFO - 'MOZ_NO_REMOTE': '1', 11:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:27 INFO - 'NO_EM_RESTART': '1', 11:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:27 INFO - 'PWD': '/builds/slave/test', 11:14:27 INFO - 'SHELL': '/bin/bash', 11:14:27 INFO - 'SHLVL': '1', 11:14:27 INFO - 'TERM': 'linux', 11:14:27 INFO - 'TMOUT': '86400', 11:14:27 INFO - 'USER': 'cltbld', 11:14:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:27 INFO - '_': '/tools/buildbot/bin/python'} 11:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 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 11:14:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:14:29 INFO - Installing collected packages: mozsystemmonitor 11:14:29 INFO - Running setup.py install for mozsystemmonitor 11:14:29 INFO - Successfully installed mozsystemmonitor 11:14:29 INFO - Cleaning up... 11:14:29 INFO - Return code: 0 11:14:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:29 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:29 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 11:14:29 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 11:14:29 INFO - Using env: {'DISPLAY': ':0', 11:14:29 INFO - 'HOME': '/home/cltbld', 11:14:29 INFO - 'LANG': 'en_US.UTF-8', 11:14:29 INFO - 'LANGUAGE': 'en_US:en', 11:14:29 INFO - 'LOGNAME': 'cltbld', 11:14:29 INFO - 'MAIL': '/var/mail/cltbld', 11:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:29 INFO - 'MOZ_NO_REMOTE': '1', 11:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:29 INFO - 'NO_EM_RESTART': '1', 11:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:29 INFO - 'PWD': '/builds/slave/test', 11:14:29 INFO - 'SHELL': '/bin/bash', 11:14:29 INFO - 'SHLVL': '1', 11:14:29 INFO - 'TERM': 'linux', 11:14:29 INFO - 'TMOUT': '86400', 11:14:29 INFO - 'USER': 'cltbld', 11:14:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:29 INFO - '_': '/tools/buildbot/bin/python'} 11:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:29 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:29 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 11:14:29 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 11:14:29 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 11:14:29 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 11:14:29 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 11:14:29 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 11:14:31 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:32 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 11:14:32 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 11:14:32 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 11:14:32 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 11:14:32 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 11:14:32 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 11:14:32 INFO - Downloading docopt-0.6.1.tar.gz 11:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:32 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:32 INFO - Running setup.py install for blobuploader 11:14:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:32 INFO - Running setup.py install for requests 11:14:32 INFO - Running setup.py install for docopt 11:14:32 INFO - Successfully installed blobuploader requests docopt 11:14:32 INFO - Cleaning up... 11:14:32 INFO - Return code: 0 11:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:33 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:33 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 11:14:33 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 11:14:33 INFO - Using env: {'DISPLAY': ':0', 11:14:33 INFO - 'HOME': '/home/cltbld', 11:14:33 INFO - 'LANG': 'en_US.UTF-8', 11:14:33 INFO - 'LANGUAGE': 'en_US:en', 11:14:33 INFO - 'LOGNAME': 'cltbld', 11:14:33 INFO - 'MAIL': '/var/mail/cltbld', 11:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:33 INFO - 'MOZ_NO_REMOTE': '1', 11:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:33 INFO - 'NO_EM_RESTART': '1', 11:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:33 INFO - 'PWD': '/builds/slave/test', 11:14:33 INFO - 'SHELL': '/bin/bash', 11:14:33 INFO - 'SHLVL': '1', 11:14:33 INFO - 'TERM': 'linux', 11:14:33 INFO - 'TMOUT': '86400', 11:14:33 INFO - 'USER': 'cltbld', 11:14:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:33 INFO - '_': '/tools/buildbot/bin/python'} 11:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:33 INFO - Running setup.py (path:/tmp/pip-jGEl1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:33 INFO - Running setup.py (path:/tmp/pip-qwY86c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:33 INFO - Running setup.py (path:/tmp/pip-0QOkUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:33 INFO - Running setup.py (path:/tmp/pip-2LEysf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:33 INFO - Running setup.py (path:/tmp/pip-FeaTFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:33 INFO - Running setup.py (path:/tmp/pip-77fh5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:33 INFO - Running setup.py (path:/tmp/pip-FkJtfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:33 INFO - Running setup.py (path:/tmp/pip-lKuMEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:33 INFO - Running setup.py (path:/tmp/pip-81T22R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:33 INFO - Running setup.py (path:/tmp/pip-OI36Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:33 INFO - Running setup.py (path:/tmp/pip-wrvF2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:33 INFO - Running setup.py (path:/tmp/pip-oI45PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:34 INFO - Running setup.py (path:/tmp/pip-bXqpUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:34 INFO - Running setup.py (path:/tmp/pip-FFq4vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:34 INFO - Running setup.py (path:/tmp/pip-n1B4ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:34 INFO - Running setup.py (path:/tmp/pip-IPhtPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:34 INFO - Running setup.py (path:/tmp/pip-Pbqj6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:34 INFO - Running setup.py install for manifestparser 11:14:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:34 INFO - Running setup.py install for mozcrash 11:14:34 INFO - Running setup.py install for mozdebug 11:14:34 INFO - Running setup.py install for mozdevice 11:14:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:34 INFO - Running setup.py install for mozfile 11:14:34 INFO - Running setup.py install for mozhttpd 11:14:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for mozinfo 11:14:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for mozInstall 11:14:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for mozleak 11:14:35 INFO - Running setup.py install for mozlog 11:14:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for moznetwork 11:14:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for mozprocess 11:14:35 INFO - Running setup.py install for mozprofile 11:14:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for mozrunner 11:14:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:35 INFO - Running setup.py install for mozscreenshot 11:14:35 INFO - Running setup.py install for moztest 11:14:36 INFO - Running setup.py install for mozversion 11:14:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:36 INFO - Cleaning up... 11:14:36 INFO - Return code: 0 11:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:36 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')]} 11:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:36 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')]} 11:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:36 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:36 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 11:14:36 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 11:14:36 INFO - Using env: {'DISPLAY': ':0', 11:14:36 INFO - 'HOME': '/home/cltbld', 11:14:36 INFO - 'LANG': 'en_US.UTF-8', 11:14:36 INFO - 'LANGUAGE': 'en_US:en', 11:14:36 INFO - 'LOGNAME': 'cltbld', 11:14:36 INFO - 'MAIL': '/var/mail/cltbld', 11:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:36 INFO - 'MOZ_NO_REMOTE': '1', 11:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:36 INFO - 'NO_EM_RESTART': '1', 11:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:36 INFO - 'PWD': '/builds/slave/test', 11:14:36 INFO - 'SHELL': '/bin/bash', 11:14:36 INFO - 'SHLVL': '1', 11:14:36 INFO - 'TERM': 'linux', 11:14:36 INFO - 'TMOUT': '86400', 11:14:36 INFO - 'USER': 'cltbld', 11:14:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:36 INFO - '_': '/tools/buildbot/bin/python'} 11:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:36 INFO - Running setup.py (path:/tmp/pip-zmzJ7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:36 INFO - Running setup.py (path:/tmp/pip-ZkPoWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:36 INFO - Running setup.py (path:/tmp/pip-6MLaK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:36 INFO - Running setup.py (path:/tmp/pip-Fz2eao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:36 INFO - Running setup.py (path:/tmp/pip-PGNdKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:36 INFO - Running setup.py (path:/tmp/pip-toyaM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:36 INFO - Running setup.py (path:/tmp/pip-54ts1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:36 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)) 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:36 INFO - Running setup.py (path:/tmp/pip-qTSkHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:37 INFO - Running setup.py (path:/tmp/pip-GOR1tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:37 INFO - Running setup.py (path:/tmp/pip-H46YXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:37 INFO - Running setup.py (path:/tmp/pip-JVx7B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:37 INFO - Running setup.py (path:/tmp/pip-vJORUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:37 INFO - Running setup.py (path:/tmp/pip-cB07tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:37 INFO - Running setup.py (path:/tmp/pip-BQzjOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:37 INFO - Running setup.py (path:/tmp/pip-j5e2Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:37 INFO - Running setup.py (path:/tmp/pip-o6vU0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:37 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)) 11:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:37 INFO - Running setup.py (path:/tmp/pip-KHOaF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:37 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)) 11:14:37 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)) 11:14:37 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)) 11:14:37 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)) 11:14:37 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)) 11:14:37 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)) 11:14:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:37 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 11:14:37 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 11:14:37 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 11:14:37 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 11:14:37 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 11:14:37 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 11:14:39 INFO - Downloading blessings-1.6.tar.gz 11:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:39 INFO - Installing collected packages: blessings 11:14:39 INFO - Running setup.py install for blessings 11:14:39 INFO - Successfully installed blessings 11:14:39 INFO - Cleaning up... 11:14:39 INFO - Return code: 0 11:14:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:39 INFO - Reading from file tmpfile_stdout 11:14:39 INFO - Current package versions: 11:14:39 INFO - argparse == 1.2.1 11:14:39 INFO - blessings == 1.6 11:14:39 INFO - blobuploader == 1.2.4 11:14:39 INFO - docopt == 0.6.1 11:14:39 INFO - manifestparser == 1.1 11:14:39 INFO - mozInstall == 1.12 11:14:39 INFO - mozcrash == 0.17 11:14:39 INFO - mozdebug == 0.1 11:14:39 INFO - mozdevice == 0.48 11:14:39 INFO - mozfile == 1.2 11:14:39 INFO - mozhttpd == 0.7 11:14:39 INFO - mozinfo == 0.9 11:14:39 INFO - mozleak == 0.1 11:14:39 INFO - mozlog == 3.2 11:14:39 INFO - moznetwork == 0.27 11:14:39 INFO - mozprocess == 0.22 11:14:39 INFO - mozprofile == 0.28 11:14:39 INFO - mozrunner == 6.11 11:14:39 INFO - mozscreenshot == 0.1 11:14:39 INFO - mozsystemmonitor == 0.3 11:14:39 INFO - moztest == 0.7 11:14:39 INFO - mozversion == 1.4 11:14:39 INFO - psutil == 3.1.1 11:14:39 INFO - requests == 1.2.3 11:14:39 INFO - wsgiref == 0.1.2 11:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:39 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:39 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 11:14:39 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 11:14:39 INFO - Using env: {'DISPLAY': ':0', 11:14:39 INFO - 'HOME': '/home/cltbld', 11:14:39 INFO - 'LANG': 'en_US.UTF-8', 11:14:39 INFO - 'LANGUAGE': 'en_US:en', 11:14:39 INFO - 'LOGNAME': 'cltbld', 11:14:39 INFO - 'MAIL': '/var/mail/cltbld', 11:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:39 INFO - 'MOZ_NO_REMOTE': '1', 11:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:39 INFO - 'NO_EM_RESTART': '1', 11:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:40 INFO - 'PWD': '/builds/slave/test', 11:14:40 INFO - 'SHELL': '/bin/bash', 11:14:40 INFO - 'SHLVL': '1', 11:14:40 INFO - 'TERM': 'linux', 11:14:40 INFO - 'TMOUT': '86400', 11:14:40 INFO - 'USER': 'cltbld', 11:14:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:40 INFO - '_': '/tools/buildbot/bin/python'} 11:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 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)) 11:14:40 INFO - Cleaning up... 11:14:40 INFO - Return code: 0 11:14:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:40 INFO - Using env: {'DISPLAY': ':0', 11:14:40 INFO - 'HOME': '/home/cltbld', 11:14:40 INFO - 'LANG': 'en_US.UTF-8', 11:14:40 INFO - 'LANGUAGE': 'en_US:en', 11:14:40 INFO - 'LOGNAME': 'cltbld', 11:14:40 INFO - 'MAIL': '/var/mail/cltbld', 11:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:40 INFO - 'MOZ_NO_REMOTE': '1', 11:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:40 INFO - 'NO_EM_RESTART': '1', 11:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:40 INFO - 'PWD': '/builds/slave/test', 11:14:40 INFO - 'SHELL': '/bin/bash', 11:14:40 INFO - 'SHLVL': '1', 11:14:40 INFO - 'TERM': 'linux', 11:14:40 INFO - 'TMOUT': '86400', 11:14:40 INFO - 'USER': 'cltbld', 11:14:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:40 INFO - '_': '/tools/buildbot/bin/python'} 11:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:40 INFO - Downloading/unpacking jsonschema 11:14:40 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 11:14:40 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 11:14:40 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 11:14:40 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 11:14:40 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 11:14:40 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 11:14:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:42 INFO - Downloading/unpacking functools32 (from jsonschema) 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:42 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:42 INFO - warning: no files found matching '*.txt' 11:14:42 INFO - no previously-included directories found matching 'build' 11:14:42 INFO - no previously-included directories found matching 'dist' 11:14:42 INFO - no previously-included directories found matching '.git*' 11:14:42 INFO - Installing collected packages: jsonschema, functools32 11:14:42 INFO - Running setup.py install for functools32 11:14:42 INFO - warning: no files found matching '*.txt' 11:14:42 INFO - no previously-included directories found matching 'build' 11:14:42 INFO - no previously-included directories found matching 'dist' 11:14:42 INFO - no previously-included directories found matching '.git*' 11:14:42 INFO - Successfully installed jsonschema functools32 11:14:42 INFO - Cleaning up... 11:14:42 INFO - Return code: 0 11:14:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:14:42 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')]} 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 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')]} 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 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 0x7fe93027df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, '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': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', '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 11:14:42 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 11:14:42 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 11:14:42 INFO - Using env: {'DISPLAY': ':0', 11:14:42 INFO - 'HOME': '/home/cltbld', 11:14:42 INFO - 'LANG': 'en_US.UTF-8', 11:14:42 INFO - 'LANGUAGE': 'en_US:en', 11:14:42 INFO - 'LOGNAME': 'cltbld', 11:14:42 INFO - 'MAIL': '/var/mail/cltbld', 11:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:42 INFO - 'MOZ_NO_REMOTE': '1', 11:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:42 INFO - 'NO_EM_RESTART': '1', 11:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:42 INFO - 'PWD': '/builds/slave/test', 11:14:42 INFO - 'SHELL': '/bin/bash', 11:14:42 INFO - 'SHLVL': '1', 11:14:42 INFO - 'TERM': 'linux', 11:14:42 INFO - 'TMOUT': '86400', 11:14:42 INFO - 'USER': 'cltbld', 11:14:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:42 INFO - '_': '/tools/buildbot/bin/python'} 11:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:43 INFO - Downloading/unpacking flake8 11:14:43 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 11:14:43 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 11:14:43 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 11:14:43 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 11:14:43 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 11:14:43 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 11:14:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:14:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:14:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:45 INFO - no previously-included directories found matching 'docs/_build' 11:14:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:14:45 INFO - Running setup.py install for pep8 11:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:45 INFO - no previously-included directories found matching 'docs/_build' 11:14:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:14:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:14:45 INFO - Cleaning up... 11:14:45 INFO - Return code: 0 11:14:45 INFO - Running post-action listener: _resource_record_post_action 11:14:45 INFO - Running post-action listener: _start_resource_monitoring 11:14:45 INFO - Starting resource monitoring. 11:14:45 INFO - ##### 11:14:45 INFO - ##### Finished create-virtualenv step (success) 11:14:45 INFO - ##### 11:14:45 INFO - ##### 11:14:45 INFO - ##### Running install step. 11:14:45 INFO - ##### 11:14:45 INFO - Running pre-action listener: _resource_record_pre_action 11:14:45 INFO - Running main action method: install 11:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:46 INFO - Reading from file tmpfile_stdout 11:14:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:46 INFO - Reading from file tmpfile_stdout 11:14:46 INFO - Output received: 11:14:46 INFO - Usage: mozinstall [options] installer 11:14:46 INFO - Options: 11:14:46 INFO - -h, --help show this help message and exit 11:14:46 INFO - -d DEST, --destination=DEST 11:14:46 INFO - Directory to install application into. [default: 11:14:46 INFO - "/builds/slave/test"] 11:14:46 INFO - --app=APP Application being installed. [default: firefox] 11:14:46 INFO - mkdir: /builds/slave/test/build/application 11:14:46 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'] 11:14:46 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 11:15:02 INFO - Reading from file tmpfile_stdout 11:15:02 INFO - Output received: 11:15:02 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:02 INFO - Running post-action listener: _resource_record_post_action 11:15:02 INFO - ##### 11:15:02 INFO - ##### Finished install step (success) 11:15:02 INFO - ##### 11:15:02 INFO - ##### 11:15:02 INFO - ##### Running run-tests step. 11:15:02 INFO - ##### 11:15:02 INFO - Running pre-action listener: _resource_record_pre_action 11:15:02 INFO - Running main action method: run_tests 11:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:02 INFO - Python 2.7.3 11:15:02 INFO - Return code: 0 11:15:02 INFO - grabbing minidump binary from tooltool 11:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:02 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 0xe769c0>, '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 0xe778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe77d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:02 INFO - Return code: 0 11:15:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:15:03 INFO - Return code: 0 11:15:03 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:15:03 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:15:03 INFO - Using env: {'DISPLAY': ':0', 11:15:03 INFO - 'HOME': '/home/cltbld', 11:15:03 INFO - 'LANG': 'en_US.UTF-8', 11:15:03 INFO - 'LANGUAGE': 'en_US:en', 11:15:03 INFO - 'LOGNAME': 'cltbld', 11:15:03 INFO - 'MAIL': '/var/mail/cltbld', 11:15:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:03 INFO - 'MOZ_NO_REMOTE': '1', 11:15:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:03 INFO - 'NO_EM_RESTART': '1', 11:15:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:03 INFO - 'PWD': '/builds/slave/test', 11:15:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:03 INFO - 'SHELL': '/bin/bash', 11:15:03 INFO - 'SHLVL': '1', 11:15:03 INFO - 'TERM': 'linux', 11:15:03 INFO - 'TMOUT': '86400', 11:15:03 INFO - 'USER': 'cltbld', 11:15:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235', 11:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:03 INFO - '_': '/tools/buildbot/bin/python'} 11:15:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:15:04 INFO - mozversion application_buildid: 20160527083030 11:15:04 INFO - mozversion application_changeset: dd3e899cfa818fcbb47b3d7432e0977e835702ee 11:15:04 INFO - mozversion application_display_name: Nightly 11:15:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:04 INFO - mozversion application_name: Firefox 11:15:04 INFO - mozversion application_remotingname: firefox 11:15:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:15:04 INFO - mozversion application_vendor: Mozilla 11:15:04 INFO - mozversion application_version: 49.0a1 11:15:04 INFO - mozversion platform_buildid: 20160527083030 11:15:04 INFO - mozversion platform_changeset: dd3e899cfa818fcbb47b3d7432e0977e835702ee 11:15:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:15:04 INFO - mozversion platform_version: 49.0a1 11:15:04 INFO - using testdate: 1464372904 11:15:04 INFO - actual date: 1464372904 11:15:04 INFO - starting webserver on 'localhost:34021' 11:15:04 INFO - SUITE-START | Running 2 tests 11:15:04 INFO - TEST-START | dromaeo_css 11:15:04 INFO - operating with platform_type : linux_ 11:15:04 INFO - Initialising browser for dromaeo_css test... 11:15:04 INFO - TEST-INFO | started process 9221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BiVop/profile http://localhost:34021/getInfo.html) 11:15:07 INFO - PROCESS | 9221 | 11:15:07 INFO - PROCESS | 9221 | (process:9288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:15:08 INFO - PROCESS | 9221 | __metrics Screen width/height:1600/1200 11:15:08 INFO - PROCESS | 9221 | colorDepth:24 11:15:08 INFO - PROCESS | 9221 | Browser inner width/height: 1024/697 11:15:08 INFO - PROCESS | 9221 | __metrics 11:15:09 ERROR - PROCESS | 9221 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:15:09 INFO - TEST-INFO | 9221: exit 0 11:15:09 INFO - Browser initialized. 11:15:09 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:09 INFO - TEST-INFO | started process 9339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BiVop/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:11 INFO - PROCESS | 9339 | 11:15:11 INFO - PROCESS | 9339 | (process:9398): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:15:21 INFO - PROCESS | 9339 | RSS: Main: 166281216 11:15:21 INFO - PROCESS | 9339 | 11:16:11 INFO - PROCESS | 9339 | 1464372971210 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] 11:18:18 INFO - PROCESS | 9339 | Cycle 1(1): loaded http://localhost:34021/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34021/tests/dromaeo/cssquery-ext.html) 11:18:19 INFO - PROCESS | 9339 | RSS: Main: 170659840 11:18:19 INFO - PROCESS | 9339 | 11:21:21 INFO - PROCESS | 9339 | Cycle 1(1): loaded http://localhost:34021/tests/dromaeo/cssquery-ext.html (next: http://localhost:34021/tests/dromaeo/cssquery-jquery.html) 11:21:22 INFO - PROCESS | 9339 | RSS: Main: 169066496 11:21:22 INFO - PROCESS | 9339 | 11:24:24 INFO - PROCESS | 9339 | Cycle 1(1): loaded http://localhost:34021/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34021/tests/dromaeo/cssquery-mootools.html) 11:24:24 INFO - PROCESS | 9339 | RSS: Main: 171077632 11:24:24 INFO - PROCESS | 9339 | 11:27:26 INFO - PROCESS | 9339 | Cycle 1(1): loaded http://localhost:34021/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34021/tests/dromaeo/cssquery-prototype.html) 11:27:27 INFO - PROCESS | 9339 | RSS: Main: 168030208 11:27:27 INFO - PROCESS | 9339 | 11:30:29 INFO - PROCESS | 9339 | Cycle 1(1): loaded http://localhost:34021/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34021/tests/dromaeo/cssquery-yui.html) 11:30:30 INFO - PROCESS | 9339 | RSS: Main: 169934848 11:30:30 INFO - PROCESS | 9339 | 11:33:32 INFO - PROCESS | 9339 | Cycle 1(1): loaded http://localhost:34021/tests/dromaeo/cssquery-yui.html (next: http://localhost:34021/tests/dromaeo/cssquery-dojo.html) 11:33:33 INFO - PROCESS | 9339 | RSS: Main: 171225088 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | __start_tp_report 11:33:33 INFO - PROCESS | 9339 | _x_x_mozilla_page_load 11:33:33 INFO - PROCESS | 9339 | _x_x_mozilla_page_load_details 11:33:33 INFO - PROCESS | 9339 | |i|pagename|runs| 11:33:33 INFO - PROCESS | 9339 | |0;dojo.html;3099.163225928999;3122.6408962969235;3143;3162.588863447753;3169.9683003169976;5342.813001544947;5346.946530534694;5348.304720386349;5370.731463426828;5420.159875219338;5284.471552844713;5355.544778693806;5381.81163659272;5433.049216387127;5449.209864569635;4861.489543597915;4907.631927605426;4975.701457912519;5043.041822053817;5063.392392912837;826.9112966712701;4901.8774530636665;5003.39959204896;5043.899122017558;5070.264811602316;4968.7764050617625;4995.800167993276;4998.450170481244;4999.600031997468;5032.0690672225755;4826.493218212072;5027.899442011139;5028.145215313405;5059.544640982293;5099.209622508517;4848.393950756155;4850.660453768238;4864.8297309594345;4872.585830204437;4910.386201724785;5287.4976877196605;5329.546988505982;5335.359756829166;5350.117230656937;5405.8107966221;5645.68948707825;5663.490285874291;5808.680522571257;5824.0390335595;5838.7080645967535;5650.491455768959;5698;5726.026575482178;5746.913796293059;5794.188813566062;5315.441878602768;5337.066013447631;5339.919901201446;5341.866453338659;5343.652662576959;5668.291463567054;5895.086261629454;5955.731992060368;5996.16053752475;5997.220361352996;5738.053221218535;5769.624974376652;5772.220750198753;5773.6824474654295;5775.6823374714795;5863.736131874076;5864.38423965486;5866.090755932837;5866.73599688015;5873.383294754075;5612.719364031782;5645.645045189125;5661.094224923992;5720.342160651495;5767.625104368202;5610.747516361774;5726.942730572641;5746.88506229873;5794.333651630032;5852.882942341129;4435.600795928382;4451.777411129496;4458.866234012985;4463.308187230984;4492.707973981681;3880.650741433228;3884.8251828667776;3887.8833634990997;3899.7855117968784;3932.8230229639735;5509.614326997072;5516.9448305516435;5524.364698059774;5536.474034966753;5537.224788529609;5737.225474560881;5846.649201047951;5847.06446968483;5865.149553314745;5914.290285165722;5241.554467870197;5458.153986132076;5555.555555555627;5563.972180139154;5570.08093664549;5020.47285035066;5025.170846810309;5034.572061374824;5040.697558146523;5050.9494905051215;5739.053056245756;6045.818625441156;6047.879042419215;6065.090236464565;6082.148499210026;5790.826275211666;5810.41895810424;5868.2664666916635;5940.287165540163;5941.346451890202;6112.113743507255;6119.082137679384;6119.35746746603;6124.203853499195;6130.049842274455;5592.776288948559;5670.858228544319;5768.278965129359;5815.098659707752;5824.912626310694;5839.240898683314;5849;5853.122031695109;5858.970705146447;5920.171176035273;5708.942910570841;5734.168545560954;5743.081107023024;5761.078227483583;5775.9133612996675;5456.372517160577;5552.056150454352;5567.916481252865;5685.545156387562;5767.221425107557;5413.485718856702;5417.052015897281;5453.182022696627;5460.945390546044;5589.217509548585;5640.238567793295;5653.378128405954;5670.234518339971;5692.288463942007;5692.6299790513485;5436.809711660231;5542.418046105101;5563.388027316911;5615.887682246251;5647 11:33:33 INFO - PROCESS | 9339 | |1;ext.html;587.0665641629807;632.6457183976974;636.866258085802;653.3107571512054;653.5359894474923;42635.573644263546;43978.78010609947;44045.33931991015;44210;48189.51810481894;46073;46758.766206169006;46941.29588056182;46950;46956.76521617395;8720.171583699539;8909.331800115016;8918.197362237397;8922.241609463203;8927.642894284254;8830.514321712304;8843.336749743763;8898.110188981114;8915.598798054103;8932.55337233139;8835.558222088903;8942.463452192856;8966.372353935227;8969.686060987866;9003.729888103335;8894.688685895995;8894.822103557924;8927.419717718392;8927.687530936419;8960;8748.21266086049;8830.911690883073;8836.116388361177;8866.202041816203;8871.689490867853;42162.57837421617;42272;42424.575754242374;42529.14941701149;42694;3582.0507565495163;3646.197836475971;3731.421629647409;3752.8498860045565;4176.979115104405;32923.3415331692;33290;33643.66356336454;33771.66228337734;34782.65217347819;4117.773522456264;4199.349100889367;4220.9155816883795;4321.178975994551;4353.499347575038;348184.2590787055;348841;348842;348880;350661;53282.46717532853;56789.148162777594;58109.12836307459;58162.418375816545;59005;62720.372796272364;62933.37066629275;62967;63283.6835815818;63471;14780.408783648749;14938;15007.699846003019;15020.924895375454;15039.323230454656;11426.428678566039;11509.769804604028;11621.2446190999;11623.12826537996;11692.94153529227;17604.119794010247;17658.823411765974;17675.381361652282;17687.20407581662;17857.374991875222;6562.5406221564035;6567.704453299613;6622.9006564901565;6628.436582890412;6758.594484330956;1058.317385286486;1145.4272863568217;1158.0908986445768;1169.7485040716288;1223.9816402753966;32038;32366;32392.838035810142;32431.675683242865;32968.175795604824;1157.9131565132648;1167.7839599674087;1193.988060119405;1221.9633410997685;1227.245244174826;16458.341666333214;16732.916335418246;16750.151866715823;16777.91611041937;16883.831161688227;517972;518685;521241;523158;527816;56199;56266;56414;56659.15011274834;57083;1382.4608402722947;1401.1873113594295;1402.719456108762;1417.1143035602747;1427.7929700193413;30548.389032219675;32203.838980805882;32339.676603233667;32589.837050815542;32916.34167316592;49752.75123624359;49869;50362.74818625883;50382.74808625934;50443.747781260856;437072;437894;438145;439075;439190;40236.79881600691;42226.155476890905;42478.15043699047;42827;42902.78548607237;47792.7610361946;48184.75907620439;48319.75840120777;49321;49806.25290620716;40554.39168412417;41202.587974121074;41238.1752364945;41974.79012604917;42003.78998105112;40543.78368648945;40836.59163408447;40930.59069409268;40984.59015409808;41066.58933410628;40677.389839151845;41045.58954410418;41931.37102943519;42008;42194.36708449437;34513.65486345205;36022.819885900404;36402.817985909904;36450;36570.634293657786;27600.343979361303;27787.722122778512;28381.716182838732;28507;28599.714002859706 11:33:33 INFO - PROCESS | 9339 | |2;jquery.html;397.33049811068344;402.41247778243763;403.89094944365024;409.1265148907082;420.41922371881714;16266.99999999997;18416.723749143774;19144.90427547864;20116.69824952625;20132.59734805305;18281.451556453296;18804.71792923104;19480.902595487038;19531.90234048828;19616.117274722637;5636.408177141403;5705.4294570542825;5969.5821292509545;5974.8506287342725;5977.282726072877;5847.502962248214;5847.766089356421;5865.824025279248;5871.2073870027425;5896.086106653454;5778.219940308047;5845.269341332333;5879.911801322984;5895.823125306226;5927.347991720907;5807.709614519278;5808;5811.360750317462;5871.089981052944;5914.2902851657645;5594.021046316879;5661.886762264773;5700.40145784695;5719.084946408555;5748.626339287933;13864.376103075387;18623.255069797193;22765.20321788746;23591.646125308132;23727.525449491088;2340.6137987232087;2401.4236583220077;2411.1922505960524;2445.2053082748;2476.05909754294;9982.251331150193;10305.12406445453;10529.947350263199;10731.302465339806;13928.30358482082;1932.5555122321805;1957.7748558915623;1999.990000050005;2023.9595208095902;2026.9594608107902;80390.59804700997;85533.57233213856;87025;87066;88108.11891881128;11134.832977505344;11160.162987775788;11180.888191117985;11224.102071834397;11341.603043893425;11972.820407693891;12670.429830657642;12722.300273484861;15808.92095539515;16060.678786424207;5992.520598352121;6129.509639228851;6813.829654258683;7626.58053807046;7751.302382785577;7378.335949764547;7405.740799072007;7473.962630186814;7595.354394876387;7669.884951725729;4099.672026237894;4135.421041054255;4186.497620285585;4187.304141822506;4250.128723611652;1887.4715079777684;1965.1255191439673;1965.459498637886;2013.3758534853948;2016.8084032016934;983.326421401328;1029.9073083422527;1057.4871187474068;1059.1950117910444;1088.8588361640354;19059.142338594796;20176.49558761043;20250.189992400432;20302.796972030384;20483.590328193353;1016.5933626549291;1026.7022563456514;1044.5769463367349;1057.3972835483855;1084.2410312781085;11044.723881903017;11389.487473063731;11433.942830285796;11512.251703639404;11559.248648837798;480448;480734;486779;487425;514722;105089;105255.4737226309;105695.47152264189;105877;106210;979.5053497983473;1029.577873072037;1041.5989843909997;1050.7058023753361;1056.4453661827602;17302.74045889338;17788.733169002215;17877.28490860403;17881.73177402314;18143.18355674024;42482;43080.78459607682;43576;43640.781796090814;44147.66536381431;59893.700531498806;60241.69879150576;61033.08450373337;62500;62718;7440.330370266702;7918.089419716806;8708.390412671051;8848.778780530538;9016.459012459274;12891.548795792101;13104.279264640536;13500.864991349961;13847.169169849438;14101.788473173116;11369.204155709353;11853.822192667289;12035.638930832089;12120.27278363301;12184.634460966185;11815.350155741173;11850.111241656738;11878.762424751629;11979.820302695642;12051.57819476314;12401.565945191875;12452.128351015343;12471.93764031174;12746.171498852545;12776;7540.660670269741;8045.637946292314;8150.877736834071;8203.58982050883;8320;11360.715982100182;12068.336241506802;12201;12606.306653134166;12693.301868397326 11:33:33 INFO - PROCESS | 9339 | |3;mootools.html;1508.82648495423;1542.0747551469117;1714.3999600139953;1827.2964908510219;1853.518085297823;7336.596487193202;8654.524001179932;8697.652093916244;9221.815563688722;9222.90777092229;8825.646974121028;8854.91145088549;8889.955550222256;8928.19646231839;8952.194302512773;2194.199117322174;2199.8790066546335;2203.5923354179527;2219.655953327229;2228.576570451609;2249.7975182233595;2271.3299576624936;2288.6567014947723;2305.446692793726;2310.526342099874;2258.3225032490186;2261.434641339665;2265.0713207584895;2282.5206706591553;2296.334063121693;2224.8887555622237;2229.944251393712;2232.0960011195493;2232.4530490029965;2245.034635106895;2199.1533259694975;2201.9449513762124;2230.4646884747544;2232.765559616233;2235.3629215673454;8878.200961913395;9023.27813774903;9049.954750226207;9061.818763624757;9100.317476189246;5233.110371236899;5340.91988620171;5354.651947623392;5357.062514060063;5371.2811900191955;3217.3404452087498;3321.7674762766615;3482.7387945904156;3483.2336885885065;3494.598121216042;1119.3843386137592;1122.6295322543622;1153.411760002405;1189.9345535995603;1211.9757604847941;12304.07719421038;12325.260484370876;12383.133180677356;12393.132480726354;12411.317377544232;4549.840755573539;4610;4693.06138772247;4708.317293992421;4751.334813126096;10329.173666106693;10395.428251446243;10408.635697750693;10419.739506512398;10439;5270.051390749702;5317.973410132925;5318.734063296897;5353.250544923714;5364.7317634118135;4127.195196936568;4805.3512775775525;4865.683730557503;4885.389326334208;4975;3991.820368083443;4011.5186177658866;4055.0673345130785;4121.113960498507;4147.730397524151;1257.8805013523884;1280.9359532023361;1293.8706129386985;1311.4033114932683;1323.7683405404016;893.2809088683672;941.3833938770116;1012.2538620878925;1020.0480198044346;1041.5885725138528;6026.306974697965;6138.355472675305;6175.536834737412;6205.2553693557065;6227.719752611143;435.37741030326936;447.7492604141691;448.27155871708476;455.6673628251329;460.2360082263427;4094.303968325392;4200.264953633163;4208.915821683549;4217.219814334297;4243.130158317599;11027.889721102847;11344.829827552594;11346.659600212008;11352.091832653368;11383.943080284545;10811.243212975174;11227.775444491064;11252.831207531894;11280.379579123228;11294.54821807135;8382.538960357117;8436.999999999878;8514.57427128641;8522.147785221428;8595.957020214859;6061.424164704346;6307.653079080695;6352.745890164527;6366.808995730135;6410.647414392253;10377.648142462556;10485.9475702621;10602.946985265024;10651.30766500175;10710.464476775975;10636.734081648021;10667.679969600924;10811.891881081403;10824.621138260123;10825.945870270598;6760.08738820253;7699.538027718355;7959.761207163794;8059.3552515799765;8197.262246397853;8802.647894084164;8815.823683526422;8830.470171789713;8861.025287218272;8874.866876996979;7735.922640773745;7737.729179478692;7910.485818421784;7964.2433968772875;8134.267915887599;7687.730929417444;7759.107702614272;7787.29914307715;7876.133625301327;7926.524408535506;7074.646267686698;7233.31283528064;7255.818604534928;7287.672054757655;7328;5188.273641690242;5213.947860521346;5228.398734145622;5293.232481290268;5366.7584958677735;5185.481451854785;5200.583953283653;5340.572754179734;5395.86510337229;5412.8105516308315 11:33:33 INFO - PROCESS | 9339 | |4;prototype.html;331.5746871982915;339.9337129259795;343.25171126943263;349.8373256435755;351.86453215512023;5445;5512.283403157584;5605.495505404513;5695.430456954303;5706.5720070994685;5526.50261476467;5543.916841247385;5567.777288908449;5573.777048918048;5610.438956104398;4333.934990975138;4334.046509767846;4363.258246098171;4384.780760961955;4418.182636212295;4103.537877273642;4331.675124365669;4345.8478953236645;4403.955960440403;4413.713108647944;4271.423357846697;4273.145370925812;4277.700560960734;4295.355696645497;4296.162248361571;4296.462942132249;4303.139372125572;4319.3952846601505;4337.937205384669;4348.608625223714;3699.426588878728;3781.789827255252;3792.848286068554;3793.1844653399376;3797.563280222782;5421.186821976696;5458.727063646841;5464;5467.480589344006;5477.4796394342875;4946.233333833262;4970.552650261494;4991.604030065589;5010;5010.448850626428;5656.660600363992;5847.766089356421;5862.267216597926;5896;5935.673537955411;4116.217918595487;4171.707980441371;4191.685623578243;4201.6008479194425;4208.516020657633;5849.649021058707;6143.539234557426;6166.81499555014;6197.969010154966;6212.347703491114;4160.875173744793;4169.770662613525;4172.582741725864;4177.874663760092;4205.11692544563;4209.957900421018;4228.667969589569;4243;4245.3844192591905;4257.382679511516;4878.317035615017;4909.803607855717;4911.631627627942;4938.925916111261;4954.0183926429;5644.943550564524;5650.208970744099;5873.20711703923;5900.586958912921;5953.523718102541;1474.8893832962572;1480.6446452851237;1498.48302335694;1502.646877983673;1505.811773528309;918.8070505193984;948.1608776232946;952.8094381123803;954.8567714842691;956.4070276428658;4962.578180854595;5056.191009438472;5072.184937359727;5082.618803589746;5120.92318615221;5295.920561191585;5316.73416329182;5320.813771517978;5323.627346085815;5357.892842143136;5048.712578292512;5128.538431541105;5163.793448262028;5384.653836540865;5843.152742852348;3218.4850423932057;3228.7085165933813;3236.174775432297;3271.5092736089778;3283.4582293921235;6105.8168254952425;6339.397757213057;6340.256429481838;6360.363963603695;6403.679816009181;6102.359252278447;6153.969230153821;6168.506519478431;6215.782447614311;6230.844228894223;6296.464800492009;6327.778527751507;6330.493560515148;6350.33321501245;6373.267074286424;5856.560757943256;6084.361142080018;6091.451769340781;6104.375118699002;6166.475849552839;6027.819165425044;6066.757329706762;6067.726952287069;6091.177691011657;6118.816435506764;6093.939060609515;6347.650879201688;6362.300146983921;6405.3594640535575;6416.262129855127;4256.553061928576;4259.808308626181;4267.50923643785;4305.97847010763;4307.870763877088;5872.677002764889;5978.222831031938;6130.785422510191;6171.907421388593;6196.3803619639475;5908.5568582357355;5918.644881307136;5960.314563825215;5977.282726072725;6009.939900600938;5930.902782985161;5952.76771210796;5971.283066204953;5971.611355457678;5980.700964951822;5659.858503537444;5790.478856902899;5816.73824677882;5830.183774271521;5844.574501581966;6023.789167379121;6048.485878700184;6061.6666083365835;6068.939310606837;6090.482309003607;5661.423324787009;5816.94183058164;5866.560007999332;5868.4424979626865;5896.410358964069 11:33:33 INFO - PROCESS | 9339 | |5;yui.html;635.177445208455;686.4679873098352;706.5372181221295;743.108270075909;793.5119901260724;14832.406703731851;15476.148811815345;15774.369025238977;15849.04905705657;15998.040117592938;14742.926285368585;14833.442488538683;14853.851461485381;14856.18290993995;14874.776878346833;676.1210426445625;799.1010113622175;800.9879851802227;821.0188824354898;821.322409012564;793.3692714292123;794.7099308752322;794.7218473534275;795.3716563914501;796.366888323784;863.3395452478859;863.8099618084011;865.35098675993;865.4504389712546;865.5628907401754;852.0967774159349;853.2320911179957;853.7182729699184;854.8760429737684;855.0508935082054;615.8983767678328;618.483566222205;619.8109576579142;621.1645337021698;622.4771192198575;14947.850521494755;14998.325075371635;15009.099454032794;15017.399304027826;15054.849451505454;14245.430182792676;14293.070950388192;14369.56891293263;14506.911981601317;14722.779158312635;11528.250663706833;11583.6524904253;11644.592439264585;11666.766664666658;11789.528418863236;3773.1541225754036;3833.7124715646437;3850.5956874528333;3853.3064048471265;3976.602339766029;52229;63576;65902.67048664726;65933.34066659368;66410;10202;10726.141908647289;10776.838347424795;10816.296940698829;11010.559577616967;19657.606847862964;19760.505987350145;19782.208711651372;19838.504037398892;19882.90058549698;8586.828263434696;8741.868871966926;8746.300295976307;8762.474251544927;8819.382643215042;4678.555537223959;4723.0789995951145;4727.456342520654;4764.38063051808;4820.758962051884;3382.2728113455723;3417.4532074867902;3447.5345828312857;3465.341585098823;3481.6518348165487;590.4715279824533;593.4006653280218;604.6523249131767;637.6939069246695;638.9552731308856;678.5555461172939;716.2228981554968;756.1568850731395;762.5539059650167;784.9921500784919;8729.694460693845;9178.586963586655;9264.7683807904;9318.580663870142;9372.953135234417;660.3363619562309;691.2534462780185;712.8253577873351;753.3596443023387;782.1201148707704;4507.18870603288;4773;4969.0987594683065;4983.9252411213865;5022.917497010732;70239;71113;72239.63880180566;72384;72668.63665681638;63926;64122.679386603704;65431.67284163644;65584.67207663931;65897;57623.71188144032;57881.710591446776;57918.420815792146;58092;58725.41274587285;9365;9391.812163756824;9396.15434610861;9462.952685236529;9473.24214062887;37227.813860930524;37506;37532.624673754006;37698.81150594339;38388.232235354575;45275;51096.74451627867;51415;51665.48334516607;52113.218301724744;11903.702407439883;11985.520579177084;12109.515619375126;12141.757164856477;12460.87539124597;12592.559260425842;12877.291748953523;12916.09587328878;13005.349732513147;13295.335233238493;12237.755244894874;12484.650223970055;12524.624261271812;12755.681107972005;12777.872221277668;12213.36238918344;12308.138430309793;12504.124711270124;12527.436265368262;12594;11440.313581185155;11535;11667.299962002307;11713.707157321136;12086.576969806014;10379.636712715019;10562.366258024544;10892.564297428014;10998.615048473264;11006.119510438986;10517.263791534826;10877.836832447678;10970.396628185526;11015;11047.502862371051 11:33:33 INFO - PROCESS | 9339 | __end_tp_report 11:33:33 INFO - PROCESS | 9339 | __start_cc_report 11:33:33 INFO - PROCESS | 9339 | _x_x_mozilla_cycle_collect,344 11:33:33 INFO - PROCESS | 9339 | __end_cc_report 11:33:33 INFO - PROCESS | 9339 | __startTimestamp1464374013094__endTimestamp 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | ------- Summary: start ------- 11:33:33 INFO - PROCESS | 9339 | Number of tests: 6 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | [#0] dojo.html Cycles:165 Average:5360.38 Median:5567.92 stddev:709.28 (12.7%) stddev-sans-first:688.92 11:33:33 INFO - PROCESS | 9339 | Values: 3099.2 3122.6 3143.0 3162.6 3170.0 5342.8 5346.9 5348.3 5370.7 5420.2 5284.5 5355.5 5381.8 5433.0 5449.2 4861.5 4907.6 4975.7 5043.0 5063.4 826.9 4901.9 5003.4 5043.9 5070.3 4968.8 4995.8 4998.5 4999.6 5032.1 4826.5 5027.9 5028.1 5059.5 5099.2 4848.4 4850.7 4864.8 4872.6 4910.4 5287.5 5329.5 5335.4 5350.1 5405.8 5645.7 5663.5 5808.7 5824.0 5838.7 5650.5 5698.0 5726.0 5746.9 5794.2 5315.4 5337.1 5339.9 5341.9 5343.7 5668.3 5895.1 5955.7 5996.2 5997.2 5738.1 5769.6 5772.2 5773.7 5775.7 5863.7 5864.4 5866.1 5866.7 5873.4 5612.7 5645.6 5661.1 5720.3 5767.6 5610.7 5726.9 5746.9 5794.3 5852.9 4435.6 4451.8 4458.9 4463.3 4492.7 3880.7 3884.8 3887.9 3899.8 3932.8 5509.6 5516.9 5524.4 5536.5 5537.2 5737.2 5846.6 5847.1 5865.1 5914.3 5241.6 5458.2 5555.6 5564.0 5570.1 5020.5 5025.2 5034.6 5040.7 5050.9 5739.1 6045.8 6047.9 6065.1 6082.1 5790.8 5810.4 5868.3 5940.3 5941.3 6112.1 6119.1 6119.4 6124.2 6130.0 5592.8 5670.9 5768.3 5815.1 5824.9 5839.2 5849.0 5853.1 5859.0 5920.2 5708.9 5734.2 5743.1 5761.1 5775.9 5456.4 5552.1 5567.9 5685.5 5767.2 5413.5 5417.1 5453.2 5460.9 5589.2 5640.2 5653.4 5670.2 5692.3 5692.6 5436.8 5542.4 5563.4 5615.9 5647.0 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | [#1] ext.html Cycles:180 Average:60312.03 Median:42249.08 stddev:117013.49 (277.0%) stddev-sans-first:117255.82 11:33:33 INFO - PROCESS | 9339 | Values: 587.1 632.6 636.9 653.3 653.5 42635.6 43978.8 44045.3 44210.0 48189.5 46073.0 46758.8 46941.3 46950.0 46956.8 8720.2 8909.3 8918.2 8922.2 8927.6 8830.5 8843.3 8898.1 8915.6 8932.6 8835.6 8942.5 8966.4 8969.7 9003.7 8894.7 8894.8 8927.4 8927.7 8960.0 8748.2 8830.9 8836.1 8866.2 8871.7 42162.6 42272.0 42424.6 42529.1 42694.0 3582.1 3646.2 3731.4 3752.8 4177.0 32923.3 33290.0 33643.7 33771.7 34782.7 4117.8 4199.3 4220.9 4321.2 4353.5 348184.3 348841.0 348842.0 348880.0 350661.0 53282.5 56789.1 58109.1 58162.4 59005.0 62720.4 62933.4 62967.0 63283.7 63471.0 14780.4 14938.0 15007.7 15020.9 15039.3 11426.4 11509.8 11621.2 11623.1 11692.9 17604.1 17658.8 17675.4 17687.2 17857.4 6562.5 6567.7 6622.9 6628.4 6758.6 1058.3 1145.4 1158.1 1169.7 1224.0 32038.0 32366.0 32392.8 32431.7 32968.2 1157.9 1167.8 1194.0 1222.0 1227.2 16458.3 16732.9 16750.2 16777.9 16883.8 517972.0 518685.0 521241.0 523158.0 527816.0 56199.0 56266.0 56414.0 56659.2 57083.0 1382.5 1401.2 1402.7 1417.1 1427.8 30548.4 32203.8 32339.7 32589.8 32916.3 49752.8 49869.0 50362.7 50382.7 50443.7 437072.0 437894.0 438145.0 439075.0 439190.0 40236.8 42226.2 42478.2 42827.0 42902.8 47792.8 48184.8 48319.8 49321.0 49806.3 40554.4 41202.6 41238.2 41974.8 42003.8 40543.8 40836.6 40930.6 40984.6 41066.6 40677.4 41045.6 41931.4 42008.0 42194.4 34513.7 36022.8 36402.8 36450.0 36570.6 27600.3 27787.7 28381.7 28507.0 28599.7 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | [#2] jquery.html Cycles:180 Average:29607.25 Median:11138.57 stddev:81283.19 (729.7%) stddev-sans-first:81481.62 11:33:33 INFO - PROCESS | 9339 | Values: 397.3 402.4 403.9 409.1 420.4 16267.0 18416.7 19144.9 20116.7 20132.6 18281.5 18804.7 19480.9 19531.9 19616.1 5636.4 5705.4 5969.6 5974.9 5977.3 5847.5 5847.8 5865.8 5871.2 5896.1 5778.2 5845.3 5879.9 5895.8 5927.3 5807.7 5808.0 5811.4 5871.1 5914.3 5594.0 5661.9 5700.4 5719.1 5748.6 13864.4 18623.3 22765.2 23591.6 23727.5 2340.6 2401.4 2411.2 2445.2 2476.1 9982.3 10305.1 10529.9 10731.3 13928.3 1932.6 1957.8 2000.0 2024.0 2027.0 80390.6 85533.6 87025.0 87066.0 88108.1 11134.8 11160.2 11180.9 11224.1 11341.6 11972.8 12670.4 12722.3 15808.9 16060.7 5992.5 6129.5 6813.8 7626.6 7751.3 7378.3 7405.7 7474.0 7595.4 7669.9 4099.7 4135.4 4186.5 4187.3 4250.1 1887.5 1965.1 1965.5 2013.4 2016.8 983.3 1029.9 1057.5 1059.2 1088.9 19059.1 20176.5 20250.2 20302.8 20483.6 1016.6 1026.7 1044.6 1057.4 1084.2 11044.7 11389.5 11433.9 11512.3 11559.2 480448.0 480734.0 486779.0 487425.0 514722.0 105089.0 105255.5 105695.5 105877.0 106210.0 979.5 1029.6 1041.6 1050.7 1056.4 17302.7 17788.7 17877.3 17881.7 18143.2 42482.0 43080.8 43576.0 43640.8 44147.7 59893.7 60241.7 61033.1 62500.0 62718.0 7440.3 7918.1 8708.4 8848.8 9016.5 12891.5 13104.3 13500.9 13847.2 14101.8 11369.2 11853.8 12035.6 12120.3 12184.6 11815.4 11850.1 11878.8 11979.8 12051.6 12401.6 12452.1 12471.9 12746.2 12776.0 7540.7 8045.6 8150.9 8203.6 8320.0 11360.7 12068.3 12201.0 12606.3 12693.3 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | [#3] mootools.html Cycles:180 Average:5905.81 Median:448.01 stddev:3419.96 (763.4%) stddev-sans-first:3413.59 11:33:33 INFO - PROCESS | 9339 | Values: 1508.8 1542.1 1714.4 1827.3 1853.5 7336.6 8654.5 8697.7 9221.8 9222.9 8825.6 8854.9 8890.0 8928.2 8952.2 2194.2 2199.9 2203.6 2219.7 2228.6 2249.8 2271.3 2288.7 2305.4 2310.5 2258.3 2261.4 2265.1 2282.5 2296.3 2224.9 2229.9 2232.1 2232.5 2245.0 2199.2 2201.9 2230.5 2232.8 2235.4 8878.2 9023.3 9050.0 9061.8 9100.3 5233.1 5340.9 5354.7 5357.1 5371.3 3217.3 3321.8 3482.7 3483.2 3494.6 1119.4 1122.6 1153.4 1189.9 1212.0 12304.1 12325.3 12383.1 12393.1 12411.3 4549.8 4610.0 4693.1 4708.3 4751.3 10329.2 10395.4 10408.6 10419.7 10439.0 5270.1 5318.0 5318.7 5353.3 5364.7 4127.2 4805.4 4865.7 4885.4 4975.0 3991.8 4011.5 4055.1 4121.1 4147.7 1257.9 1280.9 1293.9 1311.4 1323.8 893.3 941.4 1012.3 1020.0 1041.6 6026.3 6138.4 6175.5 6205.3 6227.7 435.4 447.7 448.3 455.7 460.2 4094.3 4200.3 4208.9 4217.2 4243.1 11027.9 11344.8 11346.7 11352.1 11383.9 10811.2 11227.8 11252.8 11280.4 11294.5 8382.5 8437.0 8514.6 8522.1 8596.0 6061.4 6307.7 6352.7 6366.8 6410.6 10377.6 10485.9 10602.9 10651.3 10710.5 10636.7 10667.7 10811.9 10824.6 10825.9 6760.1 7699.5 7959.8 8059.4 8197.3 8802.6 8815.8 8830.5 8861.0 8874.9 7735.9 7737.7 7910.5 7964.2 8134.3 7687.7 7759.1 7787.3 7876.1 7926.5 7074.6 7233.3 7255.8 7287.7 7328.0 5188.3 5213.9 5228.4 5293.2 5366.8 5185.5 5200.6 5340.6 5395.9 5412.8 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | [#4] prototype.html Cycles:180 Average:4913.15 Median:5519.39 stddev:1468.94 (26.6%) stddev-sans-first:1432.25 11:33:33 INFO - PROCESS | 9339 | Values: 331.6 339.9 343.3 349.8 351.9 5445.0 5512.3 5605.5 5695.4 5706.6 5526.5 5543.9 5567.8 5573.8 5610.4 4333.9 4334.0 4363.3 4384.8 4418.2 4103.5 4331.7 4345.8 4404.0 4413.7 4271.4 4273.1 4277.7 4295.4 4296.2 4296.5 4303.1 4319.4 4337.9 4348.6 3699.4 3781.8 3792.8 3793.2 3797.6 5421.2 5458.7 5464.0 5467.5 5477.5 4946.2 4970.6 4991.6 5010.0 5010.4 5656.7 5847.8 5862.3 5896.0 5935.7 4116.2 4171.7 4191.7 4201.6 4208.5 5849.6 6143.5 6166.8 6198.0 6212.3 4160.9 4169.8 4172.6 4177.9 4205.1 4210.0 4228.7 4243.0 4245.4 4257.4 4878.3 4909.8 4911.6 4938.9 4954.0 5644.9 5650.2 5873.2 5900.6 5953.5 1474.9 1480.6 1498.5 1502.6 1505.8 918.8 948.2 952.8 954.9 956.4 4962.6 5056.2 5072.2 5082.6 5120.9 5295.9 5316.7 5320.8 5323.6 5357.9 5048.7 5128.5 5163.8 5384.7 5843.2 3218.5 3228.7 3236.2 3271.5 3283.5 6105.8 6339.4 6340.3 6360.4 6403.7 6102.4 6154.0 6168.5 6215.8 6230.8 6296.5 6327.8 6330.5 6350.3 6373.3 5856.6 6084.4 6091.5 6104.4 6166.5 6027.8 6066.8 6067.7 6091.2 6118.8 6093.9 6347.7 6362.3 6405.4 6416.3 4256.6 4259.8 4267.5 4306.0 4307.9 5872.7 5978.2 6130.8 6171.9 6196.4 5908.6 5918.6 5960.3 5977.3 6009.9 5930.9 5952.8 5971.3 5971.6 5980.7 5659.9 5790.5 5816.7 5830.2 5844.6 6023.8 6048.5 6061.7 6068.9 6090.5 5661.4 5816.9 5866.6 5868.4 5896.4 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - PROCESS | 9339 | [#5] yui.html Cycles:180 Average:16162.45 Median:4768.69 stddev:19867.05 (416.6%) stddev-sans-first:19888.56 11:33:33 INFO - PROCESS | 9339 | Values: 635.2 686.5 706.5 743.1 793.5 14832.4 15476.1 15774.4 15849.0 15998.0 14742.9 14833.4 14853.9 14856.2 14874.8 676.1 799.1 801.0 821.0 821.3 793.4 794.7 794.7 795.4 796.4 863.3 863.8 865.4 865.5 865.6 852.1 853.2 853.7 854.9 855.1 615.9 618.5 619.8 621.2 622.5 14947.9 14998.3 15009.1 15017.4 15054.8 14245.4 14293.1 14369.6 14506.9 14722.8 11528.3 11583.7 11644.6 11666.8 11789.5 3773.2 3833.7 3850.6 3853.3 3976.6 52229.0 63576.0 65902.7 65933.3 66410.0 10202.0 10726.1 10776.8 10816.3 11010.6 19657.6 19760.5 19782.2 19838.5 19882.9 8586.8 8741.9 8746.3 8762.5 8819.4 4678.6 4723.1 4727.5 4764.4 4820.8 3382.3 3417.5 3447.5 3465.3 3481.7 590.5 593.4 604.7 637.7 639.0 678.6 716.2 756.2 762.6 785.0 8729.7 9178.6 9264.8 9318.6 9373.0 660.3 691.3 712.8 753.4 782.1 4507.2 4773.0 4969.1 4983.9 5022.9 70239.0 71113.0 72239.6 72384.0 72668.6 63926.0 64122.7 65431.7 65584.7 65897.0 57623.7 57881.7 57918.4 58092.0 58725.4 9365.0 9391.8 9396.2 9463.0 9473.2 37227.8 37506.0 37532.6 37698.8 38388.2 45275.0 51096.7 51415.0 51665.5 52113.2 11903.7 11985.5 12109.5 12141.8 12460.9 12592.6 12877.3 12916.1 13005.3 13295.3 12237.8 12484.7 12524.6 12755.7 12777.9 12213.4 12308.1 12504.1 12527.4 12594.0 11440.3 11535.0 11667.3 11713.7 12086.6 10379.6 10562.4 10892.6 10998.6 11006.1 10517.3 10877.8 10970.4 11015.0 11047.5 11:33:33 INFO - PROCESS | 9339 | -------- Summary: end -------- 11:33:33 INFO - PROCESS | 9339 | 11:33:33 INFO - TEST-INFO | 9339: exit 0 11:33:33 INFO - TEST-OK | dromaeo_css | took 1109714ms 11:33:33 INFO - TEST-START | kraken 11:33:33 INFO - operating with platform_type : linux_ 11:33:33 INFO - Initialising browser for kraken test... 11:33:33 INFO - TEST-INFO | started process 9567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsp1TC/profile http://localhost:34021/getInfo.html) 11:33:37 INFO - PROCESS | 9567 | 11:33:37 INFO - PROCESS | 9567 | (process:9634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:37 INFO - PROCESS | 9567 | __metrics Screen width/height:1600/1200 11:33:37 INFO - PROCESS | 9567 | colorDepth:24 11:33:37 INFO - PROCESS | 9567 | Browser inner width/height: 1024/697 11:33:37 INFO - PROCESS | 9567 | __metrics 11:33:38 ERROR - PROCESS | 9567 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:33:39 INFO - TEST-INFO | 9567: exit 0 11:33:39 INFO - Browser initialized. 11:33:39 INFO - Running cycle 1/1 for kraken test... 11:33:39 INFO - TEST-INFO | started process 9685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsp1TC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:41 INFO - PROCESS | 9685 | 11:33:41 INFO - PROCESS | 9685 | (process:9749): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:51 INFO - PROCESS | 9685 | RSS: Main: 166789120 11:33:51 INFO - PROCESS | 9685 | 11:33:53 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34021/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:54 INFO - PROCESS | 9685 | RSS: Main: 171790336 11:33:54 INFO - PROCESS | 9685 | 11:33:57 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34021/tests/kraken/driver.html?testName=audio-dft) 11:33:57 INFO - PROCESS | 9685 | RSS: Main: 171241472 11:33:57 INFO - PROCESS | 9685 | 11:34:00 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34021/tests/kraken/driver.html?testName=audio-fft) 11:34:01 INFO - PROCESS | 9685 | RSS: Main: 166010880 11:34:01 INFO - PROCESS | 9685 | 11:34:03 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34021/tests/kraken/driver.html?testName=audio-oscillator) 11:34:04 INFO - PROCESS | 9685 | RSS: Main: 167129088 11:34:04 INFO - PROCESS | 9685 | 11:34:06 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34021/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:06 INFO - PROCESS | 9685 | RSS: Main: 167284736 11:34:06 INFO - PROCESS | 9685 | 11:34:09 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34021/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:10 INFO - PROCESS | 9685 | RSS: Main: 166502400 11:34:10 INFO - PROCESS | 9685 | 11:34:13 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34021/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:14 INFO - PROCESS | 9685 | RSS: Main: 168116224 11:34:14 INFO - PROCESS | 9685 | 11:34:17 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34021/tests/kraken/driver.html?testName=json-parse-financial) 11:34:18 INFO - PROCESS | 9685 | RSS: Main: 168181760 11:34:18 INFO - PROCESS | 9685 | 11:34:19 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34021/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:20 INFO - PROCESS | 9685 | RSS: Main: 167878656 11:34:20 INFO - PROCESS | 9685 | 11:34:21 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:22 INFO - PROCESS | 9685 | RSS: Main: 167944192 11:34:22 INFO - PROCESS | 9685 | 11:34:24 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:25 INFO - PROCESS | 9685 | RSS: Main: 168284160 11:34:25 INFO - PROCESS | 9685 | 11:34:27 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:28 INFO - PROCESS | 9685 | RSS: Main: 168566784 11:34:28 INFO - PROCESS | 9685 | 11:34:31 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:31 INFO - PROCESS | 9685 | RSS: Main: 168263680 11:34:31 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | Cycle 1(1): loaded http://localhost:34021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34021/tests/kraken/driver.html?testName=ai-astar) 11:34:33 INFO - PROCESS | 9685 | RSS: Main: 169250816 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | __start_tp_report 11:34:33 INFO - PROCESS | 9685 | _x_x_mozilla_page_load 11:34:33 INFO - PROCESS | 9685 | _x_x_mozilla_page_load_details 11:34:33 INFO - PROCESS | 9685 | |i|pagename|runs| 11:34:33 INFO - PROCESS | 9685 | |0;ai-astar;111;106;111;111;112;111;111;110;112;110 11:34:33 INFO - PROCESS | 9685 | |1;audio-beat-detection;150;130;150;171;127;157;157;128;187;129 11:34:33 INFO - PROCESS | 9685 | |2;audio-dft;166;162;160;163;161;166;166;161;159;160 11:34:33 INFO - PROCESS | 9685 | |3;audio-fft;74;74;75;165;78;75;81;75;163;76 11:34:33 INFO - PROCESS | 9685 | |4;audio-oscillator;83;83;146;83;84;83;143;84;84;152 11:34:33 INFO - PROCESS | 9685 | |5;imaging-gaussian-blur;118;117;117;118;118;118;117;118;117;117 11:34:33 INFO - PROCESS | 9685 | |6;imaging-darkroom;147;147;146;146;147;149;147;147;146;146 11:34:33 INFO - PROCESS | 9685 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 11:34:33 INFO - PROCESS | 9685 | |8;json-parse-financial;53;57;55;57;53;53;52;54;53;55 11:34:33 INFO - PROCESS | 9685 | |9;json-stringify-tinderbox;62;63;62;62;62;62;62;62;61;62 11:34:33 INFO - PROCESS | 9685 | |10;stanford-crypto-aes;81;79;85;80;84;83;80;81;108;80 11:34:33 INFO - PROCESS | 9685 | |11;stanford-crypto-ccm;133;128;131;131;123;127;120;122;128;126 11:34:33 INFO - PROCESS | 9685 | |12;stanford-crypto-pbkdf2;167;160;160;166;164;159;160;159;159;167 11:34:33 INFO - PROCESS | 9685 | |13;stanford-crypto-sha256-iterative;65;62;65;64;63;63;69;63;63;66 11:34:33 INFO - PROCESS | 9685 | __end_tp_report 11:34:33 INFO - PROCESS | 9685 | __start_cc_report 11:34:33 INFO - PROCESS | 9685 | _x_x_mozilla_cycle_collect,878 11:34:33 INFO - PROCESS | 9685 | __end_cc_report 11:34:33 INFO - PROCESS | 9685 | __startTimestamp1464374073848__endTimestamp 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | ------- Summary: start ------- 11:34:33 INFO - PROCESS | 9685 | Number of tests: 14 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 11:34:33 INFO - PROCESS | 9685 | Values: 111.0 106.0 111.0 111.0 112.0 111.0 111.0 110.0 112.0 110.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.50 stddev:20.39 (13.3%) stddev-sans-first:21.62 11:34:33 INFO - PROCESS | 9685 | Values: 150.0 130.0 150.0 171.0 127.0 157.0 157.0 128.0 187.0 129.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:2.72 (1.7%) stddev-sans-first:2.55 11:34:33 INFO - PROCESS | 9685 | Values: 166.0 162.0 160.0 163.0 161.0 166.0 166.0 161.0 159.0 160.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:37.17 (49.6%) stddev-sans-first:38.74 11:34:33 INFO - PROCESS | 9685 | Values: 74.0 74.0 75.0 165.0 78.0 75.0 81.0 75.0 163.0 76.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:83.00 stddev:30.79 (37.1%) stddev-sans-first:31.84 11:34:33 INFO - PROCESS | 9685 | Values: 83.0 83.0 146.0 83.0 84.0 83.0 143.0 84.0 84.0 152.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:34:33 INFO - PROCESS | 9685 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:34:33 INFO - PROCESS | 9685 | Values: 147.0 147.0 146.0 146.0 147.0 149.0 147.0 147.0 146.0 146.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:34:33 INFO - PROCESS | 9685 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.75 (3.2%) stddev-sans-first:1.80 11:34:33 INFO - PROCESS | 9685 | Values: 53.0 57.0 55.0 57.0 53.0 53.0 52.0 54.0 53.0 55.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 11:34:33 INFO - PROCESS | 9685 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.00 stddev:8.62 (10.6%) stddev-sans-first:9.07 11:34:33 INFO - PROCESS | 9685 | Values: 81.0 79.0 85.0 80.0 84.0 83.0 80.0 81.0 108.0 80.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.00 stddev:4.23 (3.3%) stddev-sans-first:3.87 11:34:33 INFO - PROCESS | 9685 | Values: 133.0 128.0 131.0 131.0 123.0 127.0 120.0 122.0 128.0 126.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:3.48 (2.1%) stddev-sans-first:3.21 11:34:33 INFO - PROCESS | 9685 | Values: 167.0 160.0 160.0 166.0 164.0 159.0 160.0 159.0 159.0 167.0 11:34:33 INFO - PROCESS | 9685 | 11:34:33 INFO - PROCESS | 9685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:2.06 (3.2%) stddev-sans-first:2.17 11:34:33 INFO - PROCESS | 9685 | Values: 65.0 62.0 65.0 64.0 63.0 63.0 69.0 63.0 63.0 66.0 11:34:33 INFO - PROCESS | 9685 | -------- Summary: end -------- 11:34:33 INFO - PROCESS | 9685 | 11:34:34 INFO - TEST-INFO | 9685: exit 0 11:34:34 INFO - TEST-OK | kraken | took 60983ms 11:34:34 INFO - SUITE-END | took 1170s 11:34:35 INFO - Completed test suite (00:19:30) 11:34:35 INFO - javascript benchmark 11:34:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7238.048630876382, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.163225928999, 3122.6408962969235, 3143.0, 3162.588863447753, 3169.9683003169976, 5342.813001544947, 5346.946530534694, 5348.304720386349, 5370.731463426828, 5420.159875219338, 5284.471552844713, 5355.544778693806, 5381.81163659272, 5433.049216387127, 5449.209864569635, 4861.489543597915, 4907.631927605426, 4975.701457912519, 5043.041822053817, 5063.392392912837, 826.9112966712701, 4901.8774530636665, 5003.39959204896, 5043.899122017558, 5070.264811602316, 4968.7764050617625, 4995.800167993276, 4998.450170481244, 4999.600031997468, 5032.0690672225755, 4826.493218212072, 5027.899442011139, 5028.145215313405, 5059.544640982293, 5099.209622508517, 4848.393950756155, 4850.660453768238, 4864.8297309594345, 4872.585830204437, 4910.386201724785, 5287.4976877196605, 5329.546988505982, 5335.359756829166, 5350.117230656937, 5405.8107966221, 5645.68948707825, 5663.490285874291, 5808.680522571257, 5824.0390335595, 5838.7080645967535, 5650.491455768959, 5698.0, 5726.026575482178, 5746.913796293059, 5794.188813566062, 5315.441878602768, 5337.066013447631, 5339.919901201446, 5341.866453338659, 5343.652662576959, 5668.291463567054, 5895.086261629454, 5955.731992060368, 5996.16053752475, 5997.220361352996, 5738.053221218535, 5769.624974376652, 5772.220750198753, 5773.6824474654295, 5775.6823374714795, 5863.736131874076, 5864.38423965486, 5866.090755932837, 5866.73599688015, 5873.383294754075, 5612.719364031782, 5645.645045189125, 5661.094224923992, 5720.342160651495, 5767.625104368202, 5610.747516361774, 5726.942730572641, 5746.88506229873, 5794.333651630032, 5852.882942341129, 4435.600795928382, 4451.777411129496, 4458.866234012985, 4463.308187230984, 4492.707973981681, 3880.650741433228, 3884.8251828667776, 3887.8833634990997, 3899.7855117968784, 3932.8230229639735, 5509.614326997072, 5516.9448305516435, 5524.364698059774, 5536.474034966753, 5537.224788529609, 5737.225474560881, 5846.649201047951, 5847.06446968483, 5865.149553314745, 5914.290285165722, 5241.554467870197, 5458.153986132076, 5555.555555555627, 5563.972180139154, 5570.08093664549, 5020.47285035066, 5025.170846810309, 5034.572061374824, 5040.697558146523, 5050.9494905051215, 5739.053056245756, 6045.818625441156, 6047.879042419215, 6065.090236464565, 6082.148499210026, 5790.826275211666, 5810.41895810424, 5868.2664666916635, 5940.287165540163, 5941.346451890202, 6112.113743507255, 6119.082137679384, 6119.35746746603, 6124.203853499195, 6130.049842274455, 5592.776288948559, 5670.858228544319, 5768.278965129359, 5815.098659707752, 5824.912626310694, 5839.240898683314, 5849.0, 5853.122031695109, 5858.970705146447, 5920.171176035273, 5708.942910570841, 5734.168545560954, 5743.081107023024, 5761.078227483583, 5775.9133612996675, 5456.372517160577, 5552.056150454352, 5567.916481252865, 5685.545156387562, 5767.221425107557, 5413.485718856702, 5417.052015897281, 5453.182022696627, 5460.945390546044, 5589.217509548585, 5640.238567793295, 5653.378128405954, 5670.234518339971, 5692.288463942007, 5692.6299790513485, 5436.809711660231, 5542.418046105101, 5563.388027316911, 5615.887682246251, 5647.0], "value": 5314.622115770288, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0665641629807, 632.6457183976974, 636.866258085802, 653.3107571512054, 653.5359894474923, 42635.573644263546, 43978.78010609947, 44045.33931991015, 44210.0, 48189.51810481894, 46073.0, 46758.766206169006, 46941.29588056182, 46950.0, 46956.76521617395, 8720.171583699539, 8909.331800115016, 8918.197362237397, 8922.241609463203, 8927.642894284254, 8830.514321712304, 8843.336749743763, 8898.110188981114, 8915.598798054103, 8932.55337233139, 8835.558222088903, 8942.463452192856, 8966.372353935227, 8969.686060987866, 9003.729888103335, 8894.688685895995, 8894.822103557924, 8927.419717718392, 8927.687530936419, 8960.0, 8748.21266086049, 8830.911690883073, 8836.116388361177, 8866.202041816203, 8871.689490867853, 42162.57837421617, 42272.0, 42424.575754242374, 42529.14941701149, 42694.0, 3582.0507565495163, 3646.197836475971, 3731.421629647409, 3752.8498860045565, 4176.979115104405, 32923.3415331692, 33290.0, 33643.66356336454, 33771.66228337734, 34782.65217347819, 4117.773522456264, 4199.349100889367, 4220.9155816883795, 4321.178975994551, 4353.499347575038, 348184.2590787055, 348841.0, 348842.0, 348880.0, 350661.0, 53282.46717532853, 56789.148162777594, 58109.12836307459, 58162.418375816545, 59005.0, 62720.372796272364, 62933.37066629275, 62967.0, 63283.6835815818, 63471.0, 14780.408783648749, 14938.0, 15007.699846003019, 15020.924895375454, 15039.323230454656, 11426.428678566039, 11509.769804604028, 11621.2446190999, 11623.12826537996, 11692.94153529227, 17604.119794010247, 17658.823411765974, 17675.381361652282, 17687.20407581662, 17857.374991875222, 6562.5406221564035, 6567.704453299613, 6622.9006564901565, 6628.436582890412, 6758.594484330956, 1058.317385286486, 1145.4272863568217, 1158.0908986445768, 1169.7485040716288, 1223.9816402753966, 32038.0, 32366.0, 32392.838035810142, 32431.675683242865, 32968.175795604824, 1157.9131565132648, 1167.7839599674087, 1193.988060119405, 1221.9633410997685, 1227.245244174826, 16458.341666333214, 16732.916335418246, 16750.151866715823, 16777.91611041937, 16883.831161688227, 517972.0, 518685.0, 521241.0, 523158.0, 527816.0, 56199.0, 56266.0, 56414.0, 56659.15011274834, 57083.0, 1382.4608402722947, 1401.1873113594295, 1402.719456108762, 1417.1143035602747, 1427.7929700193413, 30548.389032219675, 32203.838980805882, 32339.676603233667, 32589.837050815542, 32916.34167316592, 49752.75123624359, 49869.0, 50362.74818625883, 50382.74808625934, 50443.747781260856, 437072.0, 437894.0, 438145.0, 439075.0, 439190.0, 40236.79881600691, 42226.155476890905, 42478.15043699047, 42827.0, 42902.78548607237, 47792.7610361946, 48184.75907620439, 48319.75840120777, 49321.0, 49806.25290620716, 40554.39168412417, 41202.587974121074, 41238.1752364945, 41974.79012604917, 42003.78998105112, 40543.78368648945, 40836.59163408447, 40930.59069409268, 40984.59015409808, 41066.58933410628, 40677.389839151845, 41045.58954410418, 41931.37102943519, 42008.0, 42194.36708449437, 34513.65486345205, 36022.819885900404, 36402.817985909904, 36450.0, 36570.634293657786, 27600.343979361303, 27787.722122778512, 28381.716182838732, 28507.0, 28599.714002859706], "value": 20388.600832484786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.33049811068344, 402.41247778243763, 403.89094944365024, 409.1265148907082, 420.41922371881714, 16266.99999999997, 18416.723749143774, 19144.90427547864, 20116.69824952625, 20132.59734805305, 18281.451556453296, 18804.71792923104, 19480.902595487038, 19531.90234048828, 19616.117274722637, 5636.408177141403, 5705.4294570542825, 5969.5821292509545, 5974.8506287342725, 5977.282726072877, 5847.502962248214, 5847.766089356421, 5865.824025279248, 5871.2073870027425, 5896.086106653454, 5778.219940308047, 5845.269341332333, 5879.911801322984, 5895.823125306226, 5927.347991720907, 5807.709614519278, 5808.0, 5811.360750317462, 5871.089981052944, 5914.2902851657645, 5594.021046316879, 5661.886762264773, 5700.40145784695, 5719.084946408555, 5748.626339287933, 13864.376103075387, 18623.255069797193, 22765.20321788746, 23591.646125308132, 23727.525449491088, 2340.6137987232087, 2401.4236583220077, 2411.1922505960524, 2445.2053082748, 2476.05909754294, 9982.251331150193, 10305.12406445453, 10529.947350263199, 10731.302465339806, 13928.30358482082, 1932.5555122321805, 1957.7748558915623, 1999.990000050005, 2023.9595208095902, 2026.9594608107902, 80390.59804700997, 85533.57233213856, 87025.0, 87066.0, 88108.11891881128, 11134.832977505344, 11160.162987775788, 11180.888191117985, 11224.102071834397, 11341.603043893425, 11972.820407693891, 12670.429830657642, 12722.300273484861, 15808.92095539515, 16060.678786424207, 5992.520598352121, 6129.509639228851, 6813.829654258683, 7626.58053807046, 7751.302382785577, 7378.335949764547, 7405.740799072007, 7473.962630186814, 7595.354394876387, 7669.884951725729, 4099.672026237894, 4135.421041054255, 4186.497620285585, 4187.304141822506, 4250.128723611652, 1887.4715079777684, 1965.1255191439673, 1965.459498637886, 2013.3758534853948, 2016.8084032016934, 983.326421401328, 1029.9073083422527, 1057.4871187474068, 1059.1950117910444, 1088.8588361640354, 19059.142338594796, 20176.49558761043, 20250.189992400432, 20302.796972030384, 20483.590328193353, 1016.5933626549291, 1026.7022563456514, 1044.5769463367349, 1057.3972835483855, 1084.2410312781085, 11044.723881903017, 11389.487473063731, 11433.942830285796, 11512.251703639404, 11559.248648837798, 480448.0, 480734.0, 486779.0, 487425.0, 514722.0, 105089.0, 105255.4737226309, 105695.47152264189, 105877.0, 106210.0, 979.5053497983473, 1029.577873072037, 1041.5989843909997, 1050.7058023753361, 1056.4453661827602, 17302.74045889338, 17788.733169002215, 17877.28490860403, 17881.73177402314, 18143.18355674024, 42482.0, 43080.78459607682, 43576.0, 43640.781796090814, 44147.66536381431, 59893.700531498806, 60241.69879150576, 61033.08450373337, 62500.0, 62718.0, 7440.330370266702, 7918.089419716806, 8708.390412671051, 8848.778780530538, 9016.459012459274, 12891.548795792101, 13104.279264640536, 13500.864991349961, 13847.169169849438, 14101.788473173116, 11369.204155709353, 11853.822192667289, 12035.638930832089, 12120.27278363301, 12184.634460966185, 11815.350155741173, 11850.111241656738, 11878.762424751629, 11979.820302695642, 12051.57819476314, 12401.565945191875, 12452.128351015343, 12471.93764031174, 12746.171498852545, 12776.0, 7540.660670269741, 8045.637946292314, 8150.877736834071, 8203.58982050883, 8320.0, 11360.715982100182, 12068.336241506802, 12201.0, 12606.306653134166, 12693.301868397326], "value": 9307.544907961532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.82648495423, 1542.0747551469117, 1714.3999600139953, 1827.2964908510219, 1853.518085297823, 7336.596487193202, 8654.524001179932, 8697.652093916244, 9221.815563688722, 9222.90777092229, 8825.646974121028, 8854.91145088549, 8889.955550222256, 8928.19646231839, 8952.194302512773, 2194.199117322174, 2199.8790066546335, 2203.5923354179527, 2219.655953327229, 2228.576570451609, 2249.7975182233595, 2271.3299576624936, 2288.6567014947723, 2305.446692793726, 2310.526342099874, 2258.3225032490186, 2261.434641339665, 2265.0713207584895, 2282.5206706591553, 2296.334063121693, 2224.8887555622237, 2229.944251393712, 2232.0960011195493, 2232.4530490029965, 2245.034635106895, 2199.1533259694975, 2201.9449513762124, 2230.4646884747544, 2232.765559616233, 2235.3629215673454, 8878.200961913395, 9023.27813774903, 9049.954750226207, 9061.818763624757, 9100.317476189246, 5233.110371236899, 5340.91988620171, 5354.651947623392, 5357.062514060063, 5371.2811900191955, 3217.3404452087498, 3321.7674762766615, 3482.7387945904156, 3483.2336885885065, 3494.598121216042, 1119.3843386137592, 1122.6295322543622, 1153.411760002405, 1189.9345535995603, 1211.9757604847941, 12304.07719421038, 12325.260484370876, 12383.133180677356, 12393.132480726354, 12411.317377544232, 4549.840755573539, 4610.0, 4693.06138772247, 4708.317293992421, 4751.334813126096, 10329.173666106693, 10395.428251446243, 10408.635697750693, 10419.739506512398, 10439.0, 5270.051390749702, 5317.973410132925, 5318.734063296897, 5353.250544923714, 5364.7317634118135, 4127.195196936568, 4805.3512775775525, 4865.683730557503, 4885.389326334208, 4975.0, 3991.820368083443, 4011.5186177658866, 4055.0673345130785, 4121.113960498507, 4147.730397524151, 1257.8805013523884, 1280.9359532023361, 1293.8706129386985, 1311.4033114932683, 1323.7683405404016, 893.2809088683672, 941.3833938770116, 1012.2538620878925, 1020.0480198044346, 1041.5885725138528, 6026.306974697965, 6138.355472675305, 6175.536834737412, 6205.2553693557065, 6227.719752611143, 435.37741030326936, 447.7492604141691, 448.27155871708476, 455.6673628251329, 460.2360082263427, 4094.303968325392, 4200.264953633163, 4208.915821683549, 4217.219814334297, 4243.130158317599, 11027.889721102847, 11344.829827552594, 11346.659600212008, 11352.091832653368, 11383.943080284545, 10811.243212975174, 11227.775444491064, 11252.831207531894, 11280.379579123228, 11294.54821807135, 8382.538960357117, 8436.999999999878, 8514.57427128641, 8522.147785221428, 8595.957020214859, 6061.424164704346, 6307.653079080695, 6352.745890164527, 6366.808995730135, 6410.647414392253, 10377.648142462556, 10485.9475702621, 10602.946985265024, 10651.30766500175, 10710.464476775975, 10636.734081648021, 10667.679969600924, 10811.891881081403, 10824.621138260123, 10825.945870270598, 6760.08738820253, 7699.538027718355, 7959.761207163794, 8059.3552515799765, 8197.262246397853, 8802.647894084164, 8815.823683526422, 8830.470171789713, 8861.025287218272, 8874.866876996979, 7735.922640773745, 7737.729179478692, 7910.485818421784, 7964.2433968772875, 8134.267915887599, 7687.730929417444, 7759.107702614272, 7787.29914307715, 7876.133625301327, 7926.524408535506, 7074.646267686698, 7233.31283528064, 7255.818604534928, 7287.672054757655, 7328.0, 5188.273641690242, 5213.947860521346, 5228.398734145622, 5293.232481290268, 5366.7584958677735, 5185.481451854785, 5200.583953283653, 5340.572754179734, 5395.86510337229, 5412.8105516308315], "value": 4617.237047397599, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.5746871982915, 339.9337129259795, 343.25171126943263, 349.8373256435755, 351.86453215512023, 5445.0, 5512.283403157584, 5605.495505404513, 5695.430456954303, 5706.5720070994685, 5526.50261476467, 5543.916841247385, 5567.777288908449, 5573.777048918048, 5610.438956104398, 4333.934990975138, 4334.046509767846, 4363.258246098171, 4384.780760961955, 4418.182636212295, 4103.537877273642, 4331.675124365669, 4345.8478953236645, 4403.955960440403, 4413.713108647944, 4271.423357846697, 4273.145370925812, 4277.700560960734, 4295.355696645497, 4296.162248361571, 4296.462942132249, 4303.139372125572, 4319.3952846601505, 4337.937205384669, 4348.608625223714, 3699.426588878728, 3781.789827255252, 3792.848286068554, 3793.1844653399376, 3797.563280222782, 5421.186821976696, 5458.727063646841, 5464.0, 5467.480589344006, 5477.4796394342875, 4946.233333833262, 4970.552650261494, 4991.604030065589, 5010.0, 5010.448850626428, 5656.660600363992, 5847.766089356421, 5862.267216597926, 5896.0, 5935.673537955411, 4116.217918595487, 4171.707980441371, 4191.685623578243, 4201.6008479194425, 4208.516020657633, 5849.649021058707, 6143.539234557426, 6166.81499555014, 6197.969010154966, 6212.347703491114, 4160.875173744793, 4169.770662613525, 4172.582741725864, 4177.874663760092, 4205.11692544563, 4209.957900421018, 4228.667969589569, 4243.0, 4245.3844192591905, 4257.382679511516, 4878.317035615017, 4909.803607855717, 4911.631627627942, 4938.925916111261, 4954.0183926429, 5644.943550564524, 5650.208970744099, 5873.20711703923, 5900.586958912921, 5953.523718102541, 1474.8893832962572, 1480.6446452851237, 1498.48302335694, 1502.646877983673, 1505.811773528309, 918.8070505193984, 948.1608776232946, 952.8094381123803, 954.8567714842691, 956.4070276428658, 4962.578180854595, 5056.191009438472, 5072.184937359727, 5082.618803589746, 5120.92318615221, 5295.920561191585, 5316.73416329182, 5320.813771517978, 5323.627346085815, 5357.892842143136, 5048.712578292512, 5128.538431541105, 5163.793448262028, 5384.653836540865, 5843.152742852348, 3218.4850423932057, 3228.7085165933813, 3236.174775432297, 3271.5092736089778, 3283.4582293921235, 6105.8168254952425, 6339.397757213057, 6340.256429481838, 6360.363963603695, 6403.679816009181, 6102.359252278447, 6153.969230153821, 6168.506519478431, 6215.782447614311, 6230.844228894223, 6296.464800492009, 6327.778527751507, 6330.493560515148, 6350.33321501245, 6373.267074286424, 5856.560757943256, 6084.361142080018, 6091.451769340781, 6104.375118699002, 6166.475849552839, 6027.819165425044, 6066.757329706762, 6067.726952287069, 6091.177691011657, 6118.816435506764, 6093.939060609515, 6347.650879201688, 6362.300146983921, 6405.3594640535575, 6416.262129855127, 4256.553061928576, 4259.808308626181, 4267.50923643785, 4305.97847010763, 4307.870763877088, 5872.677002764889, 5978.222831031938, 6130.785422510191, 6171.907421388593, 6196.3803619639475, 5908.5568582357355, 5918.644881307136, 5960.314563825215, 5977.282726072725, 6009.939900600938, 5930.902782985161, 5952.76771210796, 5971.283066204953, 5971.611355457678, 5980.700964951822, 5659.858503537444, 5790.478856902899, 5816.73824677882, 5830.183774271521, 5844.574501581966, 6023.789167379121, 6048.485878700184, 6061.6666083365835, 6068.939310606837, 6090.482309003607, 5661.423324787009, 5816.94183058164, 5866.560007999332, 5868.4424979626865, 5896.410358964069], "value": 4442.05384986954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.177445208455, 686.4679873098352, 706.5372181221295, 743.108270075909, 793.5119901260724, 14832.406703731851, 15476.148811815345, 15774.369025238977, 15849.04905705657, 15998.040117592938, 14742.926285368585, 14833.442488538683, 14853.851461485381, 14856.18290993995, 14874.776878346833, 676.1210426445625, 799.1010113622175, 800.9879851802227, 821.0188824354898, 821.322409012564, 793.3692714292123, 794.7099308752322, 794.7218473534275, 795.3716563914501, 796.366888323784, 863.3395452478859, 863.8099618084011, 865.35098675993, 865.4504389712546, 865.5628907401754, 852.0967774159349, 853.2320911179957, 853.7182729699184, 854.8760429737684, 855.0508935082054, 615.8983767678328, 618.483566222205, 619.8109576579142, 621.1645337021698, 622.4771192198575, 14947.850521494755, 14998.325075371635, 15009.099454032794, 15017.399304027826, 15054.849451505454, 14245.430182792676, 14293.070950388192, 14369.56891293263, 14506.911981601317, 14722.779158312635, 11528.250663706833, 11583.6524904253, 11644.592439264585, 11666.766664666658, 11789.528418863236, 3773.1541225754036, 3833.7124715646437, 3850.5956874528333, 3853.3064048471265, 3976.602339766029, 52229.0, 63576.0, 65902.67048664726, 65933.34066659368, 66410.0, 10202.0, 10726.141908647289, 10776.838347424795, 10816.296940698829, 11010.559577616967, 19657.606847862964, 19760.505987350145, 19782.208711651372, 19838.504037398892, 19882.90058549698, 8586.828263434696, 8741.868871966926, 8746.300295976307, 8762.474251544927, 8819.382643215042, 4678.555537223959, 4723.0789995951145, 4727.456342520654, 4764.38063051808, 4820.758962051884, 3382.2728113455723, 3417.4532074867902, 3447.5345828312857, 3465.341585098823, 3481.6518348165487, 590.4715279824533, 593.4006653280218, 604.6523249131767, 637.6939069246695, 638.9552731308856, 678.5555461172939, 716.2228981554968, 756.1568850731395, 762.5539059650167, 784.9921500784919, 8729.694460693845, 9178.586963586655, 9264.7683807904, 9318.580663870142, 9372.953135234417, 660.3363619562309, 691.2534462780185, 712.8253577873351, 753.3596443023387, 782.1201148707704, 4507.18870603288, 4773.0, 4969.0987594683065, 4983.9252411213865, 5022.917497010732, 70239.0, 71113.0, 72239.63880180566, 72384.0, 72668.63665681638, 63926.0, 64122.679386603704, 65431.67284163644, 65584.67207663931, 65897.0, 57623.71188144032, 57881.710591446776, 57918.420815792146, 58092.0, 58725.41274587285, 9365.0, 9391.812163756824, 9396.15434610861, 9462.952685236529, 9473.24214062887, 37227.813860930524, 37506.0, 37532.624673754006, 37698.81150594339, 38388.232235354575, 45275.0, 51096.74451627867, 51415.0, 51665.48334516607, 52113.218301724744, 11903.702407439883, 11985.520579177084, 12109.515619375126, 12141.757164856477, 12460.87539124597, 12592.559260425842, 12877.291748953523, 12916.09587328878, 13005.349732513147, 13295.335233238493, 12237.755244894874, 12484.650223970055, 12524.624261271812, 12755.681107972005, 12777.872221277668, 12213.36238918344, 12308.138430309793, 12504.124711270124, 12527.436265368262, 12594.0, 11440.313581185155, 11535.0, 11667.299962002307, 11713.707157321136, 12086.576969806014, 10379.636712715019, 10562.366258024544, 10892.564297428014, 10998.615048473264, 11006.119510438986, 10517.263791534826, 10877.836832447678, 10970.396628185526, 11015.0, 11047.502862371051], "value": 6950.628348624223, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0, 112.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 150.0, 171.0, 127.0, 157.0, 157.0, 128.0, 187.0, 129.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 160.0, 163.0, 161.0, 166.0, 166.0, 161.0, 159.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 165.0, 78.0, 75.0, 81.0, 75.0, 163.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 146.0, 83.0, 84.0, 83.0, 143.0, 84.0, 84.0, 152.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 149.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 55.0, 57.0, 53.0, 53.0, 52.0, 54.0, 53.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 85.0, 80.0, 84.0, 83.0, 80.0, 81.0, 108.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 131.0, 131.0, 123.0, 127.0, 120.0, 122.0, 128.0, 126.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 160.0, 166.0, 164.0, 159.0, 160.0, 159.0, 159.0, 167.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 65.0, 64.0, 63.0, 63.0, 69.0, 63.0, 63.0, 66.0], "value": 64.3, "unit": "score"}]}]} 11:34:35 INFO - Return code: 0 11:34:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:34:35 ERROR - # TBPL SUCCESS # 11:34:35 INFO - Running post-action listener: _resource_record_post_action 11:34:35 INFO - ##### 11:34:35 INFO - ##### Finished run-tests step (success) 11:34:35 INFO - ##### 11:34:35 INFO - Running post-run listener: _resource_record_post_run 11:34:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541974528; Read time: 16; Write time: 395384 11:34:35 INFO - TinderboxPrint: CPU usage
13.4% 11:34:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:34:35 INFO - TinderboxPrint: I/O write bytes / time
541,974,528 / 395,384 11:34:35 INFO - TinderboxPrint: CPU idle
8,211.2 (86.6%) 11:34:35 INFO - TinderboxPrint: CPU user
1,221.8 (12.9%) 11:34:35 INFO - TinderboxPrint: Swap in / out
0 / 0 11:34:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247472128; Read time: 0; Write time: 229068 11:34:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294502400; Read time: 16; Write time: 166316 11:34:35 INFO - Running post-run listener: _upload_blobber_files 11:34:35 INFO - Blob upload gear active. 11:34:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:35 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 11:34:35 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'] 11:34:35 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 11:34:36 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:36 INFO - (blobuploader) - INFO - Done attempting. 11:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:37 INFO - (blobuploader) - INFO - Done attempting. 11:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:41 INFO - (blobuploader) - INFO - Done attempting. 11:34:41 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:41 INFO - Return code: 0 11:34:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7e0a06a2a100e52fabbc5e5e34db0e779c261a019889f2131bb50da634fad82775116528ab4589840dc6274638eb756883c1ef3b8e20b9d792abe030254901f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cfda002ac548c9a64a558bc9c22b867c9549962e50bcf608516b4975dcce93568942cf0f281721f40ec170159667d423197ae570853599343f44b2f25700392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/472dbde7a528a7d6e8560dcbfa1251ca16908808c93db67ca07c617d302a79eacc542f21643ff48056d94c8bd6a2f4bc5ec73b2adab44caf6ab25ba48b9c610a"} 11:34:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:41 INFO - Contents: 11:34:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7e0a06a2a100e52fabbc5e5e34db0e779c261a019889f2131bb50da634fad82775116528ab4589840dc6274638eb756883c1ef3b8e20b9d792abe030254901f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cfda002ac548c9a64a558bc9c22b867c9549962e50bcf608516b4975dcce93568942cf0f281721f40ec170159667d423197ae570853599343f44b2f25700392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/472dbde7a528a7d6e8560dcbfa1251ca16908808c93db67ca07c617d302a79eacc542f21643ff48056d94c8bd6a2f4bc5ec73b2adab44caf6ab25ba48b9c610a"} 11:34:41 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:41 INFO - Copying logs to upload dir... 11:34:41 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.417387 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-27 11:34:41.465887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 11:34:41.471958) ========= 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=0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7e0a06a2a100e52fabbc5e5e34db0e779c261a019889f2131bb50da634fad82775116528ab4589840dc6274638eb756883c1ef3b8e20b9d792abe030254901f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cfda002ac548c9a64a558bc9c22b867c9549962e50bcf608516b4975dcce93568942cf0f281721f40ec170159667d423197ae570853599343f44b2f25700392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/472dbde7a528a7d6e8560dcbfa1251ca16908808c93db67ca07c617d302a79eacc542f21643ff48056d94c8bd6a2f4bc5ec73b2adab44caf6ab25ba48b9c610a"} build_url:https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/Z9HtPD4GS0ivV37WlWws5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7e0a06a2a100e52fabbc5e5e34db0e779c261a019889f2131bb50da634fad82775116528ab4589840dc6274638eb756883c1ef3b8e20b9d792abe030254901f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cfda002ac548c9a64a558bc9c22b867c9549962e50bcf608516b4975dcce93568942cf0f281721f40ec170159667d423197ae570853599343f44b2f25700392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/472dbde7a528a7d6e8560dcbfa1251ca16908808c93db67ca07c617d302a79eacc542f21643ff48056d94c8bd6a2f4bc5ec73b2adab44caf6ab25ba48b9c610a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 11:34:41.497656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:34:41.497989) ========= 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=0333a256a5e4f052382dd180000001b1-1464372849.687313-969372235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:34:41.582586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 11:34:41.582903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 11:34:41.583253) ========= ========= Total master_lag: 0.17 =========