builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1462883150.39 results: success (0) buildid: 20160510023016 builduid: d94c99edbcb74a0ea7758a566ee7bfc3 revision: b041ad17b6c87ddf64db984292e95a777fb9959f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.385566) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.386040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.386325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.402670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.403036) ========= 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=eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 05:25:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-05-10 05:25:50 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157443 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.573600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.573920) ========= 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=eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017934 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.623181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:50.623552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b041ad17b6c87ddf64db984292e95a777fb9959f --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 b041ad17b6c87ddf64db984292e95a777fb9959f --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=eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 05:25:50,715 truncating revision to first 12 chars 2016-05-10 05:25:50,715 Setting DEBUG logging. 2016-05-10 05:25:50,715 attempt 1/10 2016-05-10 05:25:50,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b041ad17b6c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 05:25:50,970 unpacking tar archive at: fx-team-b041ad17b6c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:51.158299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:51.158650) ========= script_repo_revision: b041ad17b6c87ddf64db984292e95a777fb9959f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:51.159055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:51.159330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:25:51.167378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-10 05:25:51.167667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:51 INFO - MultiFileLogger online at 20160510 05:25:51 in /builds/slave/test 05:25:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:25:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:51 INFO - {'append_to_log': False, 05:25:51 INFO - 'base_work_dir': '/builds/slave/test', 05:25:51 INFO - 'blob_upload_branch': 'Fx-Team', 05:25:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:51 INFO - 'branch': 'Fx-Team', 05:25:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:51 INFO - 'config_files': ('talos/linux_config.py',), 05:25:51 INFO - 'default_actions': ('clobber', 05:25:51 INFO - 'read-buildbot-config', 05:25:51 INFO - 'download-and-extract', 05:25:51 INFO - 'populate-webroot', 05:25:51 INFO - 'create-virtualenv', 05:25:51 INFO - 'install', 05:25:51 INFO - 'run-tests'), 05:25:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:51 INFO - 'download_minidump_stackwalk': True, 05:25:51 INFO - 'download_symbols': 'ondemand', 05:25:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:51 INFO - 'installer_path': 'installer.exe', 05:25:51 INFO - 'log_level': 'info', 05:25:51 INFO - 'log_name': 'talos', 05:25:51 INFO - 'log_to_console': True, 05:25:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:51 INFO - 'opt_config_files': (), 05:25:51 INFO - 'pip_index': False, 05:25:51 INFO - 'sps_profile': False, 05:25:51 INFO - 'sps_profile_interval': 0, 05:25:51 INFO - 'suite': 'dromaeojs', 05:25:51 INFO - 'system_bits': '32', 05:25:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:51 INFO - 'title': 'talos-linux64-ix-010', 05:25:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:51 INFO - 'use_talos_json': True, 05:25:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:51 INFO - 'work_dir': 'build'} 05:25:51 INFO - ##### 05:25:51 INFO - ##### Running clobber step. 05:25:51 INFO - ##### 05:25:51 INFO - Running pre-action listener: _resource_record_pre_action 05:25:51 INFO - Running main action method: clobber 05:25:51 INFO - rmtree: /builds/slave/test/build 05:25:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:52 INFO - Running post-action listener: _resource_record_post_action 05:25:52 INFO - ##### 05:25:52 INFO - ##### Finished clobber step (success) 05:25:52 INFO - ##### 05:25:52 INFO - ##### 05:25:52 INFO - ##### Running read-buildbot-config step. 05:25:52 INFO - ##### 05:25:52 INFO - Running pre-action listener: _resource_record_pre_action 05:25:52 INFO - Running main action method: read_buildbot_config 05:25:52 INFO - Using buildbot properties: 05:25:52 INFO - { 05:25:52 INFO - "project": "", 05:25:52 INFO - "product": "firefox", 05:25:52 INFO - "script_repo_revision": "production", 05:25:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:25:52 INFO - "repository": "", 05:25:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:25:52 INFO - "buildid": "20160510023016", 05:25:52 INFO - "pgo_build": "True", 05:25:52 INFO - "basedir": "/builds/slave/test", 05:25:52 INFO - "buildnumber": 73, 05:25:52 INFO - "slavename": "talos-linux64-ix-010", 05:25:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:25:52 INFO - "platform": "ubuntu64_hw", 05:25:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:25:52 INFO - "branch": "fx-team", 05:25:52 INFO - "repo_path": "integration/fx-team", 05:25:52 INFO - "revision": "b041ad17b6c87ddf64db984292e95a777fb9959f", 05:25:52 INFO - "stage_platform": "linux64-pgo", 05:25:52 INFO - "builduid": "d94c99edbcb74a0ea7758a566ee7bfc3", 05:25:52 INFO - "slavebuilddir": "test" 05:25:52 INFO - } 05:25:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:25:52 INFO - Running post-action listener: _resource_record_post_action 05:25:52 INFO - ##### 05:25:52 INFO - ##### Finished read-buildbot-config step (success) 05:25:52 INFO - ##### 05:25:52 INFO - ##### 05:25:52 INFO - ##### Running download-and-extract step. 05:25:52 INFO - ##### 05:25:52 INFO - Running pre-action listener: _resource_record_pre_action 05:25:52 INFO - Running main action method: download_and_extract 05:25:52 INFO - mkdir: /builds/slave/test/build/tests 05:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:52 INFO - https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:25:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:25:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:25:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:52 INFO - Downloaded 1361 bytes. 05:25:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:25:52 INFO - Using the following test package requirements: 05:25:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:25:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:25:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'jsshell-linux-x86_64.zip'], 05:25:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:25:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:25:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:25:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:25:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:25:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:52 INFO - https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:25:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:25:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:54 INFO - Downloaded 23896328 bytes. 05:25:54 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'] 05:25:54 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 05:25:55 INFO - Return code: 0 05:25:55 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 05:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:55 INFO - https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:57 INFO - Downloaded 23896328 bytes. 05:25:57 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'] 05:25:57 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 05:25:59 INFO - Return code: 0 05:25:59 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')]} 05:25:59 INFO - https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:25:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:25:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:25:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:25:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:26:00 INFO - Downloaded 10840152 bytes. 05:26:00 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'] 05:26:00 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 05:26:00 INFO - Return code: 0 05:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:00 INFO - https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KjPzqq-LQ_m5x325XIw_jg/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 05:26:02 INFO - Downloaded 58447894 bytes. 05:26:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:26:02 INFO - mkdir: /builds/slave/test/properties 05:26:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:02 INFO - Contents: 05:26:02 INFO - build_url:https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:26:03 INFO - Running post-action listener: _resource_record_post_action 05:26:03 INFO - Running post-action listener: set_extra_try_arguments 05:26:03 INFO - ##### 05:26:03 INFO - ##### Finished download-and-extract step (success) 05:26:03 INFO - ##### 05:26:03 INFO - ##### 05:26:03 INFO - ##### Running populate-webroot step. 05:26:03 INFO - ##### 05:26:03 INFO - Running pre-action listener: _resource_record_pre_action 05:26:03 INFO - Running main action method: populate_webroot 05:26:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:03 INFO - '--tppagecycles', 05:26:03 INFO - '7'], 05:26:03 INFO - 'tests': ['tsvgm']}}, 05:26:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['damp', 'tps']}, 05:26:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'tests': ['damp', 'tps']}, 05:26:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['dromaeo_dom']}, 05:26:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['a11yr', 05:26:03 INFO - 'ts_paint', 05:26:03 INFO - 'tpaint', 05:26:03 INFO - 'sessionrestore', 05:26:03 INFO - 'sessionrestore_no_auto_restore', 05:26:03 INFO - 'tabpaint']}, 05:26:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:03 INFO - 'ts_paint', 05:26:03 INFO - 'tpaint', 05:26:03 INFO - 'sessionrestore', 05:26:03 INFO - 'sessionrestore_no_auto_restore', 05:26:03 INFO - 'tabpaint']}, 05:26:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:03 INFO - 'ts_paint', 05:26:03 INFO - 'tpaint', 05:26:03 INFO - 'sessionrestore', 05:26:03 INFO - 'sessionrestore_no_auto_restore', 05:26:03 INFO - 'tabpaint']}, 05:26:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:03 INFO - 'ts_paint', 05:26:03 INFO - 'tpaint', 05:26:03 INFO - 'sessionrestore', 05:26:03 INFO - 'sessionrestore_no_auto_restore', 05:26:03 INFO - 'tabpaint']}, 05:26:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['a11yr', 05:26:03 INFO - 'ts_paint', 05:26:03 INFO - 'tpaint', 05:26:03 INFO - 'sessionrestore', 05:26:03 INFO - 'sessionrestore_no_auto_restore', 05:26:03 INFO - 'tabpaint']}, 05:26:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['a11yr', 05:26:03 INFO - 'ts_paint', 05:26:03 INFO - 'tpaint', 05:26:03 INFO - 'sessionrestore', 05:26:03 INFO - 'sessionrestore_no_auto_restore', 05:26:03 INFO - 'tabpaint']}, 05:26:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['tsvgx', 05:26:03 INFO - 'tsvgr_opacity', 05:26:03 INFO - 'tart', 05:26:03 INFO - 'tscrollx', 05:26:03 INFO - 'cart']}, 05:26:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:03 INFO - 'tsvgr_opacity', 05:26:03 INFO - 'tart', 05:26:03 INFO - 'tscrollx', 05:26:03 INFO - 'cart']}, 05:26:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'talos_options': ['--disable-e10s'], 05:26:03 INFO - 'tests': ['tp5o']}, 05:26:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'tests': ['tp5o']}, 05:26:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'talos_options': ['--disable-e10s', 05:26:03 INFO - '--xperf_path', 05:26:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:03 INFO - 'tests': ['tp5n']}, 05:26:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:03 INFO - 'talos_options': ['--xperf_path', 05:26:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:03 INFO - 'tests': ['tp5n']}}, 05:26:03 INFO - 'talos.zip': {'path': '', 05:26:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:03 INFO - Running post-action listener: _resource_record_post_action 05:26:03 INFO - ##### 05:26:03 INFO - ##### Finished populate-webroot step (success) 05:26:03 INFO - ##### 05:26:03 INFO - ##### 05:26:03 INFO - ##### Running create-virtualenv step. 05:26:03 INFO - ##### 05:26:03 INFO - Running pre-action listener: _resource_record_pre_action 05:26:03 INFO - Running main action method: create_virtualenv 05:26:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:03 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 05:26:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:03 INFO - Using real prefix '/usr' 05:26:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:06 INFO - Installing pip.................done. 05:26:06 INFO - Return code: 0 05:26:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:06 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')]} 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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')]} 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:06 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 05:26:06 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 05:26:06 INFO - Using env: {'DISPLAY': ':0', 05:26:06 INFO - 'HOME': '/home/cltbld', 05:26:06 INFO - 'LANG': 'en_US.UTF-8', 05:26:06 INFO - 'LANGUAGE': 'en_US:en', 05:26:06 INFO - 'LOGNAME': 'cltbld', 05:26:06 INFO - 'MAIL': '/var/mail/cltbld', 05:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:06 INFO - 'MOZ_NO_REMOTE': '1', 05:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:06 INFO - 'NO_EM_RESTART': '1', 05:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:06 INFO - 'PWD': '/builds/slave/test', 05:26:06 INFO - 'SHELL': '/bin/bash', 05:26:06 INFO - 'SHLVL': '1', 05:26:06 INFO - 'TERM': 'linux', 05:26:06 INFO - 'TMOUT': '86400', 05:26:06 INFO - 'USER': 'cltbld', 05:26:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:06 INFO - '_': '/tools/buildbot/bin/python'} 05:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:06 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 05:26:06 INFO - Cleaning up... 05:26:06 INFO - Return code: 0 05:26:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:26:06 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')]} 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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')]} 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:06 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>=0.7.1'] in /builds/slave/test/build 05:26:06 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>=0.7.1 05:26:06 INFO - Using env: {'DISPLAY': ':0', 05:26:06 INFO - 'HOME': '/home/cltbld', 05:26:06 INFO - 'LANG': 'en_US.UTF-8', 05:26:06 INFO - 'LANGUAGE': 'en_US:en', 05:26:06 INFO - 'LOGNAME': 'cltbld', 05:26:06 INFO - 'MAIL': '/var/mail/cltbld', 05:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:06 INFO - 'MOZ_NO_REMOTE': '1', 05:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:06 INFO - 'NO_EM_RESTART': '1', 05:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:06 INFO - 'PWD': '/builds/slave/test', 05:26:06 INFO - 'SHELL': '/bin/bash', 05:26:06 INFO - 'SHLVL': '1', 05:26:06 INFO - 'TERM': 'linux', 05:26:06 INFO - 'TMOUT': '86400', 05:26:06 INFO - 'USER': 'cltbld', 05:26:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:06 INFO - '_': '/tools/buildbot/bin/python'} 05:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:06 INFO - Downloading/unpacking psutil>=0.7.1 05:26:06 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 05:26:06 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 05:26:06 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 05:26:06 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 05:26:06 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 05:26:06 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 05:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:08 INFO - Installing collected packages: psutil 05:26:08 INFO - Running setup.py install for psutil 05:26:08 INFO - building 'psutil._psutil_linux' extension 05:26:08 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 05:26:08 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 05:26:08 INFO - building 'psutil._psutil_posix' extension 05:26:08 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 05:26:08 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 05:26:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:08 INFO - Successfully installed psutil 05:26:08 INFO - Cleaning up... 05:26:09 INFO - Return code: 0 05:26:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:26:09 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')]} 05:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:09 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')]} 05:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:09 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:09 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.0.0'] in /builds/slave/test/build 05:26:09 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.0.0 05:26:09 INFO - Using env: {'DISPLAY': ':0', 05:26:09 INFO - 'HOME': '/home/cltbld', 05:26:09 INFO - 'LANG': 'en_US.UTF-8', 05:26:09 INFO - 'LANGUAGE': 'en_US:en', 05:26:09 INFO - 'LOGNAME': 'cltbld', 05:26:09 INFO - 'MAIL': '/var/mail/cltbld', 05:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:09 INFO - 'MOZ_NO_REMOTE': '1', 05:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:09 INFO - 'NO_EM_RESTART': '1', 05:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:09 INFO - 'PWD': '/builds/slave/test', 05:26:09 INFO - 'SHELL': '/bin/bash', 05:26:09 INFO - 'SHLVL': '1', 05:26:09 INFO - 'TERM': 'linux', 05:26:09 INFO - 'TMOUT': '86400', 05:26:09 INFO - 'USER': 'cltbld', 05:26:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:09 INFO - '_': '/tools/buildbot/bin/python'} 05:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:26:11 INFO - Installing collected packages: mozsystemmonitor 05:26:11 INFO - Running setup.py install for mozsystemmonitor 05:26:11 INFO - Successfully installed mozsystemmonitor 05:26:11 INFO - Cleaning up... 05:26:11 INFO - Return code: 0 05:26:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:11 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')]} 05:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:11 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')]} 05:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:11 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 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:11 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 05:26:11 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 05:26:11 INFO - Using env: {'DISPLAY': ':0', 05:26:11 INFO - 'HOME': '/home/cltbld', 05:26:11 INFO - 'LANG': 'en_US.UTF-8', 05:26:11 INFO - 'LANGUAGE': 'en_US:en', 05:26:11 INFO - 'LOGNAME': 'cltbld', 05:26:11 INFO - 'MAIL': '/var/mail/cltbld', 05:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:11 INFO - 'MOZ_NO_REMOTE': '1', 05:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:11 INFO - 'NO_EM_RESTART': '1', 05:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:11 INFO - 'PWD': '/builds/slave/test', 05:26:11 INFO - 'SHELL': '/bin/bash', 05:26:11 INFO - 'SHLVL': '1', 05:26:11 INFO - 'TERM': 'linux', 05:26:11 INFO - 'TMOUT': '86400', 05:26:11 INFO - 'USER': 'cltbld', 05:26:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:11 INFO - '_': '/tools/buildbot/bin/python'} 05:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:11 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:11 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 05:26:11 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 05:26:11 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 05:26:11 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 05:26:11 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 05:26:11 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 05:26:13 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 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 05:26:13 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 05:26:14 INFO - Downloading docopt-0.6.1.tar.gz 05:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:14 INFO - Running setup.py install for blobuploader 05:26:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:14 INFO - Running setup.py install for requests 05:26:14 INFO - Running setup.py install for docopt 05:26:14 INFO - Successfully installed blobuploader requests docopt 05:26:14 INFO - Cleaning up... 05:26:14 INFO - Return code: 0 05:26:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:14 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 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:14 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 05:26:14 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 05:26:14 INFO - Using env: {'DISPLAY': ':0', 05:26:14 INFO - 'HOME': '/home/cltbld', 05:26:14 INFO - 'LANG': 'en_US.UTF-8', 05:26:14 INFO - 'LANGUAGE': 'en_US:en', 05:26:14 INFO - 'LOGNAME': 'cltbld', 05:26:14 INFO - 'MAIL': '/var/mail/cltbld', 05:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:14 INFO - 'MOZ_NO_REMOTE': '1', 05:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:14 INFO - 'NO_EM_RESTART': '1', 05:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:14 INFO - 'PWD': '/builds/slave/test', 05:26:14 INFO - 'SHELL': '/bin/bash', 05:26:14 INFO - 'SHLVL': '1', 05:26:14 INFO - 'TERM': 'linux', 05:26:14 INFO - 'TMOUT': '86400', 05:26:14 INFO - 'USER': 'cltbld', 05:26:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:14 INFO - '_': '/tools/buildbot/bin/python'} 05:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:15 INFO - Running setup.py (path:/tmp/pip-WqMQb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:15 INFO - Running setup.py (path:/tmp/pip-IbWcA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:15 INFO - Running setup.py (path:/tmp/pip-wVfimb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:15 INFO - Running setup.py (path:/tmp/pip-ebdfXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:15 INFO - Running setup.py (path:/tmp/pip-XOUK3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:15 INFO - Running setup.py (path:/tmp/pip-aEnTP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:15 INFO - Running setup.py (path:/tmp/pip-6zEikZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:15 INFO - Running setup.py (path:/tmp/pip-TlfM7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:15 INFO - Running setup.py (path:/tmp/pip-8JWEcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:15 INFO - Running setup.py (path:/tmp/pip-Xmgtnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:15 INFO - Running setup.py (path:/tmp/pip-CihULv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:15 INFO - Running setup.py (path:/tmp/pip-Tp3jbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:15 INFO - Running setup.py (path:/tmp/pip-LnKmRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:15 INFO - Running setup.py (path:/tmp/pip-57ZC0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:16 INFO - Running setup.py (path:/tmp/pip-UyLi3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:16 INFO - Running setup.py (path:/tmp/pip-U4MCV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:16 INFO - Running setup.py (path:/tmp/pip-wfHm_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:16 INFO - Running setup.py install for manifestparser 05:26:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Running setup.py install for mozcrash 05:26:16 INFO - Running setup.py install for mozdebug 05:26:16 INFO - Running setup.py install for mozdevice 05:26:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Running setup.py install for mozfile 05:26:16 INFO - Running setup.py install for mozhttpd 05:26:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Running setup.py install for mozinfo 05:26:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:16 INFO - Running setup.py install for mozInstall 05:26:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Running setup.py install for mozleak 05:26:17 INFO - Running setup.py install for mozlog 05:26:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Running setup.py install for moznetwork 05:26:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Running setup.py install for mozprocess 05:26:17 INFO - Running setup.py install for mozprofile 05:26:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Running setup.py install for mozrunner 05:26:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Running setup.py install for mozscreenshot 05:26:17 INFO - Running setup.py install for moztest 05:26:17 INFO - Running setup.py install for mozversion 05:26:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:18 INFO - Cleaning up... 05:26:18 INFO - Return code: 0 05:26:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:18 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 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:18 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 05:26:18 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 05:26:18 INFO - Using env: {'DISPLAY': ':0', 05:26:18 INFO - 'HOME': '/home/cltbld', 05:26:18 INFO - 'LANG': 'en_US.UTF-8', 05:26:18 INFO - 'LANGUAGE': 'en_US:en', 05:26:18 INFO - 'LOGNAME': 'cltbld', 05:26:18 INFO - 'MAIL': '/var/mail/cltbld', 05:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:18 INFO - 'MOZ_NO_REMOTE': '1', 05:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:18 INFO - 'NO_EM_RESTART': '1', 05:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:18 INFO - 'PWD': '/builds/slave/test', 05:26:18 INFO - 'SHELL': '/bin/bash', 05:26:18 INFO - 'SHLVL': '1', 05:26:18 INFO - 'TERM': 'linux', 05:26:18 INFO - 'TMOUT': '86400', 05:26:18 INFO - 'USER': 'cltbld', 05:26:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:18 INFO - '_': '/tools/buildbot/bin/python'} 05:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:18 INFO - Running setup.py (path:/tmp/pip-O_FK5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:18 INFO - Running setup.py (path:/tmp/pip-GxO9Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:18 INFO - Running setup.py (path:/tmp/pip-agJAF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:18 INFO - Running setup.py (path:/tmp/pip-5gwKRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:18 INFO - Running setup.py (path:/tmp/pip-ze0HGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:18 INFO - Running setup.py (path:/tmp/pip-FgFDJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:18 INFO - Running setup.py (path:/tmp/pip-ro0aON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:18 INFO - Running setup.py (path:/tmp/pip-XtzuTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:18 INFO - Running setup.py (path:/tmp/pip-ccqta3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:18 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:18 INFO - Running setup.py (path:/tmp/pip-wKk8lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:18 INFO - Running setup.py (path:/tmp/pip-rhfD2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:19 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)) 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:19 INFO - Running setup.py (path:/tmp/pip-paYVZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:19 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)) 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:19 INFO - Running setup.py (path:/tmp/pip-uTLg4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:19 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)) 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:19 INFO - Running setup.py (path:/tmp/pip-hkBhH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:19 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)) 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:19 INFO - Running setup.py (path:/tmp/pip-VMVM4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:19 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)) 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:19 INFO - Running setup.py (path:/tmp/pip-nf5Z7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:19 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)) 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:19 INFO - Running setup.py (path:/tmp/pip-X7o_tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:19 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)) 05:26:19 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)) 05:26:19 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)) 05:26:19 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)) 05:26:19 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)) 05:26:19 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)) 05:26:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:19 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 05:26:19 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 05:26:19 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 05:26:19 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 05:26:19 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 05:26:19 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 05:26:21 INFO - Downloading blessings-1.6.tar.gz 05:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:21 INFO - Installing collected packages: blessings 05:26:21 INFO - Running setup.py install for blessings 05:26:21 INFO - Successfully installed blessings 05:26:21 INFO - Cleaning up... 05:26:21 INFO - Return code: 0 05:26:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:21 INFO - Reading from file tmpfile_stdout 05:26:21 INFO - Current package versions: 05:26:21 INFO - argparse == 1.2.1 05:26:21 INFO - blessings == 1.6 05:26:21 INFO - blobuploader == 1.2.4 05:26:21 INFO - docopt == 0.6.1 05:26:21 INFO - manifestparser == 1.1 05:26:21 INFO - mozInstall == 1.12 05:26:21 INFO - mozcrash == 0.17 05:26:21 INFO - mozdebug == 0.1 05:26:21 INFO - mozdevice == 0.48 05:26:21 INFO - mozfile == 1.2 05:26:21 INFO - mozhttpd == 0.7 05:26:21 INFO - mozinfo == 0.9 05:26:21 INFO - mozleak == 0.1 05:26:21 INFO - mozlog == 3.1 05:26:21 INFO - moznetwork == 0.27 05:26:21 INFO - mozprocess == 0.22 05:26:21 INFO - mozprofile == 0.28 05:26:21 INFO - mozrunner == 6.11 05:26:21 INFO - mozscreenshot == 0.1 05:26:21 INFO - mozsystemmonitor == 0.0 05:26:21 INFO - moztest == 0.7 05:26:21 INFO - mozversion == 1.4 05:26:21 INFO - psutil == 3.1.1 05:26:21 INFO - requests == 1.2.3 05:26:21 INFO - wsgiref == 0.1.2 05:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:21 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')]} 05:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 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')]} 05:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 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 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:21 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 05:26:21 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 05:26:21 INFO - Using env: {'DISPLAY': ':0', 05:26:21 INFO - 'HOME': '/home/cltbld', 05:26:21 INFO - 'LANG': 'en_US.UTF-8', 05:26:21 INFO - 'LANGUAGE': 'en_US:en', 05:26:21 INFO - 'LOGNAME': 'cltbld', 05:26:21 INFO - 'MAIL': '/var/mail/cltbld', 05:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:21 INFO - 'MOZ_NO_REMOTE': '1', 05:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:21 INFO - 'NO_EM_RESTART': '1', 05:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:21 INFO - 'PWD': '/builds/slave/test', 05:26:21 INFO - 'SHELL': '/bin/bash', 05:26:21 INFO - 'SHLVL': '1', 05:26:21 INFO - 'TERM': 'linux', 05:26:21 INFO - 'TMOUT': '86400', 05:26:21 INFO - 'USER': 'cltbld', 05:26:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:21 INFO - '_': '/tools/buildbot/bin/python'} 05:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 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)) 05:26:21 INFO - Cleaning up... 05:26:22 INFO - Return code: 0 05:26:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:22 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 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26:22 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 05:26:22 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 05:26:22 INFO - Using env: {'DISPLAY': ':0', 05:26:22 INFO - 'HOME': '/home/cltbld', 05:26:22 INFO - 'LANG': 'en_US.UTF-8', 05:26:22 INFO - 'LANGUAGE': 'en_US:en', 05:26:22 INFO - 'LOGNAME': 'cltbld', 05:26:22 INFO - 'MAIL': '/var/mail/cltbld', 05:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:22 INFO - 'MOZ_NO_REMOTE': '1', 05:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:22 INFO - 'NO_EM_RESTART': '1', 05:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:22 INFO - 'PWD': '/builds/slave/test', 05:26:22 INFO - 'SHELL': '/bin/bash', 05:26:22 INFO - 'SHLVL': '1', 05:26:22 INFO - 'TERM': 'linux', 05:26:22 INFO - 'TMOUT': '86400', 05:26:22 INFO - 'USER': 'cltbld', 05:26:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:22 INFO - '_': '/tools/buildbot/bin/python'} 05:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:22 INFO - Downloading/unpacking jsonschema 05:26:22 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 05:26:22 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 05:26:22 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 05:26:22 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 05:26:22 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 05:26:22 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 05:26:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:24 INFO - Downloading/unpacking functools32 (from jsonschema) 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:24 INFO - warning: no files found matching '*.txt' 05:26:24 INFO - no previously-included directories found matching 'build' 05:26:24 INFO - no previously-included directories found matching 'dist' 05:26:24 INFO - no previously-included directories found matching '.git*' 05:26:24 INFO - Installing collected packages: jsonschema, functools32 05:26:24 INFO - Running setup.py install for functools32 05:26:24 INFO - warning: no files found matching '*.txt' 05:26:24 INFO - no previously-included directories found matching 'build' 05:26:24 INFO - no previously-included directories found matching 'dist' 05:26:24 INFO - no previously-included directories found matching '.git*' 05:26:24 INFO - Successfully installed jsonschema functools32 05:26:24 INFO - Cleaning up... 05:26:24 INFO - Return code: 0 05:26:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadedbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bac770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, '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': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', '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 05:26: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', 'flake8'] in /builds/slave/test/build 05:26: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 flake8 05:26:24 INFO - Using env: {'DISPLAY': ':0', 05:26:24 INFO - 'HOME': '/home/cltbld', 05:26:24 INFO - 'LANG': 'en_US.UTF-8', 05:26:24 INFO - 'LANGUAGE': 'en_US:en', 05:26:24 INFO - 'LOGNAME': 'cltbld', 05:26:24 INFO - 'MAIL': '/var/mail/cltbld', 05:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:24 INFO - 'MOZ_NO_REMOTE': '1', 05:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:24 INFO - 'NO_EM_RESTART': '1', 05:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:24 INFO - 'PWD': '/builds/slave/test', 05:26:24 INFO - 'SHELL': '/bin/bash', 05:26:24 INFO - 'SHLVL': '1', 05:26:24 INFO - 'TERM': 'linux', 05:26:24 INFO - 'TMOUT': '86400', 05:26:24 INFO - 'USER': 'cltbld', 05:26:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:24 INFO - '_': '/tools/buildbot/bin/python'} 05:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:24 INFO - Downloading/unpacking flake8 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:26:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:26:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 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 05:26:26 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 05:26:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:26:27 INFO - no previously-included directories found matching 'docs/_build' 05:26:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:26:27 INFO - Running setup.py install for pep8 05:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:26:27 INFO - no previously-included directories found matching 'docs/_build' 05:26:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:26:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:26:27 INFO - Cleaning up... 05:26:27 INFO - Return code: 0 05:26:27 INFO - Running post-action listener: _resource_record_post_action 05:26:27 INFO - Running post-action listener: _start_resource_monitoring 05:26:27 INFO - Starting resource monitoring. 05:26:27 INFO - ##### 05:26:27 INFO - ##### Finished create-virtualenv step (success) 05:26:27 INFO - ##### 05:26:27 INFO - ##### 05:26:27 INFO - ##### Running install step. 05:26:27 INFO - ##### 05:26:27 INFO - Running pre-action listener: _resource_record_pre_action 05:26:27 INFO - Running main action method: install 05:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:27 INFO - Reading from file tmpfile_stdout 05:26:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:27 INFO - Reading from file tmpfile_stdout 05:26:27 INFO - Output received: 05:26:27 INFO - Usage: mozinstall [options] installer 05:26:27 INFO - Options: 05:26:27 INFO - -h, --help show this help message and exit 05:26:27 INFO - -d DEST, --destination=DEST 05:26:27 INFO - Directory to install application into. [default: 05:26:27 INFO - "/builds/slave/test"] 05:26:27 INFO - --app=APP Application being installed. [default: firefox] 05:26:27 INFO - mkdir: /builds/slave/test/build/application 05:26:27 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'] 05:26:27 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 05:26:44 INFO - Reading from file tmpfile_stdout 05:26:44 INFO - Output received: 05:26:44 INFO - /builds/slave/test/build/application/firefox/firefox 05:26:44 INFO - Running post-action listener: _resource_record_post_action 05:26:44 INFO - ##### 05:26:44 INFO - ##### Finished install step (success) 05:26:44 INFO - ##### 05:26:44 INFO - ##### 05:26:44 INFO - ##### Running run-tests step. 05:26:44 INFO - ##### 05:26:44 INFO - Running pre-action listener: _resource_record_pre_action 05:26:44 INFO - Running main action method: run_tests 05:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:44 INFO - Python 2.7.3 05:26:44 INFO - Return code: 0 05:26:44 INFO - grabbing minidump binary from tooltool 05:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:44 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b9c0>, '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 0x1c3c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:44 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 05:26:44 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 05:26:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:44 INFO - Return code: 0 05:26:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:26:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:26:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:26:45 INFO - Return code: 0 05:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:26:45 INFO - Using env: {'DISPLAY': ':0', 05:26:45 INFO - 'HOME': '/home/cltbld', 05:26:45 INFO - 'LANG': 'en_US.UTF-8', 05:26:45 INFO - 'LANGUAGE': 'en_US:en', 05:26:45 INFO - 'LOGNAME': 'cltbld', 05:26:45 INFO - 'MAIL': '/var/mail/cltbld', 05:26:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:45 INFO - 'MOZ_NO_REMOTE': '1', 05:26:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:45 INFO - 'NO_EM_RESTART': '1', 05:26:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:45 INFO - 'PWD': '/builds/slave/test', 05:26:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:45 INFO - 'SHELL': '/bin/bash', 05:26:45 INFO - 'SHLVL': '1', 05:26:45 INFO - 'TERM': 'linux', 05:26:45 INFO - 'TMOUT': '86400', 05:26:45 INFO - 'USER': 'cltbld', 05:26:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455', 05:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:45 INFO - '_': '/tools/buildbot/bin/python'} 05:26:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:26:45 INFO - mozversion application_buildid: 20160510023016 05:26:45 INFO - mozversion application_changeset: b041ad17b6c87ddf64db984292e95a777fb9959f 05:26:45 INFO - mozversion application_display_name: Nightly 05:26:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:45 INFO - mozversion application_name: Firefox 05:26:45 INFO - mozversion application_remotingname: firefox 05:26:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:26:45 INFO - mozversion application_vendor: Mozilla 05:26:45 INFO - mozversion application_version: 49.0a1 05:26:45 INFO - mozversion platform_buildid: 20160510023016 05:26:45 INFO - mozversion platform_changeset: b041ad17b6c87ddf64db984292e95a777fb9959f 05:26:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:26:45 INFO - mozversion platform_version: 49.0a1 05:26:45 INFO - using testdate: 1462883205 05:26:45 INFO - actual date: 1462883205 05:26:45 INFO - starting webserver on 'localhost:35466' 05:26:45 INFO - SUITE-START | Running 2 tests 05:26:45 INFO - TEST-START | dromaeo_css 05:26:45 INFO - operating with platform_type : linux_ 05:26:45 INFO - Initialising browser for dromaeo_css test... 05:26:45 INFO - TEST-INFO | started process 14061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOofSx/profile http://localhost:35466/getInfo.html) 05:26:50 INFO - PROCESS | 14061 | __metrics Screen width/height:1600/1200 05:26:50 INFO - PROCESS | 14061 | colorDepth:24 05:26:50 INFO - PROCESS | 14061 | Browser inner width/height: 1024/697 05:26:50 INFO - PROCESS | 14061 | __metrics 05:26:51 ERROR - PROCESS | 14061 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:26:52 INFO - TEST-INFO | 14061: exit 0 05:26:52 INFO - Browser initialized. 05:26:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:52 INFO - TEST-INFO | started process 14140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOofSx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:03 INFO - PROCESS | 14140 | RSS: Main: 151408640 05:27:03 INFO - PROCESS | 14140 | 05:27:55 INFO - PROCESS | 14140 | 1462883275147 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] 05:30:03 INFO - PROCESS | 14140 | Cycle 1(1): loaded http://localhost:35466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35466/tests/dromaeo/cssquery-ext.html) 05:30:04 INFO - PROCESS | 14140 | RSS: Main: 255352832 05:30:04 INFO - PROCESS | 14140 | 05:33:06 INFO - PROCESS | 14140 | Cycle 1(1): loaded http://localhost:35466/tests/dromaeo/cssquery-ext.html (next: http://localhost:35466/tests/dromaeo/cssquery-jquery.html) 05:33:07 INFO - PROCESS | 14140 | RSS: Main: 233521152 05:33:07 INFO - PROCESS | 14140 | 05:36:09 INFO - PROCESS | 14140 | Cycle 1(1): loaded http://localhost:35466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35466/tests/dromaeo/cssquery-mootools.html) 05:36:09 INFO - PROCESS | 14140 | RSS: Main: 240746496 05:36:09 INFO - PROCESS | 14140 | 05:39:11 INFO - PROCESS | 14140 | Cycle 1(1): loaded http://localhost:35466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35466/tests/dromaeo/cssquery-prototype.html) 05:39:12 INFO - PROCESS | 14140 | RSS: Main: 233398272 05:39:12 INFO - PROCESS | 14140 | 05:42:14 INFO - PROCESS | 14140 | Cycle 1(1): loaded http://localhost:35466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35466/tests/dromaeo/cssquery-yui.html) 05:42:15 INFO - PROCESS | 14140 | RSS: Main: 219516928 05:42:15 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | Cycle 1(1): loaded http://localhost:35466/tests/dromaeo/cssquery-yui.html (next: http://localhost:35466/tests/dromaeo/cssquery-dojo.html) 05:45:18 INFO - PROCESS | 14140 | RSS: Main: 265875456 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | __start_tp_report 05:45:18 INFO - PROCESS | 14140 | _x_x_mozilla_page_load 05:45:18 INFO - PROCESS | 14140 | _x_x_mozilla_page_load_details 05:45:18 INFO - PROCESS | 14140 | |i|pagename|runs| 05:45:18 INFO - PROCESS | 14140 | |0;dojo.html;3180.522921561766;3193.936121277576;3215.2283451971525;3230.4508233600286;3253.983730081349;5307.363116426034;5329.760160792764;5390.946090539093;5518.310211223597;5548.91676624851;5291.99999999999;5292.550133238679;5333.733313334327;5371.731413429333;5493.395726470085;4827.7586120694;4852.781624826874;4957.380327459067;4995.275685025669;5042.4201216860165;5004.549590536851;5019.14674505335;5050.646454748151;5059.671121377099;5071.1886098224295;4816.470188279286;4849;4862.513748625127;4899.730514821684;4915.827946021872;4865.732384718839;4883.072216278895;4889.657723959324;4900.068986892479;4937.851864444073;4817.807287708488;4861.270809378586;4879.634027447955;4892.192788189945;4935.210366341368;5267.209918512215;5333;5362.35651721792;5420.322459692538;5467.043267428184;5792.073268277098;5804.535637149018;5853.648781073107;5858.12128180772;5858.707064646751;5551.3893471718075;5752.108423194411;5851.210086638334;5903.144044113623;5913.438223368773;5418.810341638024;5543.695096769636;5546.77812887484;5547.916781248285;5550.972245138749;6052.243469566304;6061.242344706911;6072;6072.240969878765;6073.5748497604745;5606.6916319602815;5629.915551266734;5660.490555849911;5771.30744310677;5818.854528636733;5803.680797556175;5817.38917413674;5819.127130930395;5819.73811178498;5855.238818953509;5719.8570035749435;5753.597248192586;5763.85590360236;5765.625234359753;5778.133280007948;5590.133529302964;5680.289963754531;5717.599768016199;5723.5707321950185;5735.799247026334;4383.276759334738;4389.539098394686;4389.802458889358;4392.187445322562;4420.535843736361;3920.0395903003946;3934;3943.4479172915817;3970.047188674755;3975.284448799186;5283.445238250005;5315.548178404802;5315.574754019669;5352.223927530486;5366.651167674088;5733.827985160452;5757.280339957505;5770.422957704196;5774.769009239583;5811;5386.218998245233;5400.243965844785;5406.810761623325;5409.269748583891;5411.485908838654;4700.529947005272;4791.736454494967;4865.051314993542;4865.878353041202;4904.60763138948;5998.880022399528;6002.54980876436;6004.969975150097;6005.669688167192;6008.969955150196;5704.828855134353;5868.735906884115;5889.057750759858;5890.587658864009;5893.499052580579;5914.792982245601;5958.136070269873;6006.249218847644;6050;6055.788047418496;5718.8570285741525;5758.078707406795;5764.07774756037;5764.59647824665;5792.710364481674;5644.971775141098;5755.597108202385;5828.504577110993;5877.235959325431;5883.499902508163;5646.774129034792;5724.484796368347;5726.885462290647;5729.656220626775;5777.335606405317;5691.373948865538;5695.060315047971;5699.6865172414255;5702.230198923092;5710.229119068873;5430.13117901134;5506.174073888948;5577.9442205577425;5588.832335029955;5595.720213989365;5812.3025236971835;5821.068629019336;5821.505172060422;5823.039198532195;5824.271966004249;5618.578606604439;5648.830535083954;5650.745716442852;5654.660720356792;5696.088625819849 05:45:18 INFO - PROCESS | 14140 | |1;ext.html;602.6745557399005;621.4220774679552;642.9003504456809;650.6681592387881;660.6828722213339;31743.841280793593;35300.82349588252;43177.35233971493;44306.55693443065;44384.55615443845;44775.32837007447;44911;45317.546824531746;45384.3192352115;45430.772846135726;8611.138886111401;8759.868601970975;8767.693130740425;8773.341999350043;8793.868091978626;8696.652133914637;8790.956045219766;8796.47221166729;8801.735947921541;8802.559872006406;8827.911720882805;8867.379283450162;8869.822603547926;8880.467171969702;8885.378023538355;8770.035296117421;8809.64761409543;8823.205911467998;8828.911710882872;8829.293656507496;8640;8663.220310172115;8734.475931444134;8737.475751454933;8742.519161446118;41412.58587414148;41524.37713434301;41717.79141104306;41781.79109104465;41899;3528.153243221634;3559.2703495783303;3651.8539258429896;3742.1954279829697;4402.515723270438;31250.53124203139;31544.684553154635;31614.209644758834;31792.04623861288;32030.359392812246;4382.561743825624;4411.139827733593;4412.0955204183065;4440.622547083502;4468.240399132123;315245;316490.9999999977;317964;318889;319462;56497.15254271189;57434.71282643644;57442.425575743706;57474;57504;37005.25989480195;37782;37807.24385512329;39675.60324396719;59238;17773.555661108574;17895.552611184823;17912.641747164984;17942.641147176982;17944.641107177784;13780.10429322091;13859.722805543832;13896.096753710977;13899.930500347433;13904.165750055028;19397.612047758965;19643.60712785736;19691.310804121786;19693.144494048283;19846;7118.359347658736;7121.184098054963;7177.626515537689;7202.171750248684;7249.752576701239;1011.544804837826;1136.891995260449;1137.1414581990543;1154.8267759836092;1180.3567055954525;31925.361492770015;32082;32118.518222226685;32257.838710806296;32389.51415728766;1149.448264832885;1169.3393232823428;1196.6170825335982;1230.39095647655;1240.9379531023412;16760.1619919006;16778.244978975974;17039.659206815795;17065.232064557124;17120.571985700208;433622;437793;439253;439631;439929;58253;58815;58831;58888;58906.70546647325;1338.1235290884485;1400.6568390744128;1436.0665567381286;1456;1457.774045023023;31239.84380078176;32482.187945301557;32636.39786757588;32721.509177362834;33368.33263334768;47979.04041919212;48122.759386202844;48292.27561586649;48360.274595880386;48553.75723121362;328341;329202;329472;329763;648631;28000.439991199655;28322.71677283201;28458.146255612366;29870.863559326826;29920.850395747882;46985.2952205724;47871.5212847881;47988.280175796695;48917;49306.26040609322;39556.40665389964;40329.168728970704;40553;41603.1679366417;41746.58253417427;37389;40162.598374015884;40248.798756006036;41598.16803663849;41929;44521.901008530265;44671.10657786761;45247.095058098;45430.31854522251;46073.30890036719;34284;36519.63480365268;36520.81739591285;37067.44398834074;37573.05482924254;28194.577081343385;28229.43541129207;28441;28533.714662853938;28778.71221287844 05:45:18 INFO - PROCESS | 14140 | |2;jquery.html;388.65603940512636;396.73022344805537;403.3002740245675;405.1774896959173;418.6525184097198;17754.73367899481;19618.313359032436;19618.90190549049;19789.901050494762;20585.69121463179;17554.122293885288;18221.180046897887;18356.632867342647;18705.906470467628;19597.804021959775;5127.7692503837325;5225.555827754626;5271.973640131794;5324.54741346986;5330.253764472977;5120.257562653413;5223.895522089556;5253.238280449333;5283.682979021271;5296.443873393296;5249.711265880375;5282.3925248596515;5285.920711189336;5317.867053323678;5327.840164795062;5170.3795544534705;5281.762320695578;5316.149416093426;5320.334958130234;5321.148616221405;4972.229304457815;5176.430592634807;5195.584353251731;5212.218167274901;5219.060569097561;21723.782762172494;22440.88779556108;22495.212667556556;22851.885740571357;22864.199753008732;2271.261839902022;2497.912573059952;2682.396460796325;2859.6997315281806;3039.316153865385;9980.650677226335;10122.848157277647;10480.371177729285;10489.63286284984;10504.107150892183;1865.2072869030744;1887.9433616991512;1978.910949007298;1994.7107669387858;2099.548597051626;82583.5870820642;86605.56697216537;87543.56228218882;87569.56215218882;87569.56215218946;10654.893451065545;11022.614208502824;11046.392448415414;11113.666590002313;11122.555097795997;15428.460003899809;15515.612109697347;15521.223938803014;15521.922390387976;15557;8199.139090395423;8447.957760211282;8536.658533658585;8620.224179823721;8660.610272537751;8294.668213271521;8363.832723345498;8387.664493420318;8444.61999210037;8467.788305292417;4648.140094082605;4795.424549054136;4854.514548545188;4906.533879281463;4978.228374601942;1968.7834338222783;1985.5333996510808;2000.6298834715333;2005.488600406887;2029.4419034765558;1020.0717347213999;1027.8817935937313;1038.9817978381077;1060.5386656804314;1090.5583238788304;18225.817741822677;18792.248310067444;18874.90562547206;18881.622367552573;19116;1047.643801107627;1064.7604289034905;1065.8454524094118;1101.0365929811414;1112.6606385052476;6347.492200623939;6510.544261901621;6647.567908085959;6732.2931092235585;6877.552959057645;508403;513504;518305;524288;532228;93973;96649;97900;99327.50336248272;99981.50009249907;502.54268615559664;506.09409157608206;508.09812582666063;512.3569919750689;512.912804823181;11475.426228688366;15966.281517331516;16903.492895213163;17027.574310641838;17878.642427151644;29441.263968400963;33727.49408758822;33982.83008584941;35472.11319717028;40111.19777604373;51201.74399127981;52294.47705522896;53713;54402;54848;8415.368847336353;8430.747077587683;8557.700480483154;8566.52884091381;8861.113888611088;9096.363254572116;9168.495732734764;9327.626894924128;9467.905320946702;9878.209743220381;8320.459170153921;8566.357523185661;8739.91260087391;8836.047557198573;9008.062037027918;8758.737237882873;8849;8976.775580610276;8987.19115279628;8992.46045237288;5441.891162176655;6131.540134489842;6827.829304267433;8480.643097104434;8800.943886733632;12729.236245825281;13019.349032548524;13020.153690010118;13072.346382681018;13176.60470185896;12456.813147802972;12661.366931653565;12668.239905605693;12723.236605803311;12875.227486350848 05:45:18 INFO - PROCESS | 14140 | |3;mootools.html;1381.316248457014;1542.8631345586364;1542.9959255731376;1686.5024817678784;1870.728744332071;8002.479838810481;8391.538465384401;8415.621297041633;8641.135886411355;8642.827143457127;8465.78835529112;8643.74068777936;8649.048604653482;8663.783405414868;8675.392722509427;1927.7493925789697;2094.3298144593737;2181.334692918659;2193.6819161221615;2217.811486023682;2098.055874856313;2107.4099252209407;2107.620628286908;2115.471132216946;2119.4807272218327;2102.2536999365234;2211.535577528713;2215.6233440315186;2217.7116974793335;2219.212179676216;1886.1795119123158;2125.436759258798;2194.0784870354328;2196.560687862434;2218.9556208875892;2054.1269960266827;2102.978970210309;2153.6446486329737;2159.8164156046755;2162.4918144236094;8668.133186681345;8728.825423491495;8753.912460875374;8766.254868336198;8778.736637900809;5046.848594542133;5160.12277912752;5204.42751297357;5206.583473322125;5209.296744939423;3199.3281410903737;3243.9837800810847;3264.9183770405693;3290.7367410607094;3367.663233676613;1015.5836107196014;1043.7599352149048;1049.3284298049255;1055.5250137438106;1062.3360399750156;12001.879981200163;12124.272543647321;12128.696782580419;12130.878691213064;12158.027357811265;4475.149721552894;4540.477845047796;4554.180247555471;4602.953970460252;4641;10129.848052279222;10147.188224941987;10148.03593658616;10148.086672199537;10164.4917754112;4661.766911654471;5174.534291913746;5181.171012638035;5194.584433245332;5202.791888324425;4619.838305659286;4734.715917044989;4748.976255118702;4777.426708794897;4784.067106914188;3876;3897.1621101462756;3980.3233450313514;3985.183037477368;4029.7179197456485;1227.4108427954454;1270.0791925853682;1276.5149243287492;1284.7045179608556;1287.7875150600235;789.2186735132293;914.6661468563926;931.5761328595473;940.9978373032699;949.1078386316979;5169.767360468788;5206.140986737146;5299.814506492331;5317.548008419328;5482.616216864782;401.10153256705354;401.7328476563053;402.02308390611097;402.5974025974026;407.4194273160734;3708.295423869456;3854.4603755474254;3954.723169378116;3968.543617484026;3997.400389941474;10437.739056523496;10779.892201078046;10898.564057437772;10933.617323393642;10938;10107.898921010696;10648.307859989076;10789.892101079045;10809.297395669257;10856.240063195659;7982.920170798334;8048.839023219502;8117.837643247102;8159.816826560115;8212;5447.346318441812;5709.172170035238;5729.684867332337;5733.684647344269;5784.479396854304;9852.704418867446;9940.304178707422;9981.251406144424;9993.900060999296;10102.292839501459;9901;10170.593176272867;10231.334963227366;10249.12882405004;10270.743231419274;6754.5947243165565;6941.930580694128;6944.027836102849;7671.309582137635;7795.727149549739;7870.84258314819;8095.797605059921;8380.371472139492;8393;8700.347473939353;7683.346915512244;7748.418868584766;7764.844703105793;7785.377169826514;8013.879791803244;7438.070241219848;7497.475176737576;7527.924720752722;7608.163102058658;7660.846783064196;7232.674529646073;7235.421166306577;7293.890591641023;7301.342879140902;7301.379382752525;4552.817887284604;4717.858464246078;4792;4835.395575553056;4904.8773780655765;4623.989312383484;4632.675712700078;4704.788284527273;4713.552212539803;4745.264484004984 05:45:18 INFO - PROCESS | 14140 | |4;prototype.html;320.7498151441876;332.9417351963406;333.4314992937041;335.7465113839051;340.5147664577976;5286.814961476349;5294.285271488348;5325.121354976429;5336.359636843579;5378.489043540867;5300.125479295912;5303.390110137326;5308.654937429064;5319;5320.122179840331;3950.4074388841686;3975.522937247534;4144.523379811315;4166.166766646667;4181.121964387482;4127.4934648853105;4131.442255295527;4161.25097482453;4162.687798415116;4163.20899029185;3916.725829191958;4124.484439445069;4125.525564560069;4133.400656904762;4136.97931510342;4006.519217693881;4087.4277601135864;4113;4115.279826030448;4117.3206420940805;3626.8367923443507;3627.2382799612114;3636.3636363636256;3650.8357123929486;3661.9633803662155;5005.724685142316;5026.924596131061;5043.344365232533;5086.4659210783075;5127.282180494733;4561.354414439617;4723.669343145981;4753.239481682914;4755.692184649214;4759.690620109716;5442.700651464168;5505.394406615269;5505.724713764296;5513.531349835269;5531.9723401383135;3743.5320584926885;3901.614926701037;4051.2505186540584;4056.858009969637;4057.6145266199665;5661.264035675335;5663.688497132656;5667.886642267132;5752.424757524256;5773.278340207474;4009.3384591542067;4016.859409920639;4027.476428064333;4029.6574791142493;4031.576684448091;3849.538055433366;4046.7976601169826;4047.5750046245307;4066.6949978751713;4071.8371265149653;4640.723800954765;4651.744154071491;4658.114958157939;4668.883277918079;4671.505118362092;5504.394516603171;5516.475934786189;5520.282363292827;5535.391106978229;5566.6381685191145;1330.2683524061727;1344.636948024028;1347.9797803032961;1369.6918193406602;1378.1455497591558;861.4745005546612;931.1293940165966;935;948.9335746497817;951.1392190068;5077.619178561623;5086.92369614456;5105.591552675777;5106.66806657566;5147.922781158286;5406.297181366476;5424.965637885793;5433.962264150943;5434.456554344613;5446.972765136149;4959.70241785494;5082.059818933509;5117.309163262987;5121.8463446096675;5128.487096306599;2879.1650421377567;2891.26524085547;2892.5950366948646;2913.994671838255;2938.67674555803;5435.320584926884;5597;5601.507329238531;5608.186812912187;5615.803446879339;5355.812546560929;5425;5438.238646589481;5493.395726470085;5547.33431988164;5552.555795536347;5565.217391304348;5587.916181257285;5592.762894842096;5595.776168953359;5246.31797866275;5424.810131645373;5441.129419293053;5457.645253058538;5695.715214239189;5631.7184140793615;5646.85882852932;5650.434956504317;5651.237082993744;5667.3765885753355;5818.185454036354;5819.592628515963;5854.180414741854;5863.355030946678;5864.706764661664;3801.3157631626573;3951.446797448302;4035.7376770510996;4076.3274059779806;4077.959220407758;5632.211490391266;5635.380108188178;5644.633098848726;5664.688442135722;5665.348484924287;5490.3411590609385;5498.927709096688;5506.119020956788;5512.862178445571;5520.779168833202;5293.894122117613;5500.669959802264;5515.917261241165;5526.530244929226;5554.6944918028275;5208.166693329049;5251.608323794274;5373.898350838147;5414.539764120094;5467.945320546903;5495.5878309127775;5527.391986881359;5576.749046293007;5619.634723742944;5629.859253518531;5435.918461223164;5451.918221226605;5452.700101494456;5455.618106732491;5464.699441530595 05:45:18 INFO - PROCESS | 14140 | |5;yui.html;760.5930827007551;777.5615112042719;856.910024447433;875.2472873328932;879.4986857491233;12649.430775615096;13843.930780346096;14038.859611403883;14065.437382504688;14101.365438555276;12794.616161515169;12857.228566286007;12863.228206307627;12941.223526588388;12949.805752913713;696.6064173741845;811.5577010529275;814.2997022560608;829.3489610655637;838.2246422059601;820.0774129104757;820.8604537228686;823.518241828531;824.5464994253167;824.5794644731201;883.9337049721264;885.5970533407284;888.1828717579842;889.7419748272993;889.9777505562348;736.5948728199496;863.369740089738;879.8768172455862;880.6257340630207;883.3639779358883;646.3116780628616;647.8250872264463;647.9384458476437;648.3548868875451;648.5168549430705;12933.288669123194;12939.094263401566;12948.093633445662;12957.157784743962;12977.675558111028;13557.661058473519;14094.718105637932;14096.859031409656;14137.929310353486;14173.43306267748;12140;12266.202696824677;12325.815112773316;12583.119181657288;12611.495540178383;4448.755318457484;4564.42944631921;4641.582257596799;4666.160091183586;4690.859274221779;55804.72097639526;56746;56809.14786278209;56812.71593642046;57176.14235786508;10911.945440272748;11005.944970275097;11071;11172.664820055248;11199.21605487608;20101.39695809128;20170;20211.090500927494;20228.089735961916;20229.19083236654;7681.231876812274;8065.072516660542;8091.393145513992;8287.171282871665;8698.695545655872;4632.050429661911;4733.810647574059;4841.975790121027;4842.5157484251295;4850.975745121252;3190.6809319067906;3229.628592711821;3277.3772983133126;3287.917802054968;3294.8352582370785;615.3538784276492;626.5019309648749;628.915096461981;638.4317957018258;645.1258544671996;639.7760783725658;648.5168549430705;649.6978904809287;650.1807722269974;655.2431941108027;8001.199880011952;8294.502329860228;8369.204925532065;8513.702020429255;8531.914680853111;652.2215362555547;685.9691313890887;691.4122995453824;702.6737331030774;708.7235977968596;3775.1505911170316;3843.442700808367;3859.1702783901596;3874.9225015499533;3881.6700580450415;57972.71013644989;63050.369496305364;63391;63401.68299158475;63486.33393493709;25454.363640909127;54158.72920635372;54897;55675.72162139163;57729;49446.50553494419;50083.24875126876;50290.74854625777;50620.49379506231;51134.23298650523;7472;7535.6985720570565;7577.886331704918;7611.847763044819;7668.80827979305;32105.518417224226;32478.35043299168;32835.50746738849;33615.15962100967;33619;39892.60107398889;41919;42310.153796923274;43727.78136109299;47597.52402475931;12648.620541383772;12810.615681529569;12855.29295888735;12876.484940602271;13117.278549679859;10158.441285729356;13207.528410503079;14362.13827170373;14993.550193494213;15020.7746883799;13233.3383330835;14079.577612671636;14200.928995354958;14211.715765684836;14473.203973781543;13154.276514791778;13710.108842925178;13849.376778045214;13873;14352.138871667734;13283.601491955256;13599.932000339935;13600.591982240549;14052.508162214273;14079.0848594841;10815.134789216687;10892.61875834342;10968.616098436516;11154.776904462027;11164;10758.17941559259;10930.180236482454;11001.504932277907;11052.723681908017;11202.103831693608 05:45:18 INFO - PROCESS | 14140 | __end_tp_report 05:45:18 INFO - PROCESS | 14140 | __start_cc_report 05:45:18 INFO - PROCESS | 14140 | _x_x_mozilla_cycle_collect,849 05:45:18 INFO - PROCESS | 14140 | __end_cc_report 05:45:18 INFO - PROCESS | 14140 | __startTimestamp1462884318602__endTimestamp 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | ------- Summary: start ------- 05:45:18 INFO - PROCESS | 14140 | Number of tests: 6 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | [#0] dojo.html Cycles:165 Average:5383.96 Median:5606.69 stddev:618.62 (11.0%) stddev-sans-first:595.87 05:45:18 INFO - PROCESS | 14140 | Values: 3180.5 3193.9 3215.2 3230.5 3254.0 5307.4 5329.8 5390.9 5518.3 5548.9 5292.0 5292.6 5333.7 5371.7 5493.4 4827.8 4852.8 4957.4 4995.3 5042.4 5004.5 5019.1 5050.6 5059.7 5071.2 4816.5 4849.0 4862.5 4899.7 4915.8 4865.7 4883.1 4889.7 4900.1 4937.9 4817.8 4861.3 4879.6 4892.2 4935.2 5267.2 5333.0 5362.4 5420.3 5467.0 5792.1 5804.5 5853.6 5858.1 5858.7 5551.4 5752.1 5851.2 5903.1 5913.4 5418.8 5543.7 5546.8 5547.9 5551.0 6052.2 6061.2 6072.0 6072.2 6073.6 5606.7 5629.9 5660.5 5771.3 5818.9 5803.7 5817.4 5819.1 5819.7 5855.2 5719.9 5753.6 5763.9 5765.6 5778.1 5590.1 5680.3 5717.6 5723.6 5735.8 4383.3 4389.5 4389.8 4392.2 4420.5 3920.0 3934.0 3943.4 3970.0 3975.3 5283.4 5315.5 5315.6 5352.2 5366.7 5733.8 5757.3 5770.4 5774.8 5811.0 5386.2 5400.2 5406.8 5409.3 5411.5 4700.5 4791.7 4865.1 4865.9 4904.6 5998.9 6002.5 6005.0 6005.7 6009.0 5704.8 5868.7 5889.1 5890.6 5893.5 5914.8 5958.1 6006.2 6050.0 6055.8 5718.9 5758.1 5764.1 5764.6 5792.7 5645.0 5755.6 5828.5 5877.2 5883.5 5646.8 5724.5 5726.9 5729.7 5777.3 5691.4 5695.1 5699.7 5702.2 5710.2 5430.1 5506.2 5577.9 5588.8 5595.7 5812.3 5821.1 5821.5 5823.0 5824.3 5618.6 5648.8 5650.7 5654.7 5696.1 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | [#1] ext.html Cycles:180 Average:54955.59 Median:41468.48 stddev:103913.59 (250.6%) stddev-sans-first:104124.96 05:45:18 INFO - PROCESS | 14140 | Values: 602.7 621.4 642.9 650.7 660.7 31743.8 35300.8 43177.4 44306.6 44384.6 44775.3 44911.0 45317.5 45384.3 45430.8 8611.1 8759.9 8767.7 8773.3 8793.9 8696.7 8791.0 8796.5 8801.7 8802.6 8827.9 8867.4 8869.8 8880.5 8885.4 8770.0 8809.6 8823.2 8828.9 8829.3 8640.0 8663.2 8734.5 8737.5 8742.5 41412.6 41524.4 41717.8 41781.8 41899.0 3528.2 3559.3 3651.9 3742.2 4402.5 31250.5 31544.7 31614.2 31792.0 32030.4 4382.6 4411.1 4412.1 4440.6 4468.2 315245.0 316491.0 317964.0 318889.0 319462.0 56497.2 57434.7 57442.4 57474.0 57504.0 37005.3 37782.0 37807.2 39675.6 59238.0 17773.6 17895.6 17912.6 17942.6 17944.6 13780.1 13859.7 13896.1 13899.9 13904.2 19397.6 19643.6 19691.3 19693.1 19846.0 7118.4 7121.2 7177.6 7202.2 7249.8 1011.5 1136.9 1137.1 1154.8 1180.4 31925.4 32082.0 32118.5 32257.8 32389.5 1149.4 1169.3 1196.6 1230.4 1240.9 16760.2 16778.2 17039.7 17065.2 17120.6 433622.0 437793.0 439253.0 439631.0 439929.0 58253.0 58815.0 58831.0 58888.0 58906.7 1338.1 1400.7 1436.1 1456.0 1457.8 31239.8 32482.2 32636.4 32721.5 33368.3 47979.0 48122.8 48292.3 48360.3 48553.8 328341.0 329202.0 329472.0 329763.0 648631.0 28000.4 28322.7 28458.1 29870.9 29920.9 46985.3 47871.5 47988.3 48917.0 49306.3 39556.4 40329.2 40553.0 41603.2 41746.6 37389.0 40162.6 40248.8 41598.2 41929.0 44521.9 44671.1 45247.1 45430.3 46073.3 34284.0 36519.6 36520.8 37067.4 37573.1 28194.6 28229.4 28441.0 28533.7 28778.7 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | [#2] jquery.html Cycles:180 Average:29322.77 Median:504.32 stddev:85749.94 (17003.1%) stddev-sans-first:85962.96 05:45:18 INFO - PROCESS | 14140 | Values: 388.7 396.7 403.3 405.2 418.7 17754.7 19618.3 19618.9 19789.9 20585.7 17554.1 18221.2 18356.6 18705.9 19597.8 5127.8 5225.6 5272.0 5324.5 5330.3 5120.3 5223.9 5253.2 5283.7 5296.4 5249.7 5282.4 5285.9 5317.9 5327.8 5170.4 5281.8 5316.1 5320.3 5321.1 4972.2 5176.4 5195.6 5212.2 5219.1 21723.8 22440.9 22495.2 22851.9 22864.2 2271.3 2497.9 2682.4 2859.7 3039.3 9980.7 10122.8 10480.4 10489.6 10504.1 1865.2 1887.9 1978.9 1994.7 2099.5 82583.6 86605.6 87543.6 87569.6 87569.6 10654.9 11022.6 11046.4 11113.7 11122.6 15428.5 15515.6 15521.2 15521.9 15557.0 8199.1 8448.0 8536.7 8620.2 8660.6 8294.7 8363.8 8387.7 8444.6 8467.8 4648.1 4795.4 4854.5 4906.5 4978.2 1968.8 1985.5 2000.6 2005.5 2029.4 1020.1 1027.9 1039.0 1060.5 1090.6 18225.8 18792.2 18874.9 18881.6 19116.0 1047.6 1064.8 1065.8 1101.0 1112.7 6347.5 6510.5 6647.6 6732.3 6877.6 508403.0 513504.0 518305.0 524288.0 532228.0 93973.0 96649.0 97900.0 99327.5 99981.5 502.5 506.1 508.1 512.4 512.9 11475.4 15966.3 16903.5 17027.6 17878.6 29441.3 33727.5 33982.8 35472.1 40111.2 51201.7 52294.5 53713.0 54402.0 54848.0 8415.4 8430.7 8557.7 8566.5 8861.1 9096.4 9168.5 9327.6 9467.9 9878.2 8320.5 8566.4 8739.9 8836.0 9008.1 8758.7 8849.0 8976.8 8987.2 8992.5 5441.9 6131.5 6827.8 8480.6 8800.9 12729.2 13019.3 13020.2 13072.3 13176.6 12456.8 12661.4 12668.2 12723.2 12875.2 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | [#3] mootools.html Cycles:180 Average:5634.38 Median:4621.91 stddev:3300.72 (71.4%) stddev-sans-first:3294.50 05:45:18 INFO - PROCESS | 14140 | Values: 1381.3 1542.9 1543.0 1686.5 1870.7 8002.5 8391.5 8415.6 8641.1 8642.8 8465.8 8643.7 8649.0 8663.8 8675.4 1927.7 2094.3 2181.3 2193.7 2217.8 2098.1 2107.4 2107.6 2115.5 2119.5 2102.3 2211.5 2215.6 2217.7 2219.2 1886.2 2125.4 2194.1 2196.6 2219.0 2054.1 2103.0 2153.6 2159.8 2162.5 8668.1 8728.8 8753.9 8766.3 8778.7 5046.8 5160.1 5204.4 5206.6 5209.3 3199.3 3244.0 3264.9 3290.7 3367.7 1015.6 1043.8 1049.3 1055.5 1062.3 12001.9 12124.3 12128.7 12130.9 12158.0 4475.1 4540.5 4554.2 4603.0 4641.0 10129.8 10147.2 10148.0 10148.1 10164.5 4661.8 5174.5 5181.2 5194.6 5202.8 4619.8 4734.7 4749.0 4777.4 4784.1 3876.0 3897.2 3980.3 3985.2 4029.7 1227.4 1270.1 1276.5 1284.7 1287.8 789.2 914.7 931.6 941.0 949.1 5169.8 5206.1 5299.8 5317.5 5482.6 401.1 401.7 402.0 402.6 407.4 3708.3 3854.5 3954.7 3968.5 3997.4 10437.7 10779.9 10898.6 10933.6 10938.0 10107.9 10648.3 10789.9 10809.3 10856.2 7982.9 8048.8 8117.8 8159.8 8212.0 5447.3 5709.2 5729.7 5733.7 5784.5 9852.7 9940.3 9981.3 9993.9 10102.3 9901.0 10170.6 10231.3 10249.1 10270.7 6754.6 6941.9 6944.0 7671.3 7795.7 7870.8 8095.8 8380.4 8393.0 8700.3 7683.3 7748.4 7764.8 7785.4 8013.9 7438.1 7497.5 7527.9 7608.2 7660.8 7232.7 7235.4 7293.9 7301.3 7301.4 4552.8 4717.9 4792.0 4835.4 4904.9 4624.0 4632.7 4704.8 4713.6 4745.3 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | [#4] prototype.html Cycles:180 Average:4597.53 Median:5297.21 stddev:1345.95 (25.4%) stddev-sans-first:1310.89 05:45:18 INFO - PROCESS | 14140 | Values: 320.7 332.9 333.4 335.7 340.5 5286.8 5294.3 5325.1 5336.4 5378.5 5300.1 5303.4 5308.7 5319.0 5320.1 3950.4 3975.5 4144.5 4166.2 4181.1 4127.5 4131.4 4161.3 4162.7 4163.2 3916.7 4124.5 4125.5 4133.4 4137.0 4006.5 4087.4 4113.0 4115.3 4117.3 3626.8 3627.2 3636.4 3650.8 3662.0 5005.7 5026.9 5043.3 5086.5 5127.3 4561.4 4723.7 4753.2 4755.7 4759.7 5442.7 5505.4 5505.7 5513.5 5532.0 3743.5 3901.6 4051.3 4056.9 4057.6 5661.3 5663.7 5667.9 5752.4 5773.3 4009.3 4016.9 4027.5 4029.7 4031.6 3849.5 4046.8 4047.6 4066.7 4071.8 4640.7 4651.7 4658.1 4668.9 4671.5 5504.4 5516.5 5520.3 5535.4 5566.6 1330.3 1344.6 1348.0 1369.7 1378.1 861.5 931.1 935.0 948.9 951.1 5077.6 5086.9 5105.6 5106.7 5147.9 5406.3 5425.0 5434.0 5434.5 5447.0 4959.7 5082.1 5117.3 5121.8 5128.5 2879.2 2891.3 2892.6 2914.0 2938.7 5435.3 5597.0 5601.5 5608.2 5615.8 5355.8 5425.0 5438.2 5493.4 5547.3 5552.6 5565.2 5587.9 5592.8 5595.8 5246.3 5424.8 5441.1 5457.6 5695.7 5631.7 5646.9 5650.4 5651.2 5667.4 5818.2 5819.6 5854.2 5863.4 5864.7 3801.3 3951.4 4035.7 4076.3 4078.0 5632.2 5635.4 5644.6 5664.7 5665.3 5490.3 5498.9 5506.1 5512.9 5520.8 5293.9 5500.7 5515.9 5526.5 5554.7 5208.2 5251.6 5373.9 5414.5 5467.9 5495.6 5527.4 5576.7 5619.6 5629.9 5435.9 5451.9 5452.7 5455.6 5464.7 05:45:18 INFO - PROCESS | 14140 | 05:45:18 INFO - PROCESS | 14140 | [#5] yui.html Cycles:180 Average:14705.41 Median:4506.59 stddev:16907.85 (375.2%) stddev-sans-first:16922.85 05:45:18 INFO - PROCESS | 14140 | Values: 760.6 777.6 856.9 875.2 879.5 12649.4 13843.9 14038.9 14065.4 14101.4 12794.6 12857.2 12863.2 12941.2 12949.8 696.6 811.6 814.3 829.3 838.2 820.1 820.9 823.5 824.5 824.6 883.9 885.6 888.2 889.7 890.0 736.6 863.4 879.9 880.6 883.4 646.3 647.8 647.9 648.4 648.5 12933.3 12939.1 12948.1 12957.2 12977.7 13557.7 14094.7 14096.9 14137.9 14173.4 12140.0 12266.2 12325.8 12583.1 12611.5 4448.8 4564.4 4641.6 4666.2 4690.9 55804.7 56746.0 56809.1 56812.7 57176.1 10911.9 11005.9 11071.0 11172.7 11199.2 20101.4 20170.0 20211.1 20228.1 20229.2 7681.2 8065.1 8091.4 8287.2 8698.7 4632.1 4733.8 4842.0 4842.5 4851.0 3190.7 3229.6 3277.4 3287.9 3294.8 615.4 626.5 628.9 638.4 645.1 639.8 648.5 649.7 650.2 655.2 8001.2 8294.5 8369.2 8513.7 8531.9 652.2 686.0 691.4 702.7 708.7 3775.2 3843.4 3859.2 3874.9 3881.7 57972.7 63050.4 63391.0 63401.7 63486.3 25454.4 54158.7 54897.0 55675.7 57729.0 49446.5 50083.2 50290.7 50620.5 51134.2 7472.0 7535.7 7577.9 7611.8 7668.8 32105.5 32478.4 32835.5 33615.2 33619.0 39892.6 41919.0 42310.2 43727.8 47597.5 12648.6 12810.6 12855.3 12876.5 13117.3 10158.4 13207.5 14362.1 14993.6 15020.8 13233.3 14079.6 14200.9 14211.7 14473.2 13154.3 13710.1 13849.4 13873.0 14352.1 13283.6 13599.9 13600.6 14052.5 14079.1 10815.1 10892.6 10968.6 11154.8 11164.0 10758.2 10930.2 11001.5 11052.7 11202.1 05:45:18 INFO - PROCESS | 14140 | -------- Summary: end -------- 05:45:18 INFO - PROCESS | 14140 | 05:45:19 INFO - TEST-INFO | 14140: exit 0 05:45:19 INFO - TEST-OK | dromaeo_css | took 1113604ms 05:45:19 INFO - TEST-START | kraken 05:45:19 INFO - operating with platform_type : linux_ 05:45:19 INFO - Initialising browser for kraken test... 05:45:19 INFO - TEST-INFO | started process 14323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsiSKh/profile http://localhost:35466/getInfo.html) 05:45:23 INFO - PROCESS | 14323 | __metrics Screen width/height:1600/1200 05:45:23 INFO - PROCESS | 14323 | colorDepth:24 05:45:23 INFO - PROCESS | 14323 | Browser inner width/height: 1024/697 05:45:23 INFO - PROCESS | 14323 | __metrics 05:45:24 ERROR - PROCESS | 14323 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:45:25 INFO - TEST-INFO | 14323: exit 0 05:45:25 INFO - Browser initialized. 05:45:25 INFO - Running cycle 1/1 for kraken test... 05:45:25 INFO - TEST-INFO | started process 14405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsiSKh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:37 INFO - PROCESS | 14405 | RSS: Main: 151977984 05:45:37 INFO - PROCESS | 14405 | 05:45:39 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35466/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:40 INFO - PROCESS | 14405 | RSS: Main: 208142336 05:45:40 INFO - PROCESS | 14405 | 05:45:43 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35466/tests/kraken/driver.html?testName=audio-dft) 05:45:44 INFO - PROCESS | 14405 | RSS: Main: 196984832 05:45:44 INFO - PROCESS | 14405 | 05:45:47 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35466/tests/kraken/driver.html?testName=audio-fft) 05:45:47 INFO - PROCESS | 14405 | RSS: Main: 265191424 05:45:47 INFO - PROCESS | 14405 | 05:45:50 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35466/tests/kraken/driver.html?testName=audio-oscillator) 05:45:50 INFO - PROCESS | 14405 | RSS: Main: 173731840 05:45:50 INFO - PROCESS | 14405 | 05:45:53 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:53 INFO - PROCESS | 14405 | RSS: Main: 177827840 05:45:53 INFO - PROCESS | 14405 | 05:45:56 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35466/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:57 INFO - PROCESS | 14405 | RSS: Main: 214167552 05:45:57 INFO - PROCESS | 14405 | 05:46:00 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35466/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:01 INFO - PROCESS | 14405 | RSS: Main: 212344832 05:46:01 INFO - PROCESS | 14405 | 05:46:04 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35466/tests/kraken/driver.html?testName=json-parse-financial) 05:46:05 INFO - PROCESS | 14405 | RSS: Main: 213504000 05:46:05 INFO - PROCESS | 14405 | 05:46:06 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:07 INFO - PROCESS | 14405 | RSS: Main: 202919936 05:46:07 INFO - PROCESS | 14405 | 05:46:09 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:09 INFO - PROCESS | 14405 | RSS: Main: 206077952 05:46:09 INFO - PROCESS | 14405 | 05:46:11 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:12 INFO - PROCESS | 14405 | RSS: Main: 215302144 05:46:12 INFO - PROCESS | 14405 | 05:46:15 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:15 INFO - PROCESS | 14405 | RSS: Main: 220205056 05:46:15 INFO - PROCESS | 14405 | 05:46:18 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:19 INFO - PROCESS | 14405 | RSS: Main: 220258304 05:46:19 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:35466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35466/tests/kraken/driver.html?testName=ai-astar) 05:46:21 INFO - PROCESS | 14405 | RSS: Main: 265469952 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | __start_tp_report 05:46:21 INFO - PROCESS | 14405 | _x_x_mozilla_page_load 05:46:21 INFO - PROCESS | 14405 | _x_x_mozilla_page_load_details 05:46:21 INFO - PROCESS | 14405 | |i|pagename|runs| 05:46:21 INFO - PROCESS | 14405 | |0;ai-astar;112;106;112;110;110;110;110;109;110;109 05:46:21 INFO - PROCESS | 14405 | |1;audio-beat-detection;156;132;151;208;126;162;151;126;191;125 05:46:21 INFO - PROCESS | 14405 | |2;audio-dft;161;158;160;160;159;160;165;160;161;162 05:46:21 INFO - PROCESS | 14405 | |3;audio-fft;75;76;75;163;76;76;77;76;135;75 05:46:21 INFO - PROCESS | 14405 | |4;audio-oscillator;91;92;158;91;99;91;125;92;91;126 05:46:21 INFO - PROCESS | 14405 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:46:21 INFO - PROCESS | 14405 | |6;imaging-darkroom;146;145;146;146;145;145;146;145;145;145 05:46:21 INFO - PROCESS | 14405 | |7;imaging-desaturate;95;97;95;95;95;95;95;94;95;95 05:46:21 INFO - PROCESS | 14405 | |8;json-parse-financial;58;58;57;57;58;56;61;110;55;55 05:46:21 INFO - PROCESS | 14405 | |9;json-stringify-tinderbox;58;58;58;58;59;58;59;58;59;59 05:46:21 INFO - PROCESS | 14405 | |10;stanford-crypto-aes;87;80;79;79;80;80;88;82;88;80 05:46:21 INFO - PROCESS | 14405 | |11;stanford-crypto-ccm;125;125;136;126;122;127;122;122;232;134 05:46:21 INFO - PROCESS | 14405 | |12;stanford-crypto-pbkdf2;167;172;168;167;169;171;172;171;171;171 05:46:21 INFO - PROCESS | 14405 | |13;stanford-crypto-sha256-iterative;64;72;66;65;66;64;64;64;63;64 05:46:21 INFO - PROCESS | 14405 | __end_tp_report 05:46:21 INFO - PROCESS | 14405 | __start_cc_report 05:46:21 INFO - PROCESS | 14405 | _x_x_mozilla_cycle_collect,1848 05:46:21 INFO - PROCESS | 14405 | __end_cc_report 05:46:21 INFO - PROCESS | 14405 | __startTimestamp1462884381395__endTimestamp 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | ------- Summary: start ------- 05:46:21 INFO - PROCESS | 14405 | Number of tests: 14 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.69 (1.5%) stddev-sans-first:1.59 05:46:21 INFO - PROCESS | 14405 | Values: 112.0 106.0 112.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:153.50 stddev:28.38 (18.5%) stddev-sans-first:30.08 05:46:21 INFO - PROCESS | 14405 | Values: 156.0 132.0 151.0 208.0 126.0 162.0 151.0 126.0 191.0 125.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 05:46:21 INFO - PROCESS | 14405 | Values: 161.0 158.0 160.0 160.0 159.0 160.0 165.0 160.0 161.0 162.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#3] audio-fft Cycles:10 Average:90.40 Median:76.00 stddev:31.59 (41.6%) stddev-sans-first:33.01 05:46:21 INFO - PROCESS | 14405 | Values: 75.0 76.0 75.0 163.0 76.0 76.0 77.0 76.0 135.0 75.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:91.00 stddev:23.10 (25.4%) stddev-sans-first:23.89 05:46:21 INFO - PROCESS | 14405 | Values: 91.0 92.0 158.0 91.0 99.0 91.0 125.0 92.0 91.0 126.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:46:21 INFO - PROCESS | 14405 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:46:21 INFO - PROCESS | 14405 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:46:21 INFO - PROCESS | 14405 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:57.50 stddev:16.78 (29.2%) stddev-sans-first:17.72 05:46:21 INFO - PROCESS | 14405 | Values: 58.0 58.0 57.0 57.0 58.0 56.0 61.0 110.0 55.0 55.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 05:46:21 INFO - PROCESS | 14405 | Values: 58.0 58.0 58.0 58.0 59.0 58.0 59.0 58.0 59.0 59.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:3.80 (4.7%) stddev-sans-first:3.63 05:46:21 INFO - PROCESS | 14405 | Values: 87.0 80.0 79.0 79.0 80.0 80.0 88.0 82.0 88.0 80.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:126.50 stddev:33.70 (26.6%) stddev-sans-first:35.45 05:46:21 INFO - PROCESS | 14405 | Values: 125.0 125.0 136.0 126.0 122.0 127.0 122.0 122.0 232.0 134.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:171.00 stddev:1.97 (1.2%) stddev-sans-first:1.79 05:46:21 INFO - PROCESS | 14405 | Values: 167.0 172.0 168.0 167.0 169.0 171.0 172.0 171.0 171.0 171.0 05:46:21 INFO - PROCESS | 14405 | 05:46:21 INFO - PROCESS | 14405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:2.57 (4.0%) stddev-sans-first:2.69 05:46:21 INFO - PROCESS | 14405 | Values: 64.0 72.0 66.0 65.0 66.0 64.0 64.0 64.0 63.0 64.0 05:46:21 INFO - PROCESS | 14405 | -------- Summary: end -------- 05:46:21 INFO - PROCESS | 14405 | 05:46:22 INFO - TEST-INFO | 14405: exit 0 05:46:22 INFO - TEST-OK | kraken | took 63000ms 05:46:22 INFO - SUITE-END | took 1176s 05:46:22 INFO - Completed test suite (00:19:36) 05:46:22 INFO - javascript benchmark 05:46:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3180.522921561766, 3193.936121277576, 3215.2283451971525, 3230.4508233600286, 3253.983730081349, 5307.363116426034, 5329.760160792764, 5390.946090539093, 5518.310211223597, 5548.91676624851, 5291.99999999999, 5292.550133238679, 5333.733313334327, 5371.731413429333, 5493.395726470085, 4827.7586120694, 4852.781624826874, 4957.380327459067, 4995.275685025669, 5042.4201216860165, 5004.549590536851, 5019.14674505335, 5050.646454748151, 5059.671121377099, 5071.1886098224295, 4816.470188279286, 4849.0, 4862.513748625127, 4899.730514821684, 4915.827946021872, 4865.732384718839, 4883.072216278895, 4889.657723959324, 4900.068986892479, 4937.851864444073, 4817.807287708488, 4861.270809378586, 4879.634027447955, 4892.192788189945, 4935.210366341368, 5267.209918512215, 5333.0, 5362.35651721792, 5420.322459692538, 5467.043267428184, 5792.073268277098, 5804.535637149018, 5853.648781073107, 5858.12128180772, 5858.707064646751, 5551.3893471718075, 5752.108423194411, 5851.210086638334, 5903.144044113623, 5913.438223368773, 5418.810341638024, 5543.695096769636, 5546.77812887484, 5547.916781248285, 5550.972245138749, 6052.243469566304, 6061.242344706911, 6072.0, 6072.240969878765, 6073.5748497604745, 5606.6916319602815, 5629.915551266734, 5660.490555849911, 5771.30744310677, 5818.854528636733, 5803.680797556175, 5817.38917413674, 5819.127130930395, 5819.73811178498, 5855.238818953509, 5719.8570035749435, 5753.597248192586, 5763.85590360236, 5765.625234359753, 5778.133280007948, 5590.133529302964, 5680.289963754531, 5717.599768016199, 5723.5707321950185, 5735.799247026334, 4383.276759334738, 4389.539098394686, 4389.802458889358, 4392.187445322562, 4420.535843736361, 3920.0395903003946, 3934.0, 3943.4479172915817, 3970.047188674755, 3975.284448799186, 5283.445238250005, 5315.548178404802, 5315.574754019669, 5352.223927530486, 5366.651167674088, 5733.827985160452, 5757.280339957505, 5770.422957704196, 5774.769009239583, 5811.0, 5386.218998245233, 5400.243965844785, 5406.810761623325, 5409.269748583891, 5411.485908838654, 4700.529947005272, 4791.736454494967, 4865.051314993542, 4865.878353041202, 4904.60763138948, 5998.880022399528, 6002.54980876436, 6004.969975150097, 6005.669688167192, 6008.969955150196, 5704.828855134353, 5868.735906884115, 5889.057750759858, 5890.587658864009, 5893.499052580579, 5914.792982245601, 5958.136070269873, 6006.249218847644, 6050.0, 6055.788047418496, 5718.8570285741525, 5758.078707406795, 5764.07774756037, 5764.59647824665, 5792.710364481674, 5644.971775141098, 5755.597108202385, 5828.504577110993, 5877.235959325431, 5883.499902508163, 5646.774129034792, 5724.484796368347, 5726.885462290647, 5729.656220626775, 5777.335606405317, 5691.373948865538, 5695.060315047971, 5699.6865172414255, 5702.230198923092, 5710.229119068873, 5430.13117901134, 5506.174073888948, 5577.9442205577425, 5588.832335029955, 5595.720213989365, 5812.3025236971835, 5821.068629019336, 5821.505172060422, 5823.039198532195, 5824.271966004249, 5618.578606604439, 5648.830535083954, 5650.745716442852, 5654.660720356792, 5696.088625819849], "value": 5342.49356277524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.6745557399005, 621.4220774679552, 642.9003504456809, 650.6681592387881, 660.6828722213339, 31743.841280793593, 35300.82349588252, 43177.35233971493, 44306.55693443065, 44384.55615443845, 44775.32837007447, 44911.0, 45317.546824531746, 45384.3192352115, 45430.772846135726, 8611.138886111401, 8759.868601970975, 8767.693130740425, 8773.341999350043, 8793.868091978626, 8696.652133914637, 8790.956045219766, 8796.47221166729, 8801.735947921541, 8802.559872006406, 8827.911720882805, 8867.379283450162, 8869.822603547926, 8880.467171969702, 8885.378023538355, 8770.035296117421, 8809.64761409543, 8823.205911467998, 8828.911710882872, 8829.293656507496, 8640.0, 8663.220310172115, 8734.475931444134, 8737.475751454933, 8742.519161446118, 41412.58587414148, 41524.37713434301, 41717.79141104306, 41781.79109104465, 41899.0, 3528.153243221634, 3559.2703495783303, 3651.8539258429896, 3742.1954279829697, 4402.515723270438, 31250.53124203139, 31544.684553154635, 31614.209644758834, 31792.04623861288, 32030.359392812246, 4382.561743825624, 4411.139827733593, 4412.0955204183065, 4440.622547083502, 4468.240399132123, 315245.0, 316490.9999999977, 317964.0, 318889.0, 319462.0, 56497.15254271189, 57434.71282643644, 57442.425575743706, 57474.0, 57504.0, 37005.25989480195, 37782.0, 37807.24385512329, 39675.60324396719, 59238.0, 17773.555661108574, 17895.552611184823, 17912.641747164984, 17942.641147176982, 17944.641107177784, 13780.10429322091, 13859.722805543832, 13896.096753710977, 13899.930500347433, 13904.165750055028, 19397.612047758965, 19643.60712785736, 19691.310804121786, 19693.144494048283, 19846.0, 7118.359347658736, 7121.184098054963, 7177.626515537689, 7202.171750248684, 7249.752576701239, 1011.544804837826, 1136.891995260449, 1137.1414581990543, 1154.8267759836092, 1180.3567055954525, 31925.361492770015, 32082.0, 32118.518222226685, 32257.838710806296, 32389.51415728766, 1149.448264832885, 1169.3393232823428, 1196.6170825335982, 1230.39095647655, 1240.9379531023412, 16760.1619919006, 16778.244978975974, 17039.659206815795, 17065.232064557124, 17120.571985700208, 433622.0, 437793.0, 439253.0, 439631.0, 439929.0, 58253.0, 58815.0, 58831.0, 58888.0, 58906.70546647325, 1338.1235290884485, 1400.6568390744128, 1436.0665567381286, 1456.0, 1457.774045023023, 31239.84380078176, 32482.187945301557, 32636.39786757588, 32721.509177362834, 33368.33263334768, 47979.04041919212, 48122.759386202844, 48292.27561586649, 48360.274595880386, 48553.75723121362, 328341.0, 329202.0, 329472.0, 329763.0, 648631.0, 28000.439991199655, 28322.71677283201, 28458.146255612366, 29870.863559326826, 29920.850395747882, 46985.2952205724, 47871.5212847881, 47988.280175796695, 48917.0, 49306.26040609322, 39556.40665389964, 40329.168728970704, 40553.0, 41603.1679366417, 41746.58253417427, 37389.0, 40162.598374015884, 40248.798756006036, 41598.16803663849, 41929.0, 44521.901008530265, 44671.10657786761, 45247.095058098, 45430.31854522251, 46073.30890036719, 34284.0, 36519.63480365268, 36520.81739591285, 37067.44398834074, 37573.05482924254, 28194.577081343385, 28229.43541129207, 28441.0, 28533.714662853938, 28778.71221287844], "value": 19948.470458073985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.65603940512636, 396.73022344805537, 403.3002740245675, 405.1774896959173, 418.6525184097198, 17754.73367899481, 19618.313359032436, 19618.90190549049, 19789.901050494762, 20585.69121463179, 17554.122293885288, 18221.180046897887, 18356.632867342647, 18705.906470467628, 19597.804021959775, 5127.7692503837325, 5225.555827754626, 5271.973640131794, 5324.54741346986, 5330.253764472977, 5120.257562653413, 5223.895522089556, 5253.238280449333, 5283.682979021271, 5296.443873393296, 5249.711265880375, 5282.3925248596515, 5285.920711189336, 5317.867053323678, 5327.840164795062, 5170.3795544534705, 5281.762320695578, 5316.149416093426, 5320.334958130234, 5321.148616221405, 4972.229304457815, 5176.430592634807, 5195.584353251731, 5212.218167274901, 5219.060569097561, 21723.782762172494, 22440.88779556108, 22495.212667556556, 22851.885740571357, 22864.199753008732, 2271.261839902022, 2497.912573059952, 2682.396460796325, 2859.6997315281806, 3039.316153865385, 9980.650677226335, 10122.848157277647, 10480.371177729285, 10489.63286284984, 10504.107150892183, 1865.2072869030744, 1887.9433616991512, 1978.910949007298, 1994.7107669387858, 2099.548597051626, 82583.5870820642, 86605.56697216537, 87543.56228218882, 87569.56215218882, 87569.56215218946, 10654.893451065545, 11022.614208502824, 11046.392448415414, 11113.666590002313, 11122.555097795997, 15428.460003899809, 15515.612109697347, 15521.223938803014, 15521.922390387976, 15557.0, 8199.139090395423, 8447.957760211282, 8536.658533658585, 8620.224179823721, 8660.610272537751, 8294.668213271521, 8363.832723345498, 8387.664493420318, 8444.61999210037, 8467.788305292417, 4648.140094082605, 4795.424549054136, 4854.514548545188, 4906.533879281463, 4978.228374601942, 1968.7834338222783, 1985.5333996510808, 2000.6298834715333, 2005.488600406887, 2029.4419034765558, 1020.0717347213999, 1027.8817935937313, 1038.9817978381077, 1060.5386656804314, 1090.5583238788304, 18225.817741822677, 18792.248310067444, 18874.90562547206, 18881.622367552573, 19116.0, 1047.643801107627, 1064.7604289034905, 1065.8454524094118, 1101.0365929811414, 1112.6606385052476, 6347.492200623939, 6510.544261901621, 6647.567908085959, 6732.2931092235585, 6877.552959057645, 508403.0, 513504.0, 518305.0, 524288.0, 532228.0, 93973.0, 96649.0, 97900.0, 99327.50336248272, 99981.50009249907, 502.54268615559664, 506.09409157608206, 508.09812582666063, 512.3569919750689, 512.912804823181, 11475.426228688366, 15966.281517331516, 16903.492895213163, 17027.574310641838, 17878.642427151644, 29441.263968400963, 33727.49408758822, 33982.83008584941, 35472.11319717028, 40111.19777604373, 51201.74399127981, 52294.47705522896, 53713.0, 54402.0, 54848.0, 8415.368847336353, 8430.747077587683, 8557.700480483154, 8566.52884091381, 8861.113888611088, 9096.363254572116, 9168.495732734764, 9327.626894924128, 9467.905320946702, 9878.209743220381, 8320.459170153921, 8566.357523185661, 8739.91260087391, 8836.047557198573, 9008.062037027918, 8758.737237882873, 8849.0, 8976.775580610276, 8987.19115279628, 8992.46045237288, 5441.891162176655, 6131.540134489842, 6827.829304267433, 8480.643097104434, 8800.943886733632, 12729.236245825281, 13019.349032548524, 13020.153690010118, 13072.346382681018, 13176.60470185896, 12456.813147802972, 12661.366931653565, 12668.239905605693, 12723.236605803311, 12875.227486350848], "value": 8655.407266891305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.316248457014, 1542.8631345586364, 1542.9959255731376, 1686.5024817678784, 1870.728744332071, 8002.479838810481, 8391.538465384401, 8415.621297041633, 8641.135886411355, 8642.827143457127, 8465.78835529112, 8643.74068777936, 8649.048604653482, 8663.783405414868, 8675.392722509427, 1927.7493925789697, 2094.3298144593737, 2181.334692918659, 2193.6819161221615, 2217.811486023682, 2098.055874856313, 2107.4099252209407, 2107.620628286908, 2115.471132216946, 2119.4807272218327, 2102.2536999365234, 2211.535577528713, 2215.6233440315186, 2217.7116974793335, 2219.212179676216, 1886.1795119123158, 2125.436759258798, 2194.0784870354328, 2196.560687862434, 2218.9556208875892, 2054.1269960266827, 2102.978970210309, 2153.6446486329737, 2159.8164156046755, 2162.4918144236094, 8668.133186681345, 8728.825423491495, 8753.912460875374, 8766.254868336198, 8778.736637900809, 5046.848594542133, 5160.12277912752, 5204.42751297357, 5206.583473322125, 5209.296744939423, 3199.3281410903737, 3243.9837800810847, 3264.9183770405693, 3290.7367410607094, 3367.663233676613, 1015.5836107196014, 1043.7599352149048, 1049.3284298049255, 1055.5250137438106, 1062.3360399750156, 12001.879981200163, 12124.272543647321, 12128.696782580419, 12130.878691213064, 12158.027357811265, 4475.149721552894, 4540.477845047796, 4554.180247555471, 4602.953970460252, 4641.0, 10129.848052279222, 10147.188224941987, 10148.03593658616, 10148.086672199537, 10164.4917754112, 4661.766911654471, 5174.534291913746, 5181.171012638035, 5194.584433245332, 5202.791888324425, 4619.838305659286, 4734.715917044989, 4748.976255118702, 4777.426708794897, 4784.067106914188, 3876.0, 3897.1621101462756, 3980.3233450313514, 3985.183037477368, 4029.7179197456485, 1227.4108427954454, 1270.0791925853682, 1276.5149243287492, 1284.7045179608556, 1287.7875150600235, 789.2186735132293, 914.6661468563926, 931.5761328595473, 940.9978373032699, 949.1078386316979, 5169.767360468788, 5206.140986737146, 5299.814506492331, 5317.548008419328, 5482.616216864782, 401.10153256705354, 401.7328476563053, 402.02308390611097, 402.5974025974026, 407.4194273160734, 3708.295423869456, 3854.4603755474254, 3954.723169378116, 3968.543617484026, 3997.400389941474, 10437.739056523496, 10779.892201078046, 10898.564057437772, 10933.617323393642, 10938.0, 10107.898921010696, 10648.307859989076, 10789.892101079045, 10809.297395669257, 10856.240063195659, 7982.920170798334, 8048.839023219502, 8117.837643247102, 8159.816826560115, 8212.0, 5447.346318441812, 5709.172170035238, 5729.684867332337, 5733.684647344269, 5784.479396854304, 9852.704418867446, 9940.304178707422, 9981.251406144424, 9993.900060999296, 10102.292839501459, 9901.0, 10170.593176272867, 10231.334963227366, 10249.12882405004, 10270.743231419274, 6754.5947243165565, 6941.930580694128, 6944.027836102849, 7671.309582137635, 7795.727149549739, 7870.84258314819, 8095.797605059921, 8380.371472139492, 8393.0, 8700.347473939353, 7683.346915512244, 7748.418868584766, 7764.844703105793, 7785.377169826514, 8013.879791803244, 7438.070241219848, 7497.475176737576, 7527.924720752722, 7608.163102058658, 7660.846783064196, 7232.674529646073, 7235.421166306577, 7293.890591641023, 7301.342879140902, 7301.379382752525, 4552.817887284604, 4717.858464246078, 4792.0, 4835.395575553056, 4904.8773780655765, 4623.989312383484, 4632.675712700078, 4704.788284527273, 4713.552212539803, 4745.264484004984], "value": 4381.192702664505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.7498151441876, 332.9417351963406, 333.4314992937041, 335.7465113839051, 340.5147664577976, 5286.814961476349, 5294.285271488348, 5325.121354976429, 5336.359636843579, 5378.489043540867, 5300.125479295912, 5303.390110137326, 5308.654937429064, 5319.0, 5320.122179840331, 3950.4074388841686, 3975.522937247534, 4144.523379811315, 4166.166766646667, 4181.121964387482, 4127.4934648853105, 4131.442255295527, 4161.25097482453, 4162.687798415116, 4163.20899029185, 3916.725829191958, 4124.484439445069, 4125.525564560069, 4133.400656904762, 4136.97931510342, 4006.519217693881, 4087.4277601135864, 4113.0, 4115.279826030448, 4117.3206420940805, 3626.8367923443507, 3627.2382799612114, 3636.3636363636256, 3650.8357123929486, 3661.9633803662155, 5005.724685142316, 5026.924596131061, 5043.344365232533, 5086.4659210783075, 5127.282180494733, 4561.354414439617, 4723.669343145981, 4753.239481682914, 4755.692184649214, 4759.690620109716, 5442.700651464168, 5505.394406615269, 5505.724713764296, 5513.531349835269, 5531.9723401383135, 3743.5320584926885, 3901.614926701037, 4051.2505186540584, 4056.858009969637, 4057.6145266199665, 5661.264035675335, 5663.688497132656, 5667.886642267132, 5752.424757524256, 5773.278340207474, 4009.3384591542067, 4016.859409920639, 4027.476428064333, 4029.6574791142493, 4031.576684448091, 3849.538055433366, 4046.7976601169826, 4047.5750046245307, 4066.6949978751713, 4071.8371265149653, 4640.723800954765, 4651.744154071491, 4658.114958157939, 4668.883277918079, 4671.505118362092, 5504.394516603171, 5516.475934786189, 5520.282363292827, 5535.391106978229, 5566.6381685191145, 1330.2683524061727, 1344.636948024028, 1347.9797803032961, 1369.6918193406602, 1378.1455497591558, 861.4745005546612, 931.1293940165966, 935.0, 948.9335746497817, 951.1392190068, 5077.619178561623, 5086.92369614456, 5105.591552675777, 5106.66806657566, 5147.922781158286, 5406.297181366476, 5424.965637885793, 5433.962264150943, 5434.456554344613, 5446.972765136149, 4959.70241785494, 5082.059818933509, 5117.309163262987, 5121.8463446096675, 5128.487096306599, 2879.1650421377567, 2891.26524085547, 2892.5950366948646, 2913.994671838255, 2938.67674555803, 5435.320584926884, 5597.0, 5601.507329238531, 5608.186812912187, 5615.803446879339, 5355.812546560929, 5425.0, 5438.238646589481, 5493.395726470085, 5547.33431988164, 5552.555795536347, 5565.217391304348, 5587.916181257285, 5592.762894842096, 5595.776168953359, 5246.31797866275, 5424.810131645373, 5441.129419293053, 5457.645253058538, 5695.715214239189, 5631.7184140793615, 5646.85882852932, 5650.434956504317, 5651.237082993744, 5667.3765885753355, 5818.185454036354, 5819.592628515963, 5854.180414741854, 5863.355030946678, 5864.706764661664, 3801.3157631626573, 3951.446797448302, 4035.7376770510996, 4076.3274059779806, 4077.959220407758, 5632.211490391266, 5635.380108188178, 5644.633098848726, 5664.688442135722, 5665.348484924287, 5490.3411590609385, 5498.927709096688, 5506.119020956788, 5512.862178445571, 5520.779168833202, 5293.894122117613, 5500.669959802264, 5515.917261241165, 5526.530244929226, 5554.6944918028275, 5208.166693329049, 5251.608323794274, 5373.898350838147, 5414.539764120094, 5467.945320546903, 5495.5878309127775, 5527.391986881359, 5576.749046293007, 5619.634723742944, 5629.859253518531, 5435.918461223164, 5451.918221226605, 5452.700101494456, 5455.618106732491, 5464.699441530595], "value": 4167.401272168647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.5930827007551, 777.5615112042719, 856.910024447433, 875.2472873328932, 879.4986857491233, 12649.430775615096, 13843.930780346096, 14038.859611403883, 14065.437382504688, 14101.365438555276, 12794.616161515169, 12857.228566286007, 12863.228206307627, 12941.223526588388, 12949.805752913713, 696.6064173741845, 811.5577010529275, 814.2997022560608, 829.3489610655637, 838.2246422059601, 820.0774129104757, 820.8604537228686, 823.518241828531, 824.5464994253167, 824.5794644731201, 883.9337049721264, 885.5970533407284, 888.1828717579842, 889.7419748272993, 889.9777505562348, 736.5948728199496, 863.369740089738, 879.8768172455862, 880.6257340630207, 883.3639779358883, 646.3116780628616, 647.8250872264463, 647.9384458476437, 648.3548868875451, 648.5168549430705, 12933.288669123194, 12939.094263401566, 12948.093633445662, 12957.157784743962, 12977.675558111028, 13557.661058473519, 14094.718105637932, 14096.859031409656, 14137.929310353486, 14173.43306267748, 12140.0, 12266.202696824677, 12325.815112773316, 12583.119181657288, 12611.495540178383, 4448.755318457484, 4564.42944631921, 4641.582257596799, 4666.160091183586, 4690.859274221779, 55804.72097639526, 56746.0, 56809.14786278209, 56812.71593642046, 57176.14235786508, 10911.945440272748, 11005.944970275097, 11071.0, 11172.664820055248, 11199.21605487608, 20101.39695809128, 20170.0, 20211.090500927494, 20228.089735961916, 20229.19083236654, 7681.231876812274, 8065.072516660542, 8091.393145513992, 8287.171282871665, 8698.695545655872, 4632.050429661911, 4733.810647574059, 4841.975790121027, 4842.5157484251295, 4850.975745121252, 3190.6809319067906, 3229.628592711821, 3277.3772983133126, 3287.917802054968, 3294.8352582370785, 615.3538784276492, 626.5019309648749, 628.915096461981, 638.4317957018258, 645.1258544671996, 639.7760783725658, 648.5168549430705, 649.6978904809287, 650.1807722269974, 655.2431941108027, 8001.199880011952, 8294.502329860228, 8369.204925532065, 8513.702020429255, 8531.914680853111, 652.2215362555547, 685.9691313890887, 691.4122995453824, 702.6737331030774, 708.7235977968596, 3775.1505911170316, 3843.442700808367, 3859.1702783901596, 3874.9225015499533, 3881.6700580450415, 57972.71013644989, 63050.369496305364, 63391.0, 63401.68299158475, 63486.33393493709, 25454.363640909127, 54158.72920635372, 54897.0, 55675.72162139163, 57729.0, 49446.50553494419, 50083.24875126876, 50290.74854625777, 50620.49379506231, 51134.23298650523, 7472.0, 7535.6985720570565, 7577.886331704918, 7611.847763044819, 7668.80827979305, 32105.518417224226, 32478.35043299168, 32835.50746738849, 33615.15962100967, 33619.0, 39892.60107398889, 41919.0, 42310.153796923274, 43727.78136109299, 47597.52402475931, 12648.620541383772, 12810.615681529569, 12855.29295888735, 12876.484940602271, 13117.278549679859, 10158.441285729356, 13207.528410503079, 14362.13827170373, 14993.550193494213, 15020.7746883799, 13233.3383330835, 14079.577612671636, 14200.928995354958, 14211.715765684836, 14473.203973781543, 13154.276514791778, 13710.108842925178, 13849.376778045214, 13873.0, 14352.138871667734, 13283.601491955256, 13599.932000339935, 13600.591982240549, 14052.508162214273, 14079.0848594841, 10815.134789216687, 10892.61875834342, 10968.616098436516, 11154.776904462027, 11164.0, 10758.17941559259, 10930.180236482454, 11001.504932277907, 11052.723681908017, 11202.103831693608], "value": 6736.878147454655, "unit": "score"}], "name": "dromaeo_css", "value": 6957.993239137355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 151.0, 208.0, 126.0, 162.0, 151.0, 126.0, 191.0, 125.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 160.0, 160.0, 159.0, 160.0, 165.0, 160.0, 161.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 163.0, 76.0, 76.0, 77.0, 76.0, 135.0, 75.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 158.0, 91.0, 99.0, 91.0, 125.0, 92.0, 91.0, 126.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 56.0, 61.0, 110.0, 55.0, 55.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 79.0, 79.0, 80.0, 80.0, 88.0, 82.0, 88.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 136.0, 126.0, 122.0, 127.0, 122.0, 122.0, 232.0, 134.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 168.0, 167.0, 169.0, 171.0, 172.0, 171.0, 171.0, 171.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 66.0, 65.0, 66.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1552.1000000000001, "alertThreshold": 2.0}]} 05:46:22 INFO - Return code: 0 05:46:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:46:22 ERROR - # TBPL SUCCESS # 05:46:22 INFO - Running post-action listener: _resource_record_post_action 05:46:22 INFO - ##### 05:46:22 INFO - ##### Finished run-tests step (success) 05:46:22 INFO - ##### 05:46:22 INFO - Running post-run listener: _resource_record_post_run 05:46:23 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541376512; Read time: 16; Write time: 566664 05:46:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252190720; Read time: 0; Write time: 334540 05:46:23 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289185792; Read time: 16; Write time: 232124 05:46:23 INFO - Running post-run listener: _upload_blobber_files 05:46:23 INFO - Blob upload gear active. 05:46:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:23 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 05:46:23 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'] 05:46:23 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 05:46:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:24 INFO - (blobuploader) - INFO - Done attempting. 05:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:25 INFO - (blobuploader) - INFO - Done attempting. 05:46:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:25 INFO - Return code: 0 05:46:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f285bec8e75cd4f92edbcaea3fe928670eeb981fe039baf3b29306da456db4ce969ddde5c50823dd01bb738e21947b5b9bc4494cfa02988653a397d3be146bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71820198f9ab5258ddb1072b458ec208a49ae7b0f6ac21ff749f885cdff5810da5e9acf40e0eaac06da6818dc3a1a65cebde317a93dc90588c2f6992a7fd7d07"} 05:46:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:25 INFO - Contents: 05:46:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f285bec8e75cd4f92edbcaea3fe928670eeb981fe039baf3b29306da456db4ce969ddde5c50823dd01bb738e21947b5b9bc4494cfa02988653a397d3be146bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71820198f9ab5258ddb1072b458ec208a49ae7b0f6ac21ff749f885cdff5810da5e9acf40e0eaac06da6818dc3a1a65cebde317a93dc90588c2f6992a7fd7d07"} 05:46:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:25 INFO - Copying logs to upload dir... 05:46:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.535235 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-10 05:46:25.714427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:46:25.717978) ========= 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=eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f285bec8e75cd4f92edbcaea3fe928670eeb981fe039baf3b29306da456db4ce969ddde5c50823dd01bb738e21947b5b9bc4494cfa02988653a397d3be146bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71820198f9ab5258ddb1072b458ec208a49ae7b0f6ac21ff749f885cdff5810da5e9acf40e0eaac06da6818dc3a1a65cebde317a93dc90588c2f6992a7fd7d07"} build_url:https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/KjPzqq-LQ_m5x325XIw_jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f285bec8e75cd4f92edbcaea3fe928670eeb981fe039baf3b29306da456db4ce969ddde5c50823dd01bb738e21947b5b9bc4494cfa02988653a397d3be146bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71820198f9ab5258ddb1072b458ec208a49ae7b0f6ac21ff749f885cdff5810da5e9acf40e0eaac06da6818dc3a1a65cebde317a93dc90588c2f6992a7fd7d07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:46:25.742694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:46:25.743027) ========= 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=eca2ab57546de7b41f256b19000001ef-1462883149.731456-781622455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:46:25.827311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:46:25.827636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:46:25.827941) ========= ========= Total master_lag: 0.16 =========