builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1461159913.63 results: success (0) buildid: 20160420053850 builduid: db978b6c5222466a89fb1ea0fc60f9d5 revision: 19b8851d8d4c19997ecc73960f4de8d90c981c28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.625564) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.626046) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.626345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.697063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.697371) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 06:45:13-- 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% 223M=0s 2016-04-20 06:45:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.814803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.815127) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017505 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.864892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:13.865286) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19b8851d8d4c19997ecc73960f4de8d90c981c28 --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 19b8851d8d4c19997ecc73960f4de8d90c981c28 --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=fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 06:45:13,947 truncating revision to first 12 chars 2016-04-20 06:45:13,947 Setting DEBUG logging. 2016-04-20 06:45:13,947 attempt 1/10 2016-04-20 06:45:13,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/19b8851d8d4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 06:45:14,204 unpacking tar archive at: fx-team-19b8851d8d4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:14.399052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:14.399417) ========= script_repo_revision: 19b8851d8d4c19997ecc73960f4de8d90c981c28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:14.399881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:14.400168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 06:45:14.410089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 06:45:14.410370) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:45:14 INFO - MultiFileLogger online at 20160420 06:45:14 in /builds/slave/test 06:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:45:14 INFO - {'append_to_log': False, 06:45:14 INFO - 'base_work_dir': '/builds/slave/test', 06:45:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:45:14 INFO - 'branch': 'Fx-Team-Non-PGO', 06:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:45:14 INFO - 'config_files': ('talos/linux_config.py',), 06:45:14 INFO - 'default_actions': ('clobber', 06:45:14 INFO - 'read-buildbot-config', 06:45:14 INFO - 'download-and-extract', 06:45:14 INFO - 'populate-webroot', 06:45:14 INFO - 'create-virtualenv', 06:45:14 INFO - 'install', 06:45:14 INFO - 'run-tests'), 06:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:45:14 INFO - 'download_minidump_stackwalk': True, 06:45:14 INFO - 'download_symbols': 'ondemand', 06:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:45:14 INFO - 'installer_path': 'installer.exe', 06:45:14 INFO - 'log_level': 'info', 06:45:14 INFO - 'log_name': 'talos', 06:45:14 INFO - 'log_to_console': True, 06:45:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:45:14 INFO - 'opt_config_files': (), 06:45:14 INFO - 'pip_index': False, 06:45:14 INFO - 'sps_profile': False, 06:45:14 INFO - 'sps_profile_interval': 0, 06:45:14 INFO - 'suite': 'dromaeojs-e10s', 06:45:14 INFO - 'system_bits': '32', 06:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:45:14 INFO - 'title': 'talos-linux64-ix-014', 06:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:45:14 INFO - 'use_talos_json': True, 06:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:45:14 INFO - 'work_dir': 'build'} 06:45:14 INFO - ##### 06:45:14 INFO - ##### Running clobber step. 06:45:14 INFO - ##### 06:45:14 INFO - Running pre-action listener: _resource_record_pre_action 06:45:14 INFO - Running main action method: clobber 06:45:14 INFO - rmtree: /builds/slave/test/build 06:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:45:15 INFO - Running post-action listener: _resource_record_post_action 06:45:15 INFO - ##### 06:45:15 INFO - ##### Running read-buildbot-config step. 06:45:15 INFO - ##### 06:45:15 INFO - Running pre-action listener: _resource_record_pre_action 06:45:15 INFO - Running main action method: read_buildbot_config 06:45:15 INFO - Using buildbot properties: 06:45:15 INFO - { 06:45:15 INFO - "project": "", 06:45:15 INFO - "product": "firefox", 06:45:15 INFO - "script_repo_revision": "production", 06:45:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:45:15 INFO - "repository": "", 06:45:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:45:15 INFO - "buildid": "20160420053850", 06:45:15 INFO - "pgo_build": "False", 06:45:15 INFO - "basedir": "/builds/slave/test", 06:45:15 INFO - "buildnumber": 1182, 06:45:15 INFO - "slavename": "talos-linux64-ix-014", 06:45:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:45:15 INFO - "platform": "ubuntu64_hw", 06:45:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:45:15 INFO - "branch": "fx-team", 06:45:15 INFO - "repo_path": "integration/fx-team", 06:45:15 INFO - "revision": "19b8851d8d4c19997ecc73960f4de8d90c981c28", 06:45:15 INFO - "stage_platform": "linux64", 06:45:15 INFO - "builduid": "db978b6c5222466a89fb1ea0fc60f9d5", 06:45:15 INFO - "slavebuilddir": "test" 06:45:15 INFO - } 06:45:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:45:15 INFO - Running post-action listener: _resource_record_post_action 06:45:15 INFO - ##### 06:45:15 INFO - ##### Running download-and-extract step. 06:45:15 INFO - ##### 06:45:15 INFO - Running pre-action listener: _resource_record_pre_action 06:45:15 INFO - Running main action method: download_and_extract 06:45:15 INFO - mkdir: /builds/slave/test/build/tests 06:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:15 INFO - https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:45:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:45:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:45:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:45:20 INFO - Downloaded 1361 bytes. 06:45:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:45:20 INFO - Using the following test package requirements: 06:45:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:45:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:45:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:45:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'jsshell-linux-x86_64.zip'], 06:45:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:45:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:45:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:45:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:45:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:45:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:45:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:20 INFO - https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:45:22 INFO - Downloaded 22267803 bytes. 06:45:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:45:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:45:23 INFO - Return code: 0 06:45:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:23 INFO - https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:45:25 INFO - Downloaded 22267803 bytes. 06:45:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:45:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:45:26 INFO - Return code: 0 06:45:26 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')]} 06:45:26 INFO - https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:45:27 INFO - Downloaded 10845952 bytes. 06:45:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:45:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:45:27 INFO - Return code: 0 06:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:27 INFO - https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:45:37 INFO - Downloaded 54611551 bytes. 06:45:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:45:37 INFO - mkdir: /builds/slave/test/properties 06:45:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:45:37 INFO - Writing to file /builds/slave/test/properties/build_url 06:45:37 INFO - Contents: 06:45:37 INFO - build_url:https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:45:38 INFO - Running post-action listener: _resource_record_post_action 06:45:38 INFO - Running post-action listener: set_extra_try_arguments 06:45:38 INFO - ##### 06:45:38 INFO - ##### Running populate-webroot step. 06:45:38 INFO - ##### 06:45:38 INFO - Running pre-action listener: _resource_record_pre_action 06:45:38 INFO - Running main action method: populate_webroot 06:45:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:45:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:45:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:45:38 INFO - '--tppagecycles', 06:45:38 INFO - '7'], 06:45:38 INFO - 'tests': ['tsvgm']}}, 06:45:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:45:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:45:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:45:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:45:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['damp', 'tps']}, 06:45:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'tests': ['damp', 'tps']}, 06:45:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['dromaeo_dom']}, 06:45:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:45:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['a11yr', 06:45:38 INFO - 'ts_paint', 06:45:38 INFO - 'tpaint', 06:45:38 INFO - 'sessionrestore', 06:45:38 INFO - 'sessionrestore_no_auto_restore', 06:45:38 INFO - 'tabpaint']}, 06:45:38 INFO - 'other-e10s': {'tests': ['a11yr', 06:45:38 INFO - 'ts_paint', 06:45:38 INFO - 'tpaint', 06:45:38 INFO - 'sessionrestore', 06:45:38 INFO - 'sessionrestore_no_auto_restore', 06:45:38 INFO - 'tabpaint']}, 06:45:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:45:38 INFO - 'ts_paint', 06:45:38 INFO - 'tpaint', 06:45:38 INFO - 'sessionrestore', 06:45:38 INFO - 'sessionrestore_no_auto_restore', 06:45:38 INFO - 'tabpaint']}, 06:45:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:45:38 INFO - 'ts_paint', 06:45:38 INFO - 'tpaint', 06:45:38 INFO - 'sessionrestore', 06:45:38 INFO - 'sessionrestore_no_auto_restore', 06:45:38 INFO - 'tabpaint']}, 06:45:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['a11yr', 06:45:38 INFO - 'ts_paint', 06:45:38 INFO - 'tpaint', 06:45:38 INFO - 'sessionrestore', 06:45:38 INFO - 'sessionrestore_no_auto_restore', 06:45:38 INFO - 'tabpaint']}, 06:45:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['a11yr', 06:45:38 INFO - 'ts_paint', 06:45:38 INFO - 'tpaint', 06:45:38 INFO - 'sessionrestore', 06:45:38 INFO - 'sessionrestore_no_auto_restore', 06:45:38 INFO - 'tabpaint']}, 06:45:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['tsvgx', 06:45:38 INFO - 'tsvgr_opacity', 06:45:38 INFO - 'tart', 06:45:38 INFO - 'tscrollx', 06:45:38 INFO - 'cart']}, 06:45:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:45:38 INFO - 'tsvgr_opacity', 06:45:38 INFO - 'tart', 06:45:38 INFO - 'tscrollx', 06:45:38 INFO - 'cart']}, 06:45:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'talos_options': ['--disable-e10s'], 06:45:38 INFO - 'tests': ['tp5o']}, 06:45:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'tests': ['tp5o']}, 06:45:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'talos_options': ['--disable-e10s', 06:45:38 INFO - '--xperf_path', 06:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:38 INFO - 'tests': ['tp5n']}, 06:45:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:38 INFO - 'talos_options': ['--xperf_path', 06:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:38 INFO - 'tests': ['tp5n']}}, 06:45:38 INFO - 'talos.zip': {'path': '', 06:45:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:45:38 INFO - Running post-action listener: _resource_record_post_action 06:45:38 INFO - ##### 06:45:38 INFO - ##### Running create-virtualenv step. 06:45:38 INFO - ##### 06:45:38 INFO - Running pre-action listener: _resource_record_pre_action 06:45:38 INFO - Running main action method: create_virtualenv 06:45:38 INFO - Creating virtualenv /builds/slave/test/build/venv 06:45:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:45:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:45:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:45:38 INFO - Using real prefix '/usr' 06:45:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:45:38 INFO - Installing distribute.............................................................................................................................................................................................done. 06:45:40 INFO - Installing pip.................done. 06:45:40 INFO - Return code: 0 06:45:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:45:40 INFO - Using env: {'DISPLAY': ':0', 06:45:40 INFO - 'HOME': '/home/cltbld', 06:45:40 INFO - 'LANG': 'en_US.UTF-8', 06:45:40 INFO - 'LANGUAGE': 'en_US:en', 06:45:40 INFO - 'LOGNAME': 'cltbld', 06:45:40 INFO - 'MAIL': '/var/mail/cltbld', 06:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:40 INFO - 'MOZ_NO_REMOTE': '1', 06:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:40 INFO - 'NO_EM_RESTART': '1', 06:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:40 INFO - 'PWD': '/builds/slave/test', 06:45:40 INFO - 'SHELL': '/bin/bash', 06:45:40 INFO - 'SHLVL': '1', 06:45:40 INFO - 'TERM': 'linux', 06:45:40 INFO - 'TMOUT': '86400', 06:45:40 INFO - 'USER': 'cltbld', 06:45:40 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:40 INFO - '_': '/tools/buildbot/bin/python'} 06:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:41 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 06:45:41 INFO - Cleaning up... 06:45:41 INFO - Return code: 0 06:45:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:45:41 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')]} 06:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:41 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')]} 06:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:41 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:41 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 06:45:41 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 06:45:41 INFO - Using env: {'DISPLAY': ':0', 06:45:41 INFO - 'HOME': '/home/cltbld', 06:45:41 INFO - 'LANG': 'en_US.UTF-8', 06:45:41 INFO - 'LANGUAGE': 'en_US:en', 06:45:41 INFO - 'LOGNAME': 'cltbld', 06:45:41 INFO - 'MAIL': '/var/mail/cltbld', 06:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:41 INFO - 'MOZ_NO_REMOTE': '1', 06:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:41 INFO - 'NO_EM_RESTART': '1', 06:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:41 INFO - 'PWD': '/builds/slave/test', 06:45:41 INFO - 'SHELL': '/bin/bash', 06:45:41 INFO - 'SHLVL': '1', 06:45:41 INFO - 'TERM': 'linux', 06:45:41 INFO - 'TMOUT': '86400', 06:45:41 INFO - 'USER': 'cltbld', 06:45:41 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:41 INFO - '_': '/tools/buildbot/bin/python'} 06:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:41 INFO - Downloading/unpacking psutil>=0.7.1 06:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:45:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:43 INFO - Installing collected packages: psutil 06:45:43 INFO - Running setup.py install for psutil 06:45:43 INFO - building 'psutil._psutil_linux' extension 06:45:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:45:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:45:43 INFO - building 'psutil._psutil_posix' extension 06:45:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:45:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:45:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:43 INFO - Successfully installed psutil 06:45:43 INFO - Cleaning up... 06:45:43 INFO - Return code: 0 06:45:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:45:43 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')]} 06:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:43 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')]} 06:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:43 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:43 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 06:45:43 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 06:45:43 INFO - Using env: {'DISPLAY': ':0', 06:45:43 INFO - 'HOME': '/home/cltbld', 06:45:43 INFO - 'LANG': 'en_US.UTF-8', 06:45:43 INFO - 'LANGUAGE': 'en_US:en', 06:45:43 INFO - 'LOGNAME': 'cltbld', 06:45:43 INFO - 'MAIL': '/var/mail/cltbld', 06:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:43 INFO - 'MOZ_NO_REMOTE': '1', 06:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:43 INFO - 'NO_EM_RESTART': '1', 06:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:43 INFO - 'PWD': '/builds/slave/test', 06:45:43 INFO - 'SHELL': '/bin/bash', 06:45:43 INFO - 'SHLVL': '1', 06:45:43 INFO - 'TERM': 'linux', 06:45:43 INFO - 'TMOUT': '86400', 06:45:43 INFO - 'USER': 'cltbld', 06:45:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:43 INFO - '_': '/tools/buildbot/bin/python'} 06:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:45:45 INFO - Installing collected packages: mozsystemmonitor 06:45:45 INFO - Running setup.py install for mozsystemmonitor 06:45:46 INFO - Successfully installed mozsystemmonitor 06:45:46 INFO - Cleaning up... 06:45:46 INFO - Return code: 0 06:45:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:45:46 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')]} 06:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:46 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')]} 06:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:46 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:46 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 06:45:46 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 06:45:46 INFO - Using env: {'DISPLAY': ':0', 06:45:46 INFO - 'HOME': '/home/cltbld', 06:45:46 INFO - 'LANG': 'en_US.UTF-8', 06:45:46 INFO - 'LANGUAGE': 'en_US:en', 06:45:46 INFO - 'LOGNAME': 'cltbld', 06:45:46 INFO - 'MAIL': '/var/mail/cltbld', 06:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:46 INFO - 'MOZ_NO_REMOTE': '1', 06:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:46 INFO - 'NO_EM_RESTART': '1', 06:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:46 INFO - 'PWD': '/builds/slave/test', 06:45:46 INFO - 'SHELL': '/bin/bash', 06:45:46 INFO - 'SHLVL': '1', 06:45:46 INFO - 'TERM': 'linux', 06:45:46 INFO - 'TMOUT': '86400', 06:45:46 INFO - 'USER': 'cltbld', 06:45:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:46 INFO - '_': '/tools/buildbot/bin/python'} 06:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:45:46 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 06:45:46 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 06:45:46 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 06:45:46 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 06:45:46 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 06:45:46 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 06:45:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 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 06:45:48 INFO - Downloading docopt-0.6.1.tar.gz 06:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:48 INFO - Running setup.py install for blobuploader 06:45:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:49 INFO - Running setup.py install for requests 06:45:49 INFO - Running setup.py install for docopt 06:45:49 INFO - Successfully installed blobuploader requests docopt 06:45:49 INFO - Cleaning up... 06:45:49 INFO - Return code: 0 06:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:49 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:49 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 06:45:49 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 06:45:49 INFO - Using env: {'DISPLAY': ':0', 06:45:49 INFO - 'HOME': '/home/cltbld', 06:45:49 INFO - 'LANG': 'en_US.UTF-8', 06:45:49 INFO - 'LANGUAGE': 'en_US:en', 06:45:49 INFO - 'LOGNAME': 'cltbld', 06:45:49 INFO - 'MAIL': '/var/mail/cltbld', 06:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:49 INFO - 'MOZ_NO_REMOTE': '1', 06:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:49 INFO - 'NO_EM_RESTART': '1', 06:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:49 INFO - 'PWD': '/builds/slave/test', 06:45:49 INFO - 'SHELL': '/bin/bash', 06:45:49 INFO - 'SHLVL': '1', 06:45:49 INFO - 'TERM': 'linux', 06:45:49 INFO - 'TMOUT': '86400', 06:45:49 INFO - 'USER': 'cltbld', 06:45:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:49 INFO - '_': '/tools/buildbot/bin/python'} 06:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:49 INFO - Running setup.py (path:/tmp/pip-1mP3fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:49 INFO - Running setup.py (path:/tmp/pip-G5q5Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:49 INFO - Running setup.py (path:/tmp/pip-c_1xsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:50 INFO - Running setup.py (path:/tmp/pip-TGGQ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:50 INFO - Running setup.py (path:/tmp/pip-mdcwzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:50 INFO - Running setup.py (path:/tmp/pip-kJOzcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:50 INFO - Running setup.py (path:/tmp/pip-r43Jui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:50 INFO - Running setup.py (path:/tmp/pip-3UODG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:50 INFO - Running setup.py (path:/tmp/pip-iR6L7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:50 INFO - Running setup.py (path:/tmp/pip-2KAhcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:50 INFO - Running setup.py (path:/tmp/pip-hQwXgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:50 INFO - Running setup.py (path:/tmp/pip-MzFY0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:50 INFO - Running setup.py (path:/tmp/pip-Smgj5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:50 INFO - Running setup.py (path:/tmp/pip-LCqyu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:50 INFO - Running setup.py (path:/tmp/pip-uk4_JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:50 INFO - Running setup.py (path:/tmp/pip-rHQe9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:50 INFO - Running setup.py (path:/tmp/pip-TrIbLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:50 INFO - Running setup.py install for manifestparser 06:45:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Running setup.py install for mozcrash 06:45:51 INFO - Running setup.py install for mozdebug 06:45:51 INFO - Running setup.py install for mozdevice 06:45:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Running setup.py install for mozfile 06:45:51 INFO - Running setup.py install for mozhttpd 06:45:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Running setup.py install for mozinfo 06:45:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Running setup.py install for mozInstall 06:45:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:51 INFO - Running setup.py install for mozleak 06:45:51 INFO - Running setup.py install for mozlog 06:45:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Running setup.py install for moznetwork 06:45:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Running setup.py install for mozprocess 06:45:52 INFO - Running setup.py install for mozprofile 06:45:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Running setup.py install for mozrunner 06:45:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Running setup.py install for mozscreenshot 06:45:52 INFO - Running setup.py install for moztest 06:45:52 INFO - Running setup.py install for mozversion 06:45:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:52 INFO - Cleaning up... 06:45:52 INFO - Return code: 0 06:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:52 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:52 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 06:45:52 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 06:45:52 INFO - Using env: {'DISPLAY': ':0', 06:45:52 INFO - 'HOME': '/home/cltbld', 06:45:52 INFO - 'LANG': 'en_US.UTF-8', 06:45:52 INFO - 'LANGUAGE': 'en_US:en', 06:45:52 INFO - 'LOGNAME': 'cltbld', 06:45:52 INFO - 'MAIL': '/var/mail/cltbld', 06:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:52 INFO - 'MOZ_NO_REMOTE': '1', 06:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:52 INFO - 'NO_EM_RESTART': '1', 06:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:52 INFO - 'PWD': '/builds/slave/test', 06:45:52 INFO - 'SHELL': '/bin/bash', 06:45:52 INFO - 'SHLVL': '1', 06:45:52 INFO - 'TERM': 'linux', 06:45:52 INFO - 'TMOUT': '86400', 06:45:52 INFO - 'USER': 'cltbld', 06:45:52 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:52 INFO - '_': '/tools/buildbot/bin/python'} 06:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:53 INFO - Running setup.py (path:/tmp/pip-_VVqck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:53 INFO - Running setup.py (path:/tmp/pip-wvAJQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:53 INFO - Running setup.py (path:/tmp/pip-UwqfcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:53 INFO - Running setup.py (path:/tmp/pip-x5IYRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:53 INFO - Running setup.py (path:/tmp/pip-u5ZWbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:53 INFO - Running setup.py (path:/tmp/pip-w4q4v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:53 INFO - Running setup.py (path:/tmp/pip-icvSAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:53 INFO - Running setup.py (path:/tmp/pip-Iy567l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:53 INFO - Running setup.py (path:/tmp/pip-jIHT8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:53 INFO - Running setup.py (path:/tmp/pip-L16qwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:53 INFO - Running setup.py (path:/tmp/pip-5p_kyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:53 INFO - Running setup.py (path:/tmp/pip-T75hXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:53 INFO - Running setup.py (path:/tmp/pip-Ickou7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:53 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)) 06:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:53 INFO - Running setup.py (path:/tmp/pip-f2tmpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:54 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)) 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:54 INFO - Running setup.py (path:/tmp/pip-79o9D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:54 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)) 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:54 INFO - Running setup.py (path:/tmp/pip-_wynss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:54 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)) 06:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:54 INFO - Running setup.py (path:/tmp/pip-INlGT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:54 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)) 06:45:54 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)) 06:45:54 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)) 06:45:54 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)) 06:45:54 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)) 06:45:54 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)) 06:45:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:54 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 06:45:54 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 06:45:54 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 06:45:54 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 06:45:54 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 06:45:54 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 06:45:56 INFO - Downloading blessings-1.6.tar.gz 06:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:56 INFO - Installing collected packages: blessings 06:45:56 INFO - Running setup.py install for blessings 06:45:56 INFO - Successfully installed blessings 06:45:56 INFO - Cleaning up... 06:45:56 INFO - Return code: 0 06:45:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:56 INFO - Reading from file tmpfile_stdout 06:45:56 INFO - Current package versions: 06:45:56 INFO - argparse == 1.2.1 06:45:56 INFO - blessings == 1.6 06:45:56 INFO - blobuploader == 1.2.4 06:45:56 INFO - docopt == 0.6.1 06:45:56 INFO - manifestparser == 1.1 06:45:56 INFO - mozInstall == 1.12 06:45:56 INFO - mozcrash == 0.17 06:45:56 INFO - mozdebug == 0.1 06:45:56 INFO - mozdevice == 0.48 06:45:56 INFO - mozfile == 1.2 06:45:56 INFO - mozhttpd == 0.7 06:45:56 INFO - mozinfo == 0.9 06:45:56 INFO - mozleak == 0.1 06:45:56 INFO - mozlog == 3.1 06:45:56 INFO - moznetwork == 0.27 06:45:56 INFO - mozprocess == 0.22 06:45:56 INFO - mozprofile == 0.28 06:45:56 INFO - mozrunner == 6.11 06:45:56 INFO - mozscreenshot == 0.1 06:45:56 INFO - mozsystemmonitor == 0.0 06:45:56 INFO - moztest == 0.7 06:45:56 INFO - mozversion == 1.4 06:45:56 INFO - psutil == 3.1.1 06:45:56 INFO - requests == 1.2.3 06:45:56 INFO - wsgiref == 0.1.2 06:45:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:56 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:56 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 06:45:56 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 06:45:56 INFO - Using env: {'DISPLAY': ':0', 06:45:56 INFO - 'HOME': '/home/cltbld', 06:45:56 INFO - 'LANG': 'en_US.UTF-8', 06:45:56 INFO - 'LANGUAGE': 'en_US:en', 06:45:56 INFO - 'LOGNAME': 'cltbld', 06:45:56 INFO - 'MAIL': '/var/mail/cltbld', 06:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:56 INFO - 'MOZ_NO_REMOTE': '1', 06:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:56 INFO - 'NO_EM_RESTART': '1', 06:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:56 INFO - 'PWD': '/builds/slave/test', 06:45:56 INFO - 'SHELL': '/bin/bash', 06:45:56 INFO - 'SHLVL': '1', 06:45:56 INFO - 'TERM': 'linux', 06:45:56 INFO - 'TMOUT': '86400', 06:45:56 INFO - 'USER': 'cltbld', 06:45:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:56 INFO - '_': '/tools/buildbot/bin/python'} 06:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 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)) 06:45:56 INFO - Cleaning up... 06:45:56 INFO - Return code: 0 06:45:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:56 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:56 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 06:45:56 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 06:45:56 INFO - Using env: {'DISPLAY': ':0', 06:45:56 INFO - 'HOME': '/home/cltbld', 06:45:56 INFO - 'LANG': 'en_US.UTF-8', 06:45:56 INFO - 'LANGUAGE': 'en_US:en', 06:45:56 INFO - 'LOGNAME': 'cltbld', 06:45:56 INFO - 'MAIL': '/var/mail/cltbld', 06:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:56 INFO - 'MOZ_NO_REMOTE': '1', 06:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:56 INFO - 'NO_EM_RESTART': '1', 06:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:56 INFO - 'PWD': '/builds/slave/test', 06:45:56 INFO - 'SHELL': '/bin/bash', 06:45:56 INFO - 'SHLVL': '1', 06:45:56 INFO - 'TERM': 'linux', 06:45:56 INFO - 'TMOUT': '86400', 06:45:56 INFO - 'USER': 'cltbld', 06:45:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:56 INFO - '_': '/tools/buildbot/bin/python'} 06:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:57 INFO - Downloading/unpacking jsonschema 06:45:57 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 06:45:57 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 06:45:57 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 06:45:57 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 06:45:57 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 06:45:57 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 06:45:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:45:59 INFO - Downloading/unpacking functools32 (from jsonschema) 06:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:45:59 INFO - warning: no files found matching '*.txt' 06:45:59 INFO - no previously-included directories found matching 'build' 06:45:59 INFO - no previously-included directories found matching 'dist' 06:45:59 INFO - no previously-included directories found matching '.git*' 06:45:59 INFO - Installing collected packages: jsonschema, functools32 06:45:59 INFO - Running setup.py install for functools32 06:45:59 INFO - warning: no files found matching '*.txt' 06:45:59 INFO - no previously-included directories found matching 'build' 06:45:59 INFO - no previously-included directories found matching 'dist' 06:45:59 INFO - no previously-included directories found matching '.git*' 06:45:59 INFO - Successfully installed jsonschema functools32 06:45:59 INFO - Cleaning up... 06:45:59 INFO - Return code: 0 06:45:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:59 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 0x7f20b26e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', '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 06:45:59 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 06:45:59 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 06:45:59 INFO - Using env: {'DISPLAY': ':0', 06:45:59 INFO - 'HOME': '/home/cltbld', 06:45:59 INFO - 'LANG': 'en_US.UTF-8', 06:45:59 INFO - 'LANGUAGE': 'en_US:en', 06:45:59 INFO - 'LOGNAME': 'cltbld', 06:45:59 INFO - 'MAIL': '/var/mail/cltbld', 06:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:59 INFO - 'MOZ_NO_REMOTE': '1', 06:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:59 INFO - 'NO_EM_RESTART': '1', 06:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:59 INFO - 'PWD': '/builds/slave/test', 06:45:59 INFO - 'SHELL': '/bin/bash', 06:45:59 INFO - 'SHLVL': '1', 06:45:59 INFO - 'TERM': 'linux', 06:45:59 INFO - 'TMOUT': '86400', 06:45:59 INFO - 'USER': 'cltbld', 06:45:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:59 INFO - '_': '/tools/buildbot/bin/python'} 06:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:59 INFO - Downloading/unpacking flake8 06:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:46:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:46:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:46:02 INFO - no previously-included directories found matching 'docs/_build' 06:46:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:46:02 INFO - Running setup.py install for pep8 06:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:46:02 INFO - no previously-included directories found matching 'docs/_build' 06:46:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:46:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:46:02 INFO - Cleaning up... 06:46:02 INFO - Return code: 0 06:46:02 INFO - Running post-action listener: _resource_record_post_action 06:46:02 INFO - Running post-action listener: _start_resource_monitoring 06:46:02 INFO - Starting resource monitoring. 06:46:02 INFO - ##### 06:46:02 INFO - ##### Running install step. 06:46:02 INFO - ##### 06:46:02 INFO - Running pre-action listener: _resource_record_pre_action 06:46:02 INFO - Running main action method: install 06:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:03 INFO - Reading from file tmpfile_stdout 06:46:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:46:03 INFO - Reading from file tmpfile_stdout 06:46:03 INFO - Output received: 06:46:03 INFO - Usage: mozinstall [options] installer 06:46:03 INFO - Options: 06:46:03 INFO - -h, --help show this help message and exit 06:46:03 INFO - -d DEST, --destination=DEST 06:46:03 INFO - Directory to install application into. [default: 06:46:03 INFO - "/builds/slave/test"] 06:46:03 INFO - --app=APP Application being installed. [default: firefox] 06:46:03 INFO - mkdir: /builds/slave/test/build/application 06:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:46:18 INFO - Reading from file tmpfile_stdout 06:46:18 INFO - Output received: 06:46:18 INFO - /builds/slave/test/build/application/firefox/firefox 06:46:18 INFO - Running post-action listener: _resource_record_post_action 06:46:18 INFO - ##### 06:46:18 INFO - ##### Running run-tests step. 06:46:18 INFO - ##### 06:46:18 INFO - Running pre-action listener: _resource_record_pre_action 06:46:18 INFO - Running main action method: run_tests 06:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:46:18 INFO - Python 2.7.3 06:46:18 INFO - Return code: 0 06:46:18 INFO - grabbing minidump binary from tooltool 06:46: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')]} 06:46:18 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 0x278a640>, '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 0x278b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278b9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:46:18 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 06:46:18 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 06:46:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:46:18 INFO - Return code: 0 06:46:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:46:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:46:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:46:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:46:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:46:19 INFO - Return code: 0 06:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:46:19 INFO - Using env: {'DISPLAY': ':0', 06:46:19 INFO - 'HOME': '/home/cltbld', 06:46:19 INFO - 'LANG': 'en_US.UTF-8', 06:46:19 INFO - 'LANGUAGE': 'en_US:en', 06:46:19 INFO - 'LOGNAME': 'cltbld', 06:46:19 INFO - 'MAIL': '/var/mail/cltbld', 06:46:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:46:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:19 INFO - 'MOZ_NO_REMOTE': '1', 06:46:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:19 INFO - 'NO_EM_RESTART': '1', 06:46:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:19 INFO - 'PWD': '/builds/slave/test', 06:46:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:46:19 INFO - 'SHELL': '/bin/bash', 06:46:19 INFO - 'SHLVL': '1', 06:46:19 INFO - 'TERM': 'linux', 06:46:19 INFO - 'TMOUT': '86400', 06:46:19 INFO - 'USER': 'cltbld', 06:46:19 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255', 06:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:19 INFO - '_': '/tools/buildbot/bin/python'} 06:46:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:46:20 INFO - mozversion application_buildid: 20160420053850 06:46:20 INFO - mozversion application_changeset: 19b8851d8d4c19997ecc73960f4de8d90c981c28 06:46:20 INFO - mozversion application_display_name: Nightly 06:46:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:46:20 INFO - mozversion application_name: Firefox 06:46:20 INFO - mozversion application_remotingname: firefox 06:46:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:46:20 INFO - mozversion application_vendor: Mozilla 06:46:20 INFO - mozversion application_version: 48.0a1 06:46:20 INFO - mozversion platform_buildid: 20160420053850 06:46:20 INFO - mozversion platform_changeset: 19b8851d8d4c19997ecc73960f4de8d90c981c28 06:46:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:46:20 INFO - mozversion platform_version: 48.0a1 06:46:20 INFO - using testdate: 1461159980 06:46:20 INFO - actual date: 1461159980 06:46:20 INFO - starting webserver on 'localhost:45464' 06:46:20 INFO - SUITE-START | Running 2 tests 06:46:20 INFO - TEST-START | dromaeo_css 06:46:20 INFO - operating with platform_type : linux_ 06:46:20 INFO - Initialising browser for dromaeo_css test... 06:46:20 INFO - TEST-INFO | started process 19907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1S3MVQ/profile http://localhost:45464/getInfo.html) 06:46:24 INFO - PROCESS | 19907 | 06:46:24 INFO - PROCESS | 19907 | (process:19978): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:46:25 INFO - PROCESS | 19907 | __metrics Screen width/height:1600/1200 06:46:25 INFO - PROCESS | 19907 | colorDepth:24 06:46:25 INFO - PROCESS | 19907 | Browser inner width/height: 1024/697 06:46:25 INFO - PROCESS | 19907 | __metrics 06:46:25 ERROR - PROCESS | 19907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:46:26 INFO - TEST-INFO | 19907: exit 0 06:46:26 INFO - Browser initialized. 06:46:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:46:26 INFO - TEST-INFO | started process 20029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1S3MVQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:28 INFO - PROCESS | 20029 | 06:46:28 INFO - PROCESS | 20029 | (process:20089): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:46:38 INFO - PROCESS | 20029 | RSS: Main: 164749312 06:46:38 INFO - PROCESS | 20029 | 06:47:28 INFO - PROCESS | 20029 | 1461160048204 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] 06:49:39 INFO - PROCESS | 20029 | Cycle 1(1): loaded http://localhost:45464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45464/tests/dromaeo/cssquery-ext.html) 06:49:41 INFO - PROCESS | 20029 | RSS: Main: 169795584 06:49:41 INFO - PROCESS | 20029 | 06:52:43 INFO - PROCESS | 20029 | Cycle 1(1): loaded http://localhost:45464/tests/dromaeo/cssquery-ext.html (next: http://localhost:45464/tests/dromaeo/cssquery-jquery.html) 06:52:43 INFO - PROCESS | 20029 | RSS: Main: 165666816 06:52:43 INFO - PROCESS | 20029 | 06:55:45 INFO - PROCESS | 20029 | Cycle 1(1): loaded http://localhost:45464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45464/tests/dromaeo/cssquery-mootools.html) 06:55:46 INFO - PROCESS | 20029 | RSS: Main: 167198720 06:55:46 INFO - PROCESS | 20029 | 06:58:48 INFO - PROCESS | 20029 | Cycle 1(1): loaded http://localhost:45464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45464/tests/dromaeo/cssquery-prototype.html) 06:58:48 INFO - PROCESS | 20029 | RSS: Main: 165060608 06:58:48 INFO - PROCESS | 20029 | 07:01:51 INFO - PROCESS | 20029 | Cycle 1(1): loaded http://localhost:45464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45464/tests/dromaeo/cssquery-yui.html) 07:01:52 INFO - PROCESS | 20029 | RSS: Main: 166498304 07:01:52 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | Cycle 1(1): loaded http://localhost:45464/tests/dromaeo/cssquery-yui.html (next: http://localhost:45464/tests/dromaeo/cssquery-dojo.html) 07:04:54 INFO - PROCESS | 20029 | RSS: Main: 168718336 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | __start_tp_report 07:04:54 INFO - PROCESS | 20029 | _x_x_mozilla_page_load 07:04:54 INFO - PROCESS | 20029 | _x_x_mozilla_page_load_details 07:04:54 INFO - PROCESS | 20029 | |i|pagename|runs| 07:04:54 INFO - PROCESS | 20029 | |0;dojo.html;2613.7386261373863;2667.62653228548;2689.9327516812077;2703.95944060839;2720.387912719637;4758.381410416645;4781.6413768967295;4818.229083346665;4834.4923783002805;4873.585745211662;4677.859664210071;4843.588294994921;4876.317315575822;4886.267059941002;4918.237673160657;4436.134953684033;4469.597736203741;4509.909801803962;4510.413646226002;4557.225271703818;4431.113777244548;4480.126375356806;4507.301368287921;4522.3216517522305;4527.52460991596;4285.8499952501825;4301.247281725686;4373.540778218273;4438.8224471021285;4527.094581083797;4377.430933978594;4393.868183954486;4409.250427427345;4410.073884484262;4452.710573812692;4376.737395756233;4406.603405693471;4416.514183439819;4420.4253447052;4448.132614140244;4710.646701497367;4747.786349614275;4759.571638552547;4782.13921494131;4806.255030470283;5139.717315547643;5141.357330333708;5158.561522270612;5160.638755287094;5188.481151884819;5067;5178.533931946105;5199.688018718851;5203.531682148625;5207.6875387476875;4814.085323788469;4852.708837469763;4854.781534830941;4900.093482705711;4905.583025442806;5306.575473962073;5349.491798279158;5378.757955891994;5386.542143917733;5411.972940135274;4987.952529968675;5072.391313042384;5091.0836049511445;5094.083065048253;5123.2827404163445;5165.328507294028;5209.661372010807;5214.191800270888;5226.398964119099;5269.604779641542;4969.304297398367;5053.974730126326;5054.317667114966;5056.646034777604;5060.139776238048;5074.23886417033;5127.2052831811125;5181.637285390062;5221.947780522222;5233.450487698813;3988.062805240766;4051.756894586334;4052.2908491013955;4053.594640535982;4100.036491424513;3561.4301711726;3594.9101272468397;3601.1177261571083;3620.8913732588067;3628.129248980226;4504.639628829751;4527.253003254492;4532.138893610204;4551.180787458223;4571.862844114682;5213.478652134832;5216.504432078947;5223.791048358099;5228.9738551307;5257.00116977773;4541.591256786905;4544.613707834805;4547;4564.475085365226;4582.404287442611;4615.23848564983;4697.177993851063;4698.248280275139;4703.95296047042;4746.620270378361;4783.784729687172;4884.804607815648;4948.282499037691;4971.304017437489;4998.6750861193905;5180.896382072262;5198.74006299676;5210.244514545446;5227.660202086852;5232.816851410183;4913.7543122843;4927.581155601814;4932.3094766731965;4932.7286999215385;4954.8761280968265;4946.480619535041;5103.770330335218;5144.922826157685;5162.122439185272;5189.818356357509;5172.353455818023;5193.143131383279;5211.817586384458;5216.66091704038;5284.128118860345;4850.223964165716;5045.520675535819;5045.5459008689395;5048.949510504995;5052.418971818141;4900.68145570551;5064.898702026013;5101.7194054327365;5134.4352121267375;5134.640575159703;4888.071266459361;4940.530649588283;4958.206686930218;4980.103581355391;5037.319961805256;5041.395032596112;5043.067032598834;5048.419431765394;5056.039352523009;5114.105031619377;4824.396950381202;4870.878228044327;4910.9263361050325;4911.7298548580175;4916.92624610624 07:04:54 INFO - PROCESS | 20029 | |1;ext.html;565.3357305166431;597.4652685846168;614.0543562913111;618.2086928731225;634.7207228819316;31961.680383196162;33346.16634584137;33430.164245893866;33432.164195895115;33450;36721.449178262345;37068.07329816756;37101.44347834778;37404.81297593515;37550.62449375505;7735.883961740578;7839;7883.251091146332;7893.697539905937;7917.089534703497;7622.2758837910305;7756.418268629847;7779.8444031119625;7788.260115289038;7807.570583617899;7806.921930780704;7858.960705196466;7877.2122787721055;7894.250046245597;7900.130985591581;7753.573553454586;7784.416168787364;7785.1436342002335;7792.220777922219;7828.138904720477;7733.1880152583735;7821.217878212134;7868.645910934022;7874;7874.173211812735;30451.695483045107;34140.658593413995;34902.65097349019;35001;35030.82484587586;3021.54676798482;3189.1867573768773;3218.09893229896;3631.9818400907825;3791.9241615167816;27161;27242.5913611296;27457.86271068632;27533;27991.30021749452;3326.417876871538;3326.933461330784;3343.264481813997;3393.5927688677516;3557.4663800429885;187799;191562;192569.9999999986;193128;193134;33837.30813459317;35259;57612;58433;58482.415175848546;34213.65786342155;34293;34328.313433731186;34335.484967725;34337.65662343395;12703.555375561997;12842.165259258305;12890.419931103123;12926.935365323114;13043.021773366845;10625.893741062646;10831.67504974852;10857.294275872044;10872.891271087346;10947.178961577914;8328.458650187718;8329.791755206168;8410.243078122998;8432.156784321518;8463.661453541912;3299.6535363786456;3314.303996160785;3330.4171769940162;3336.6162891267813;3377.628460869302;910.349100393222;942.5711301357866;972.7324985629009;990.3958585262984;995.8904520502739;27110.322241944108;28477.57283640747;28565.71434285672;28607.427851442855;29219.269518262212;1004.6483730694345;1030.845373194027;1047.6804574604666;1061.368485750977;1068.4444089073793;14812.777808332883;15270.923645381925;15373.308201130976;15540.844591554165;15569;341022;344239;346563;346756;348011;48469.75765121152;48911;49174.26238606352;49302.75348623234;49374.25938610924;1192.2548407245472;1225.8161275808523;1259.6535952612921;1263.4819723913151;1270.510853321478;26008;27921.720782792723;27981;28016.159515214575;28228.71771282261;43045.784771075945;43126.568734312255;43425;43550.346744799484;43605.78197108994;315513;317718;317996;318188;318749;25714.485710286062;26051.609225861248;26138.607920881583;26139.215823525326;39140.804295978334;38498.80750596229;38803.41794873136;39403.60596394114;39498;41434.58565414307;33828;33869.66130338665;34011;34080.31839363149;34464.310713786086;33296.1675958103;33966;34062.14844628805;34290.65709342974;34400.311993760486;31707.841460792548;34565.82717086499;35388.46917296191;36257.81871090628;37831;28460.857695711387;29427.411451771273;29793.10620681383;29949.55075673823;30087.398252035273;22775.430614234778;23480.530389391773;24430.144944926844;24868.37829054288;25233.747662523874 07:04:54 INFO - PROCESS | 20029 | |2;jquery.html;381.77856843031026;387.5156054931335;389.287603685256;392.77415486095487;407.86132714876936;15085.472008479705;16366.590835229124;16500.422485213036;16512.25694843732;16541.83458165418;15513.612159696013;16237.756433653505;16327.673446531062;16345.34618615254;16413.343466261365;4800.5679488846;4906.656534042619;4955.529224723664;4977.178765503688;4985.825496107637;3468.1329667583104;5234.398044224925;5537.252470916435;5541.944580554183;5559.9444005559835;5433.049216387136;5505.807296744615;5512.944870551283;5518.613697041189;5525.723713814314;5909.290885093773;6014.969925150346;6048.546359023069;6068.514518838482;6077.118817771398;5195.272661827347;5419.458054194549;5426.728663566806;5457;5460.399356070829;12376.504939802397;12397.318147501885;12504.37478126099;12562;13224.338783060904;2004.4788355027797;2007.3175120458968;2032.217596225464;2033.166401775265;2150.2796563151205;8916.286697064219;9017.81964360709;9128.995810460843;9473.573689184002;9495.145436910641;1767.7525146479504;1773.2818208625526;1777.8222177782247;1823.5349985753548;1842.769653793276;61022.694886525285;66399.66800166016;67982;69956.30043699549;71692.28307716908;9624.422534647943;9891.406515609087;10371.429571373495;10412.479376031168;10608.469576521144;14526.201058941648;14526.709465810836;14547.636309092357;14569.41722331116;14596.12423254608;7107.466939979522;7162.104736907887;7251.311125443074;7286.23494533077;7289.052423185058;6818.318168183142;6883.621400823003;6919.930800692029;6967.965160174268;7010.334018268256;4310.577509421946;4325.675574331937;4348;4370.912581748411;4383.539728328544;1697.3125884016993;1832.0839580209895;1844.020382850903;1863.6552237836045;1918.3669389101842;887.5517863479031;895.3687650206589;896.3770179725159;945.4705364995624;999.8200323941614;16368.263428145761;16416.343346266014;16486.17569121539;16715.582110447336;16750.58123546921;882.5631312500353;899.604174163366;912.8995810460844;925.0794912559672;925.444733160112;9192.678256260999;9238.260939124853;9321.207697345802;9391.342606017513;9572.377795443273;379736;384061;408473;410654;415091;81551.59224203842;82584;83563;83781.58109209537;83803.58098209593;916.9908300917039;953.4327075390132;986.8865080515689;1005.2360206243162;1011.4234886114843;14618.561443156723;14656.70686586241;14696.265186740406;14735.968482206143;14921.253937302874;31348.68651313549;32268.677313227505;34242.657573423945;36652.63347366492;38136.809315953244;44588.10823783571;46613.30080048734;48214.75892620515;48387.27419088646;49223.32378424044;7432.554046757212;7627.313541781266;7731.652075656497;7781.805454863674;7854.3323817473865;8330.208630180123;10495.632652857113;11793.469293881968;11798.469068892093;11850.229735067192;9786;10124.34191777532;10164.390136591828;10196.643117490852;10355;10056.245781566266;10203.94898025505;10212.846807297748;10270.383776973405;10289.485525723834;10036.799264014824;10178.847317290098;10314.278000540191;10380.948095259475;10390.116840068678;7578.621068946641;7603.20166382544;7662.080550333772;7765.650545725343;7873.488223265469;8836.381453298207;9682.85475717879;9728.708138755848;9767.267454940766;9963.25275604347 07:04:54 INFO - PROCESS | 20029 | |3;mootools.html;1442.5888621742802;1464.5899148238493;1630.6412589230365;1771.096740662262;1815.3736960748538;6811.114555107842;7488.251174882515;7591.468597198198;7735.381169506433;7747.961260193705;7529.510581812178;7592.354649854755;7665.348445382136;7674.040744906887;7697.884531732015;2252.8760918149455;2265.422317309084;2268.7731226877263;2273.6021196290667;2289.061484791236;2213.712217411742;2222.7332720073614;2232.598132336179;2253.583087128878;2255.1881322723807;2237.7538470768204;2268.0247493577754;2270.7842754938256;2289.919852805152;2305.227748704186;2234.9329520114425;2239.8656080635133;2243.6298010828195;2244.618414869476;2246.539459410825;2163.9242626508153;2195.538936823269;2196.4399078235106;2208.503086805472;2212.0156530344;7781.182975787574;7826.217378262185;7826.8434631307055;7828.021497312836;7836.843263134705;4617.353570500132;4747.192977193886;4801.663883528155;4812.446568644616;4827.155247831615;2895.131460561823;3045.7258846703903;3049.1614805928325;3080.0451859923496;3080.5687203791263;1802.8647851411197;1806.8102849200777;1843.4653950354382;1844.6126313474188;1849.4544109487733;10175.084242418145;10185.490725463696;10210.540525676362;10287.639932602398;10318.484075796181;4078.4290199372113;4124.443200167999;4258.127083947783;4276.764777937181;4292.849750258726;8377.45546539473;8380.078191398941;8408.705695300636;8410.411271210956;8427.95786021066;4730.053989202104;4741.099191153669;4745.691530050535;4748.074125545554;4748.548887855648;3798.2783271178387;4238.427812245307;4326.4159338489535;4370.781460926941;4410.845620403271;3374.797512149279;3377.121948293461;3454.4127498325347;3473.14907847579;3490.214701692099;1090.487470888681;1095.5891540672249;1097.05653138301;1101.2126329674322;1113.716002419378;902.2962089570015;920.59953920045;924.5146298193367;931.9998209605418;940.8259471997702;5370.785168593291;5565.471280228372;5614.719264036782;5743.0811070228565;5840.59115861894;873.4802792338548;894.1996912763041;954.4559601027487;965.5510187762724;969.0454901921602;3613.602503724588;3662.4506324051604;3665.52348194733;3673.7612055216327;3727.8136093195776;9191.954040229755;9588.520573971273;9676.371035882645;9700.611975521042;9729;9448.622055117856;9500.144986951207;9617.615295388247;9623.711288661352;9688.224942004623;6875.3812156906115;6905.343992320822;6972.755953541703;7019.262977387403;7046.929530704628;4545.090981803719;4689.413823272091;4692.272697731857;4692.671512994194;4696.976515117402;8386.37102217324;8451.704190353308;8488.915110849059;8501.617427215913;8577.914220857712;8385.53879536607;8444.451110677786;8687.348448866487;8690.087540808125;8751.824963500821;5542.445755424425;6304.211973503312;6307.779227727007;6456.386643268882;6512.902306465501;7320.231375705474;7382.52013619113;7450;7469.962650186714;7470.589117598584;6613.503987200883;6846.246912839484;6894.379505844498;7037.824054398681;7053.612051337226;6833.760818371333;6894.655267236518;6933.202681691469;6964.825879353057;6977.476689248225;6364.777232797015;6410.391012853772;6410.711517981609;6538.215414150332;6544.214694236532;4812.8796780080775;4860.95139048605;4896.926546101882;4949.257611358181;4951.059298733229;4822.324874517641;4822.9758851205515;4846.17615005457;4864.027194561173;4938.1358262304675 07:04:54 INFO - PROCESS | 20029 | |4;prototype.html;306.20692406666734;311.8113541307509;314.28029811731153;315.9462891308478;321.4904376563147;5412.539934105601;5440.945590544098;5447.782088716446;5465.207544905991;5469.316335458067;5351.491608297206;5353.705546194958;5355.278081733197;5364.973175134119;5375.731213439322;3939.4287828264814;4014.2172276406113;4140.730852494593;4144.606262405082;4161.25097482453;4127.112670775783;4128.649064829493;4133.545310015896;4144.212599606065;4147.025449019478;4112.403701463286;4113.465249517559;4120.855770048049;4120.979395103021;4126.938095928564;4027.677785777131;4110.157417729359;4115.32097203961;4119.3409054551275;4124.752514849089;3603.9099022524383;3633.382325004729;3639.5268615080136;3641.308151451216;3645.0340659725193;5041.521055499722;5068.682142642902;5075.213341932006;5084.271347741748;5097.413797413271;4601.976990115061;4746.952530474686;4770.976145119253;4782.497837727058;4806.534007127824;5576.609637325389;5585.441455854423;5610.551155907518;5630.071038278679;5630.352509461423;3965.4250133730447;3988.441618173458;4002.7198096133284;4004.2992476316526;4017.4777278953843;5560.916586251209;5853.326867410217;5854.297484301868;5865;5911.852203694899;3939.783311917872;4002.639762421396;4003.159336539301;4015.2371049500503;4032.193561287754;4072.3484242521054;4079.5716449772344;4081.5306239782212;4086.1010577672864;4093.16090201508;4579.816807327669;4686.507916668701;4700.106979673851;4701.459332176775;4711.7879695413785;5617.651763576794;5626.212330273765;5626.381098079208;5665.971670141623;5671.347795003628;1383.8477767445572;1404.5392791496934;1411.4213172599184;1414.1161773891317;1415.9079659822078;884.2263019857625;916.848719961199;925.893522244937;938.8592859675528;941.0918463682442;4839.346688197119;4845.563899249085;4848.878778030577;4851.878703032452;4855.271709243571;5669;5672.914906276409;5676.858078548069;5689.630174038674;5693.715314234271;4694.976525117421;4796.448408433075;4829.154897892855;4836.46798852126;4927.384076990376;3096.6903309669306;3117.922051948674;3131.4989601663624;3132.6554079051284;3141.167590588496;5530.806421775299;5537.390887002426;5544.112941929272;5553.361363443256;5562.888742225133;5950.553708471882;6056.545759068;6084.361142080018;6088.847778805477;6099.542534309944;5456.290682211287;5459.317585301837;5465.672059676433;5493.99999999992;5527.143292789624;5650.406707295675;5804.883902322014;5817.970910145422;5828.795992140254;5853;5813.79651712188;5820.272465941757;5828.242328497268;5834.15404766315;5842.2405087338375;5438.891222175455;5488.9725551371985;5519.641223320471;5537.169424586345;5540.556755459635;3912.882613521599;3987.561368249548;4012.976690943791;4020.718549701493;4031.576684448091;5804.5356371491025;5830.854228644318;5835.270591176103;5858.209141765978;5865.677387743715;5654.180143879033;5658.971705141613;5666.943330566642;5672.14917762339;5674.092145256739;5453.209284653623;5648.774049038157;5668.744906479301;5681.517071049007;5689.857753556029;5297.470252974672;5520.392756796829;5559.19391688211;5564.38791732901;5596.5242954347705;5516.475934786189;5691.8861622768145;5700.116481945305;5710.5146062585145;5736.483716465538;5507.917381239365;5529.33647962231;5538.141588053858;5547.8890422192135;5567.415421380859 07:04:54 INFO - PROCESS | 20029 | |5;yui.html;655.6688872119579;741.5921243316182;758.4084414156956;783.5298820707575;795.3915254830056;11571.305721656707;11988.700282492942;12089.758204835898;12133.211341262811;12179.57371491998;10955.766192733006;10995.34027958323;11072.778544429106;11098.4450777461;11572.132090093255;785.9096203936534;810.5501446697095;819.5492479136451;822.6832669422286;823.9093699693029;808.9069756977964;811.1401913971209;813.4102775487754;813.5728742410223;813.6297984417106;836.4061516323418;840.5713086325987;844.0082902589463;845.8181490979438;848.1476116502906;835.0563862835019;836.0302049622439;836.7196989008689;836.9790755231168;839.937004724645;615.2125279642065;616.9475594574467;618.4434009391539;621.5307442880642;621.7730528357163;11834.467448964731;11856.466459009365;11858.822117668242;11926.522939082513;11939.94030029853;12402.13185077045;12519.499220031188;12627.305498197595;12682.492700291978;12770.936145319214;10042.899571004342;10075.34510256831;10160;10312.89687103127;10423.478826058743;3248.3828072666356;3274.746436642824;3280.8195549244783;3338.2488939988552;3340.766146369755;46284;46525.76737116327;46777.298340524576;47153.29270060952;47599.5240047602;9156.725298241063;9865.172003919053;10062.597496100221;10081.19350451962;10116.08955194036;17493.475195744148;17496.38762643327;17509;17521.64956700859;17567.47297581049;6624.768133115318;6766.898496522556;6810.829729256809;6815.352541508549;6860.6912688929115;3868.4777555030273;3901.804909754501;3909.6090390960676;3929.2458207157647;3939.2909276330533;2818.5631227159824;2875.3961668049524;2906.8401237932117;2908.3892382599893;2913.126062181337;501.51353187408154;513.3070355020692;515.564348125833;521.2259794205602;522.0029743190564;512.5131125430855;596.8120042186785;596.9492593129632;597.3548567547039;643.0419373009198;7205.855882882313;7443.330100291;7502.6623801929045;7710.228977102245;7941.6029198539845;526.7287347016289;570.1020892094967;584.6492104737124;601.2664549249909;616.4328817487922;3509.8771542996383;3535.416656251741;3536.381133301662;3611.530501034849;3650.1604630935035;52120.73939630278;53596.19605705918;53600;53944.73027634837;54007.45992540103;40137.59862401397;41684.79157604193;42146.36780448296;43918;45895.31157032647;39124.26130170918;39285.80357098196;39513.802430987664;40054.79972600118;41230.58769412328;8126.918730812853;8432.114627963976;8549.957250213709;8578.871316930376;8868.95565522194;28681.42637147287;29027;29142.708572913998;29418;29660.555091674072;35361.64638353584;36658.45012324764;38379.232415350976;38720.6127938717;38840.41739373855;9756.560954756911;9762.121409073217;9821.656242031495;10535.473226338805;10747.570097196025;11776.764464710486;11794.351310677996;11808.82286765682;11855.407229638311;12096;10892.455377230948;10916.836247456136;10932.398718070264;11147.777044458902;11254.718632034264;11051.17116216271;11413.771724565297;11588.917641651817;11732.530698771954;12158.878411216128;10974.451277435937;11038.227324087558;11297.209195356574;11421.657350279505;11738.530458781896;9555.856662150212;9608.375455595364;9794.510274486389;9840.212782977487;9867.358621689567;9628.71113866585;9698.95150524271;9699.563519641773;9739.513024348613;9772.511374431393 07:04:54 INFO - PROCESS | 20029 | __end_tp_report 07:04:54 INFO - PROCESS | 20029 | __start_cc_report 07:04:54 INFO - PROCESS | 20029 | _x_x_mozilla_cycle_collect,372 07:04:54 INFO - PROCESS | 20029 | __end_cc_report 07:04:54 INFO - PROCESS | 20029 | __startTimestamp1461161094586__endTimestamp 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | ------- Summary: start ------- 07:04:54 INFO - PROCESS | 20029 | Number of tests: 6 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | [#0] dojo.html Cycles:165 Average:4769.20 Median:4911.73 stddev:530.93 (10.8%) stddev-sans-first:504.91 07:04:54 INFO - PROCESS | 20029 | Values: 2613.7 2667.6 2689.9 2704.0 2720.4 4758.4 4781.6 4818.2 4834.5 4873.6 4677.9 4843.6 4876.3 4886.3 4918.2 4436.1 4469.6 4509.9 4510.4 4557.2 4431.1 4480.1 4507.3 4522.3 4527.5 4285.8 4301.2 4373.5 4438.8 4527.1 4377.4 4393.9 4409.3 4410.1 4452.7 4376.7 4406.6 4416.5 4420.4 4448.1 4710.6 4747.8 4759.6 4782.1 4806.3 5139.7 5141.4 5158.6 5160.6 5188.5 5067.0 5178.5 5199.7 5203.5 5207.7 4814.1 4852.7 4854.8 4900.1 4905.6 5306.6 5349.5 5378.8 5386.5 5412.0 4988.0 5072.4 5091.1 5094.1 5123.3 5165.3 5209.7 5214.2 5226.4 5269.6 4969.3 5054.0 5054.3 5056.6 5060.1 5074.2 5127.2 5181.6 5221.9 5233.5 3988.1 4051.8 4052.3 4053.6 4100.0 3561.4 3594.9 3601.1 3620.9 3628.1 4504.6 4527.3 4532.1 4551.2 4571.9 5213.5 5216.5 5223.8 5229.0 5257.0 4541.6 4544.6 4547.0 4564.5 4582.4 4615.2 4697.2 4698.2 4704.0 4746.6 4783.8 4884.8 4948.3 4971.3 4998.7 5180.9 5198.7 5210.2 5227.7 5232.8 4913.8 4927.6 4932.3 4932.7 4954.9 4946.5 5103.8 5144.9 5162.1 5189.8 5172.4 5193.1 5211.8 5216.7 5284.1 4850.2 5045.5 5045.5 5048.9 5052.4 4900.7 5064.9 5101.7 5134.4 5134.6 4888.1 4940.5 4958.2 4980.1 5037.3 5041.4 5043.1 5048.4 5056.0 5114.1 4824.4 4870.9 4910.9 4911.7 4916.9 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | [#1] ext.html Cycles:180 Average:42867.79 Median:187551.16 stddev:77134.55 (41.1%) stddev-sans-first:77285.54 07:04:54 INFO - PROCESS | 20029 | Values: 565.3 597.5 614.1 618.2 634.7 31961.7 33346.2 33430.2 33432.2 33450.0 36721.4 37068.1 37101.4 37404.8 37550.6 7735.9 7839.0 7883.3 7893.7 7917.1 7622.3 7756.4 7779.8 7788.3 7807.6 7806.9 7859.0 7877.2 7894.3 7900.1 7753.6 7784.4 7785.1 7792.2 7828.1 7733.2 7821.2 7868.6 7874.0 7874.2 30451.7 34140.7 34902.7 35001.0 35030.8 3021.5 3189.2 3218.1 3632.0 3791.9 27161.0 27242.6 27457.9 27533.0 27991.3 3326.4 3326.9 3343.3 3393.6 3557.5 187799.0 191562.0 192570.0 193128.0 193134.0 33837.3 35259.0 57612.0 58433.0 58482.4 34213.7 34293.0 34328.3 34335.5 34337.7 12703.6 12842.2 12890.4 12926.9 13043.0 10625.9 10831.7 10857.3 10872.9 10947.2 8328.5 8329.8 8410.2 8432.2 8463.7 3299.7 3314.3 3330.4 3336.6 3377.6 910.3 942.6 972.7 990.4 995.9 27110.3 28477.6 28565.7 28607.4 29219.3 1004.6 1030.8 1047.7 1061.4 1068.4 14812.8 15270.9 15373.3 15540.8 15569.0 341022.0 344239.0 346563.0 346756.0 348011.0 48469.8 48911.0 49174.3 49302.8 49374.3 1192.3 1225.8 1259.7 1263.5 1270.5 26008.0 27921.7 27981.0 28016.2 28228.7 43045.8 43126.6 43425.0 43550.3 43605.8 315513.0 317718.0 317996.0 318188.0 318749.0 25714.5 26051.6 26138.6 26139.2 39140.8 38498.8 38803.4 39403.6 39498.0 41434.6 33828.0 33869.7 34011.0 34080.3 34464.3 33296.2 33966.0 34062.1 34290.7 34400.3 31707.8 34565.8 35388.5 36257.8 37831.0 28460.9 29427.4 29793.1 29949.6 30087.4 22775.4 23480.5 24430.1 24868.4 25233.7 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | [#2] jquery.html Cycles:180 Average:24228.83 Median:25706.93 stddev:66065.21 (257.0%) stddev-sans-first:66226.28 07:04:54 INFO - PROCESS | 20029 | Values: 381.8 387.5 389.3 392.8 407.9 15085.5 16366.6 16500.4 16512.3 16541.8 15513.6 16237.8 16327.7 16345.3 16413.3 4800.6 4906.7 4955.5 4977.2 4985.8 3468.1 5234.4 5537.3 5541.9 5559.9 5433.0 5505.8 5512.9 5518.6 5525.7 5909.3 6015.0 6048.5 6068.5 6077.1 5195.3 5419.5 5426.7 5457.0 5460.4 12376.5 12397.3 12504.4 12562.0 13224.3 2004.5 2007.3 2032.2 2033.2 2150.3 8916.3 9017.8 9129.0 9473.6 9495.1 1767.8 1773.3 1777.8 1823.5 1842.8 61022.7 66399.7 67982.0 69956.3 71692.3 9624.4 9891.4 10371.4 10412.5 10608.5 14526.2 14526.7 14547.6 14569.4 14596.1 7107.5 7162.1 7251.3 7286.2 7289.1 6818.3 6883.6 6919.9 6968.0 7010.3 4310.6 4325.7 4348.0 4370.9 4383.5 1697.3 1832.1 1844.0 1863.7 1918.4 887.6 895.4 896.4 945.5 999.8 16368.3 16416.3 16486.2 16715.6 16750.6 882.6 899.6 912.9 925.1 925.4 9192.7 9238.3 9321.2 9391.3 9572.4 379736.0 384061.0 408473.0 410654.0 415091.0 81551.6 82584.0 83563.0 83781.6 83803.6 917.0 953.4 986.9 1005.2 1011.4 14618.6 14656.7 14696.3 14736.0 14921.3 31348.7 32268.7 34242.7 36652.6 38136.8 44588.1 46613.3 48214.8 48387.3 49223.3 7432.6 7627.3 7731.7 7781.8 7854.3 8330.2 10495.6 11793.5 11798.5 11850.2 9786.0 10124.3 10164.4 10196.6 10355.0 10056.2 10203.9 10212.8 10270.4 10289.5 10036.8 10178.8 10314.3 10380.9 10390.1 7578.6 7603.2 7662.1 7765.7 7873.5 8836.4 9682.9 9728.7 9767.3 9963.3 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | [#3] mootools.html Cycles:180 Average:5122.25 Median:4880.48 stddev:2721.93 (55.8%) stddev-sans-first:2715.52 07:04:54 INFO - PROCESS | 20029 | Values: 1442.6 1464.6 1630.6 1771.1 1815.4 6811.1 7488.3 7591.5 7735.4 7748.0 7529.5 7592.4 7665.3 7674.0 7697.9 2252.9 2265.4 2268.8 2273.6 2289.1 2213.7 2222.7 2232.6 2253.6 2255.2 2237.8 2268.0 2270.8 2289.9 2305.2 2234.9 2239.9 2243.6 2244.6 2246.5 2163.9 2195.5 2196.4 2208.5 2212.0 7781.2 7826.2 7826.8 7828.0 7836.8 4617.4 4747.2 4801.7 4812.4 4827.2 2895.1 3045.7 3049.2 3080.0 3080.6 1802.9 1806.8 1843.5 1844.6 1849.5 10175.1 10185.5 10210.5 10287.6 10318.5 4078.4 4124.4 4258.1 4276.8 4292.8 8377.5 8380.1 8408.7 8410.4 8428.0 4730.1 4741.1 4745.7 4748.1 4748.5 3798.3 4238.4 4326.4 4370.8 4410.8 3374.8 3377.1 3454.4 3473.1 3490.2 1090.5 1095.6 1097.1 1101.2 1113.7 902.3 920.6 924.5 932.0 940.8 5370.8 5565.5 5614.7 5743.1 5840.6 873.5 894.2 954.5 965.6 969.0 3613.6 3662.5 3665.5 3673.8 3727.8 9192.0 9588.5 9676.4 9700.6 9729.0 9448.6 9500.1 9617.6 9623.7 9688.2 6875.4 6905.3 6972.8 7019.3 7046.9 4545.1 4689.4 4692.3 4692.7 4697.0 8386.4 8451.7 8488.9 8501.6 8577.9 8385.5 8444.5 8687.3 8690.1 8751.8 5542.4 6304.2 6307.8 6456.4 6512.9 7320.2 7382.5 7450.0 7470.0 7470.6 6613.5 6846.2 6894.4 7037.8 7053.6 6833.8 6894.7 6933.2 6964.8 6977.5 6364.8 6410.4 6410.7 6538.2 6544.2 4812.9 4861.0 4896.9 4949.3 4951.1 4822.3 4823.0 4846.2 4864.0 4938.1 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | [#4] prototype.html Cycles:180 Average:4657.20 Median:5394.14 stddev:1378.28 (25.6%) stddev-sans-first:1342.90 07:04:54 INFO - PROCESS | 20029 | Values: 306.2 311.8 314.3 315.9 321.5 5412.5 5440.9 5447.8 5465.2 5469.3 5351.5 5353.7 5355.3 5365.0 5375.7 3939.4 4014.2 4140.7 4144.6 4161.3 4127.1 4128.6 4133.5 4144.2 4147.0 4112.4 4113.5 4120.9 4121.0 4126.9 4027.7 4110.2 4115.3 4119.3 4124.8 3603.9 3633.4 3639.5 3641.3 3645.0 5041.5 5068.7 5075.2 5084.3 5097.4 4602.0 4747.0 4771.0 4782.5 4806.5 5576.6 5585.4 5610.6 5630.1 5630.4 3965.4 3988.4 4002.7 4004.3 4017.5 5560.9 5853.3 5854.3 5865.0 5911.9 3939.8 4002.6 4003.2 4015.2 4032.2 4072.3 4079.6 4081.5 4086.1 4093.2 4579.8 4686.5 4700.1 4701.5 4711.8 5617.7 5626.2 5626.4 5666.0 5671.3 1383.8 1404.5 1411.4 1414.1 1415.9 884.2 916.8 925.9 938.9 941.1 4839.3 4845.6 4848.9 4851.9 4855.3 5669.0 5672.9 5676.9 5689.6 5693.7 4695.0 4796.4 4829.2 4836.5 4927.4 3096.7 3117.9 3131.5 3132.7 3141.2 5530.8 5537.4 5544.1 5553.4 5562.9 5950.6 6056.5 6084.4 6088.8 6099.5 5456.3 5459.3 5465.7 5494.0 5527.1 5650.4 5804.9 5818.0 5828.8 5853.0 5813.8 5820.3 5828.2 5834.2 5842.2 5438.9 5489.0 5519.6 5537.2 5540.6 3912.9 3987.6 4013.0 4020.7 4031.6 5804.5 5830.9 5835.3 5858.2 5865.7 5654.2 5659.0 5666.9 5672.1 5674.1 5453.2 5648.8 5668.7 5681.5 5689.9 5297.5 5520.4 5559.2 5564.4 5596.5 5516.5 5691.9 5700.1 5710.5 5736.5 5507.9 5529.3 5538.1 5547.9 5567.4 07:04:54 INFO - PROCESS | 20029 | 07:04:54 INFO - PROCESS | 20029 | [#5] yui.html Cycles:180 Average:12585.98 Median:41457.69 stddev:14141.02 (34.1%) stddev-sans-first:14152.31 07:04:54 INFO - PROCESS | 20029 | Values: 655.7 741.6 758.4 783.5 795.4 11571.3 11988.7 12089.8 12133.2 12179.6 10955.8 10995.3 11072.8 11098.4 11572.1 785.9 810.6 819.5 822.7 823.9 808.9 811.1 813.4 813.6 813.6 836.4 840.6 844.0 845.8 848.1 835.1 836.0 836.7 837.0 839.9 615.2 616.9 618.4 621.5 621.8 11834.5 11856.5 11858.8 11926.5 11939.9 12402.1 12519.5 12627.3 12682.5 12770.9 10042.9 10075.3 10160.0 10312.9 10423.5 3248.4 3274.7 3280.8 3338.2 3340.8 46284.0 46525.8 46777.3 47153.3 47599.5 9156.7 9865.2 10062.6 10081.2 10116.1 17493.5 17496.4 17509.0 17521.6 17567.5 6624.8 6766.9 6810.8 6815.4 6860.7 3868.5 3901.8 3909.6 3929.2 3939.3 2818.6 2875.4 2906.8 2908.4 2913.1 501.5 513.3 515.6 521.2 522.0 512.5 596.8 596.9 597.4 643.0 7205.9 7443.3 7502.7 7710.2 7941.6 526.7 570.1 584.6 601.3 616.4 3509.9 3535.4 3536.4 3611.5 3650.2 52120.7 53596.2 53600.0 53944.7 54007.5 40137.6 41684.8 42146.4 43918.0 45895.3 39124.3 39285.8 39513.8 40054.8 41230.6 8126.9 8432.1 8550.0 8578.9 8869.0 28681.4 29027.0 29142.7 29418.0 29660.6 35361.6 36658.5 38379.2 38720.6 38840.4 9756.6 9762.1 9821.7 10535.5 10747.6 11776.8 11794.4 11808.8 11855.4 12096.0 10892.5 10916.8 10932.4 11147.8 11254.7 11051.2 11413.8 11588.9 11732.5 12158.9 10974.5 11038.2 11297.2 11421.7 11738.5 9555.9 9608.4 9794.5 9840.2 9867.4 9628.7 9699.0 9699.6 9739.5 9772.5 07:04:54 INFO - PROCESS | 20029 | -------- Summary: end -------- 07:04:54 INFO - PROCESS | 20029 | 07:04:55 INFO - TEST-INFO | 20029: exit 0 07:04:55 INFO - TEST-OK | dromaeo_css | took 1115261ms 07:04:55 INFO - TEST-START | kraken 07:04:55 INFO - operating with platform_type : linux_ 07:04:55 INFO - Initialising browser for kraken test... 07:04:55 INFO - TEST-INFO | started process 20260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXLpeDV/profile http://localhost:45464/getInfo.html) 07:04:59 INFO - PROCESS | 20260 | 07:04:59 INFO - PROCESS | 20260 | (process:20327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:05:00 INFO - PROCESS | 20260 | __metrics Screen width/height:1600/1200 07:05:00 INFO - PROCESS | 20260 | colorDepth:24 07:05:00 INFO - PROCESS | 20260 | Browser inner width/height: 1024/697 07:05:00 INFO - PROCESS | 20260 | __metrics 07:05:00 ERROR - PROCESS | 20260 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:05:01 INFO - TEST-INFO | 20260: exit 0 07:05:01 INFO - Browser initialized. 07:05:01 INFO - Running cycle 1/1 for kraken test... 07:05:01 INFO - TEST-INFO | started process 20378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXLpeDV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:05:03 INFO - PROCESS | 20378 | 07:05:03 INFO - PROCESS | 20378 | (process:20439): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:05:13 INFO - PROCESS | 20378 | RSS: Main: 164843520 07:05:13 INFO - PROCESS | 20378 | 07:05:16 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45464/tests/kraken/driver.html?testName=audio-beat-detection) 07:05:17 INFO - PROCESS | 20378 | RSS: Main: 169127936 07:05:17 INFO - PROCESS | 20378 | 07:05:19 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45464/tests/kraken/driver.html?testName=audio-dft) 07:05:20 INFO - PROCESS | 20378 | RSS: Main: 172437504 07:05:20 INFO - PROCESS | 20378 | 07:05:23 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45464/tests/kraken/driver.html?testName=audio-fft) 07:05:24 INFO - PROCESS | 20378 | RSS: Main: 163647488 07:05:24 INFO - PROCESS | 20378 | 07:05:26 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45464/tests/kraken/driver.html?testName=audio-oscillator) 07:05:26 INFO - PROCESS | 20378 | RSS: Main: 163889152 07:05:26 INFO - PROCESS | 20378 | 07:05:29 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:05:29 INFO - PROCESS | 20378 | RSS: Main: 165396480 07:05:29 INFO - PROCESS | 20378 | 07:05:32 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45464/tests/kraken/driver.html?testName=imaging-darkroom) 07:05:33 INFO - PROCESS | 20378 | RSS: Main: 165347328 07:05:33 INFO - PROCESS | 20378 | 07:05:37 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45464/tests/kraken/driver.html?testName=imaging-desaturate) 07:05:37 INFO - PROCESS | 20378 | RSS: Main: 165076992 07:05:37 INFO - PROCESS | 20378 | 07:05:40 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45464/tests/kraken/driver.html?testName=json-parse-financial) 07:05:41 INFO - PROCESS | 20378 | RSS: Main: 165306368 07:05:41 INFO - PROCESS | 20378 | 07:05:43 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:05:43 INFO - PROCESS | 20378 | RSS: Main: 165531648 07:05:43 INFO - PROCESS | 20378 | 07:05:45 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:05:46 INFO - PROCESS | 20378 | RSS: Main: 165642240 07:05:46 INFO - PROCESS | 20378 | 07:05:48 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:05:49 INFO - PROCESS | 20378 | RSS: Main: 165904384 07:05:49 INFO - PROCESS | 20378 | 07:05:51 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:05:52 INFO - PROCESS | 20378 | RSS: Main: 166846464 07:05:52 INFO - PROCESS | 20378 | 07:05:55 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:05:56 INFO - PROCESS | 20378 | RSS: Main: 166100992 07:05:56 INFO - PROCESS | 20378 | 07:05:57 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:45464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45464/tests/kraken/driver.html?testName=ai-astar) 07:05:58 INFO - PROCESS | 20378 | RSS: Main: 167616512 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | __start_tp_report 07:05:58 INFO - PROCESS | 20378 | _x_x_mozilla_page_load 07:05:58 INFO - PROCESS | 20378 | _x_x_mozilla_page_load_details 07:05:58 INFO - PROCESS | 20378 | |i|pagename|runs| 07:05:58 INFO - PROCESS | 20378 | |0;ai-astar;116;107;114;113;115;126;115;114;113;113 07:05:58 INFO - PROCESS | 20378 | |1;audio-beat-detection;165;134;158;176;133;164;154;142;184;134 07:05:58 INFO - PROCESS | 20378 | |2;audio-dft;162;164;162;170;165;165;163;162;166;162 07:05:58 INFO - PROCESS | 20378 | |3;audio-fft;74;73;77;151;79;74;74;73;157;75 07:05:58 INFO - PROCESS | 20378 | |4;audio-oscillator;94;95;160;95;94;94;141;94;93;148 07:05:58 INFO - PROCESS | 20378 | |5;imaging-gaussian-blur;119;119;118;117;117;118;118;117;117;118 07:05:58 INFO - PROCESS | 20378 | |6;imaging-darkroom;147;147;146;146;148;147;147;147;147;147 07:05:58 INFO - PROCESS | 20378 | |7;imaging-desaturate;95;95;96;95;95;96;95;100;95;96 07:05:58 INFO - PROCESS | 20378 | |8;json-parse-financial;65;65;65;65;64;65;65;85;63;63 07:05:58 INFO - PROCESS | 20378 | |9;json-stringify-tinderbox;64;66;64;67;66;66;65;65;64;65 07:05:58 INFO - PROCESS | 20378 | |10;stanford-crypto-aes;79;80;78;81;88;80;82;82;81;81 07:05:58 INFO - PROCESS | 20378 | |11;stanford-crypto-ccm;135;133;143;139;143;144;140;138;169;146 07:05:58 INFO - PROCESS | 20378 | |12;stanford-crypto-pbkdf2;187;172;173;189;181;183;174;175;174;176 07:05:58 INFO - PROCESS | 20378 | |13;stanford-crypto-sha256-iterative;73;75;72;72;73;79;72;75;74;71 07:05:58 INFO - PROCESS | 20378 | __end_tp_report 07:05:58 INFO - PROCESS | 20378 | __start_cc_report 07:05:58 INFO - PROCESS | 20378 | _x_x_mozilla_cycle_collect,912 07:05:58 INFO - PROCESS | 20378 | __end_cc_report 07:05:58 INFO - PROCESS | 20378 | __startTimestamp1461161158188__endTimestamp 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | ------- Summary: start ------- 07:05:58 INFO - PROCESS | 20378 | Number of tests: 14 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:4.70 (4.1%) stddev-sans-first:4.95 07:05:58 INFO - PROCESS | 20378 | Values: 116.0 107.0 114.0 113.0 115.0 126.0 115.0 114.0 113.0 113.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:161.00 stddev:18.27 (11.3%) stddev-sans-first:18.97 07:05:58 INFO - PROCESS | 20378 | Values: 165.0 134.0 158.0 176.0 133.0 164.0 154.0 142.0 184.0 134.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:2.56 (1.6%) stddev-sans-first:2.60 07:05:58 INFO - PROCESS | 20378 | Values: 162.0 164.0 162.0 170.0 165.0 165.0 163.0 162.0 166.0 162.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.00 stddev:33.44 (45.2%) stddev-sans-first:34.92 07:05:58 INFO - PROCESS | 20378 | Values: 74.0 73.0 77.0 151.0 79.0 74.0 74.0 73.0 157.0 75.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:94.00 stddev:27.21 (28.9%) stddev-sans-first:28.17 07:05:58 INFO - PROCESS | 20378 | Values: 94.0 95.0 160.0 95.0 94.0 94.0 141.0 94.0 93.0 148.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 07:05:58 INFO - PROCESS | 20378 | Values: 119.0 119.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:05:58 INFO - PROCESS | 20378 | Values: 147.0 147.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 07:05:58 INFO - PROCESS | 20378 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 100.0 95.0 96.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:65.00 stddev:6.55 (10.1%) stddev-sans-first:6.93 07:05:58 INFO - PROCESS | 20378 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 65.0 85.0 63.0 63.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.00 07:05:58 INFO - PROCESS | 20378 | Values: 64.0 66.0 64.0 67.0 66.0 66.0 65.0 65.0 64.0 65.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.70 (3.3%) stddev-sans-first:2.74 07:05:58 INFO - PROCESS | 20378 | Values: 79.0 80.0 78.0 81.0 88.0 80.0 82.0 82.0 81.0 81.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:143.00 stddev:10.00 (7.0%) stddev-sans-first:10.18 07:05:58 INFO - PROCESS | 20378 | Values: 135.0 133.0 143.0 139.0 143.0 144.0 140.0 138.0 169.0 146.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:178.50 stddev:6.15 (3.4%) stddev-sans-first:5.68 07:05:58 INFO - PROCESS | 20378 | Values: 187.0 172.0 173.0 189.0 181.0 183.0 174.0 175.0 174.0 176.0 07:05:58 INFO - PROCESS | 20378 | 07:05:58 INFO - PROCESS | 20378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.50 stddev:2.32 (3.2%) stddev-sans-first:2.45 07:05:58 INFO - PROCESS | 20378 | Values: 73.0 75.0 72.0 72.0 73.0 79.0 72.0 75.0 74.0 71.0 07:05:58 INFO - PROCESS | 20378 | -------- Summary: end -------- 07:05:58 INFO - PROCESS | 20378 | 07:05:59 INFO - TEST-INFO | 20378: exit 0 07:05:59 INFO - TEST-OK | kraken | took 63842ms 07:05:59 INFO - SUITE-END | took 1179s 07:05:59 INFO - Completed test suite (00:19:39) 07:05:59 INFO - javascript benchmark 07:05:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.7386261373863, 2667.62653228548, 2689.9327516812077, 2703.95944060839, 2720.387912719637, 4758.381410416645, 4781.6413768967295, 4818.229083346665, 4834.4923783002805, 4873.585745211662, 4677.859664210071, 4843.588294994921, 4876.317315575822, 4886.267059941002, 4918.237673160657, 4436.134953684033, 4469.597736203741, 4509.909801803962, 4510.413646226002, 4557.225271703818, 4431.113777244548, 4480.126375356806, 4507.301368287921, 4522.3216517522305, 4527.52460991596, 4285.8499952501825, 4301.247281725686, 4373.540778218273, 4438.8224471021285, 4527.094581083797, 4377.430933978594, 4393.868183954486, 4409.250427427345, 4410.073884484262, 4452.710573812692, 4376.737395756233, 4406.603405693471, 4416.514183439819, 4420.4253447052, 4448.132614140244, 4710.646701497367, 4747.786349614275, 4759.571638552547, 4782.13921494131, 4806.255030470283, 5139.717315547643, 5141.357330333708, 5158.561522270612, 5160.638755287094, 5188.481151884819, 5067.0, 5178.533931946105, 5199.688018718851, 5203.531682148625, 5207.6875387476875, 4814.085323788469, 4852.708837469763, 4854.781534830941, 4900.093482705711, 4905.583025442806, 5306.575473962073, 5349.491798279158, 5378.757955891994, 5386.542143917733, 5411.972940135274, 4987.952529968675, 5072.391313042384, 5091.0836049511445, 5094.083065048253, 5123.2827404163445, 5165.328507294028, 5209.661372010807, 5214.191800270888, 5226.398964119099, 5269.604779641542, 4969.304297398367, 5053.974730126326, 5054.317667114966, 5056.646034777604, 5060.139776238048, 5074.23886417033, 5127.2052831811125, 5181.637285390062, 5221.947780522222, 5233.450487698813, 3988.062805240766, 4051.756894586334, 4052.2908491013955, 4053.594640535982, 4100.036491424513, 3561.4301711726, 3594.9101272468397, 3601.1177261571083, 3620.8913732588067, 3628.129248980226, 4504.639628829751, 4527.253003254492, 4532.138893610204, 4551.180787458223, 4571.862844114682, 5213.478652134832, 5216.504432078947, 5223.791048358099, 5228.9738551307, 5257.00116977773, 4541.591256786905, 4544.613707834805, 4547.0, 4564.475085365226, 4582.404287442611, 4615.23848564983, 4697.177993851063, 4698.248280275139, 4703.95296047042, 4746.620270378361, 4783.784729687172, 4884.804607815648, 4948.282499037691, 4971.304017437489, 4998.6750861193905, 5180.896382072262, 5198.74006299676, 5210.244514545446, 5227.660202086852, 5232.816851410183, 4913.7543122843, 4927.581155601814, 4932.3094766731965, 4932.7286999215385, 4954.8761280968265, 4946.480619535041, 5103.770330335218, 5144.922826157685, 5162.122439185272, 5189.818356357509, 5172.353455818023, 5193.143131383279, 5211.817586384458, 5216.66091704038, 5284.128118860345, 4850.223964165716, 5045.520675535819, 5045.5459008689395, 5048.949510504995, 5052.418971818141, 4900.68145570551, 5064.898702026013, 5101.7194054327365, 5134.4352121267375, 5134.640575159703, 4888.071266459361, 4940.530649588283, 4958.206686930218, 4980.103581355391, 5037.319961805256, 5041.395032596112, 5043.067032598834, 5048.419431765394, 5056.039352523009, 5114.105031619377, 4824.396950381202, 4870.878228044327, 4910.9263361050325, 4911.7298548580175, 4916.92624610624], "value": 4733.313953778132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3357305166431, 597.4652685846168, 614.0543562913111, 618.2086928731225, 634.7207228819316, 31961.680383196162, 33346.16634584137, 33430.164245893866, 33432.164195895115, 33450.0, 36721.449178262345, 37068.07329816756, 37101.44347834778, 37404.81297593515, 37550.62449375505, 7735.883961740578, 7839.0, 7883.251091146332, 7893.697539905937, 7917.089534703497, 7622.2758837910305, 7756.418268629847, 7779.8444031119625, 7788.260115289038, 7807.570583617899, 7806.921930780704, 7858.960705196466, 7877.2122787721055, 7894.250046245597, 7900.130985591581, 7753.573553454586, 7784.416168787364, 7785.1436342002335, 7792.220777922219, 7828.138904720477, 7733.1880152583735, 7821.217878212134, 7868.645910934022, 7874.0, 7874.173211812735, 30451.695483045107, 34140.658593413995, 34902.65097349019, 35001.0, 35030.82484587586, 3021.54676798482, 3189.1867573768773, 3218.09893229896, 3631.9818400907825, 3791.9241615167816, 27161.0, 27242.5913611296, 27457.86271068632, 27533.0, 27991.30021749452, 3326.417876871538, 3326.933461330784, 3343.264481813997, 3393.5927688677516, 3557.4663800429885, 187799.0, 191562.0, 192569.9999999986, 193128.0, 193134.0, 33837.30813459317, 35259.0, 57612.0, 58433.0, 58482.415175848546, 34213.65786342155, 34293.0, 34328.313433731186, 34335.484967725, 34337.65662343395, 12703.555375561997, 12842.165259258305, 12890.419931103123, 12926.935365323114, 13043.021773366845, 10625.893741062646, 10831.67504974852, 10857.294275872044, 10872.891271087346, 10947.178961577914, 8328.458650187718, 8329.791755206168, 8410.243078122998, 8432.156784321518, 8463.661453541912, 3299.6535363786456, 3314.303996160785, 3330.4171769940162, 3336.6162891267813, 3377.628460869302, 910.349100393222, 942.5711301357866, 972.7324985629009, 990.3958585262984, 995.8904520502739, 27110.322241944108, 28477.57283640747, 28565.71434285672, 28607.427851442855, 29219.269518262212, 1004.6483730694345, 1030.845373194027, 1047.6804574604666, 1061.368485750977, 1068.4444089073793, 14812.777808332883, 15270.923645381925, 15373.308201130976, 15540.844591554165, 15569.0, 341022.0, 344239.0, 346563.0, 346756.0, 348011.0, 48469.75765121152, 48911.0, 49174.26238606352, 49302.75348623234, 49374.25938610924, 1192.2548407245472, 1225.8161275808523, 1259.6535952612921, 1263.4819723913151, 1270.510853321478, 26008.0, 27921.720782792723, 27981.0, 28016.159515214575, 28228.71771282261, 43045.784771075945, 43126.568734312255, 43425.0, 43550.346744799484, 43605.78197108994, 315513.0, 317718.0, 317996.0, 318188.0, 318749.0, 25714.485710286062, 26051.609225861248, 26138.607920881583, 26139.215823525326, 39140.804295978334, 38498.80750596229, 38803.41794873136, 39403.60596394114, 39498.0, 41434.58565414307, 33828.0, 33869.66130338665, 34011.0, 34080.31839363149, 34464.310713786086, 33296.1675958103, 33966.0, 34062.14844628805, 34290.65709342974, 34400.311993760486, 31707.841460792548, 34565.82717086499, 35388.46917296191, 36257.81871090628, 37831.0, 28460.857695711387, 29427.411451771273, 29793.10620681383, 29949.55075673823, 30087.398252035273, 22775.430614234778, 23480.530389391773, 24430.144944926844, 24868.37829054288, 25233.747662523874], "value": 16181.093492304053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.77856843031026, 387.5156054931335, 389.287603685256, 392.77415486095487, 407.86132714876936, 15085.472008479705, 16366.590835229124, 16500.422485213036, 16512.25694843732, 16541.83458165418, 15513.612159696013, 16237.756433653505, 16327.673446531062, 16345.34618615254, 16413.343466261365, 4800.5679488846, 4906.656534042619, 4955.529224723664, 4977.178765503688, 4985.825496107637, 3468.1329667583104, 5234.398044224925, 5537.252470916435, 5541.944580554183, 5559.9444005559835, 5433.049216387136, 5505.807296744615, 5512.944870551283, 5518.613697041189, 5525.723713814314, 5909.290885093773, 6014.969925150346, 6048.546359023069, 6068.514518838482, 6077.118817771398, 5195.272661827347, 5419.458054194549, 5426.728663566806, 5457.0, 5460.399356070829, 12376.504939802397, 12397.318147501885, 12504.37478126099, 12562.0, 13224.338783060904, 2004.4788355027797, 2007.3175120458968, 2032.217596225464, 2033.166401775265, 2150.2796563151205, 8916.286697064219, 9017.81964360709, 9128.995810460843, 9473.573689184002, 9495.145436910641, 1767.7525146479504, 1773.2818208625526, 1777.8222177782247, 1823.5349985753548, 1842.769653793276, 61022.694886525285, 66399.66800166016, 67982.0, 69956.30043699549, 71692.28307716908, 9624.422534647943, 9891.406515609087, 10371.429571373495, 10412.479376031168, 10608.469576521144, 14526.201058941648, 14526.709465810836, 14547.636309092357, 14569.41722331116, 14596.12423254608, 7107.466939979522, 7162.104736907887, 7251.311125443074, 7286.23494533077, 7289.052423185058, 6818.318168183142, 6883.621400823003, 6919.930800692029, 6967.965160174268, 7010.334018268256, 4310.577509421946, 4325.675574331937, 4348.0, 4370.912581748411, 4383.539728328544, 1697.3125884016993, 1832.0839580209895, 1844.020382850903, 1863.6552237836045, 1918.3669389101842, 887.5517863479031, 895.3687650206589, 896.3770179725159, 945.4705364995624, 999.8200323941614, 16368.263428145761, 16416.343346266014, 16486.17569121539, 16715.582110447336, 16750.58123546921, 882.5631312500353, 899.604174163366, 912.8995810460844, 925.0794912559672, 925.444733160112, 9192.678256260999, 9238.260939124853, 9321.207697345802, 9391.342606017513, 9572.377795443273, 379736.0, 384061.0, 408473.0, 410654.0, 415091.0, 81551.59224203842, 82584.0, 83563.0, 83781.58109209537, 83803.58098209593, 916.9908300917039, 953.4327075390132, 986.8865080515689, 1005.2360206243162, 1011.4234886114843, 14618.561443156723, 14656.70686586241, 14696.265186740406, 14735.968482206143, 14921.253937302874, 31348.68651313549, 32268.677313227505, 34242.657573423945, 36652.63347366492, 38136.809315953244, 44588.10823783571, 46613.30080048734, 48214.75892620515, 48387.27419088646, 49223.32378424044, 7432.554046757212, 7627.313541781266, 7731.652075656497, 7781.805454863674, 7854.3323817473865, 8330.208630180123, 10495.632652857113, 11793.469293881968, 11798.469068892093, 11850.229735067192, 9786.0, 10124.34191777532, 10164.390136591828, 10196.643117490852, 10355.0, 10056.245781566266, 10203.94898025505, 10212.846807297748, 10270.383776973405, 10289.485525723834, 10036.799264014824, 10178.847317290098, 10314.278000540191, 10380.948095259475, 10390.116840068678, 7578.621068946641, 7603.20166382544, 7662.080550333772, 7765.650545725343, 7873.488223265469, 8836.381453298207, 9682.85475717879, 9728.708138755848, 9767.267454940766, 9963.25275604347], "value": 8104.120228805824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.5888621742802, 1464.5899148238493, 1630.6412589230365, 1771.096740662262, 1815.3736960748538, 6811.114555107842, 7488.251174882515, 7591.468597198198, 7735.381169506433, 7747.961260193705, 7529.510581812178, 7592.354649854755, 7665.348445382136, 7674.040744906887, 7697.884531732015, 2252.8760918149455, 2265.422317309084, 2268.7731226877263, 2273.6021196290667, 2289.061484791236, 2213.712217411742, 2222.7332720073614, 2232.598132336179, 2253.583087128878, 2255.1881322723807, 2237.7538470768204, 2268.0247493577754, 2270.7842754938256, 2289.919852805152, 2305.227748704186, 2234.9329520114425, 2239.8656080635133, 2243.6298010828195, 2244.618414869476, 2246.539459410825, 2163.9242626508153, 2195.538936823269, 2196.4399078235106, 2208.503086805472, 2212.0156530344, 7781.182975787574, 7826.217378262185, 7826.8434631307055, 7828.021497312836, 7836.843263134705, 4617.353570500132, 4747.192977193886, 4801.663883528155, 4812.446568644616, 4827.155247831615, 2895.131460561823, 3045.7258846703903, 3049.1614805928325, 3080.0451859923496, 3080.5687203791263, 1802.8647851411197, 1806.8102849200777, 1843.4653950354382, 1844.6126313474188, 1849.4544109487733, 10175.084242418145, 10185.490725463696, 10210.540525676362, 10287.639932602398, 10318.484075796181, 4078.4290199372113, 4124.443200167999, 4258.127083947783, 4276.764777937181, 4292.849750258726, 8377.45546539473, 8380.078191398941, 8408.705695300636, 8410.411271210956, 8427.95786021066, 4730.053989202104, 4741.099191153669, 4745.691530050535, 4748.074125545554, 4748.548887855648, 3798.2783271178387, 4238.427812245307, 4326.4159338489535, 4370.781460926941, 4410.845620403271, 3374.797512149279, 3377.121948293461, 3454.4127498325347, 3473.14907847579, 3490.214701692099, 1090.487470888681, 1095.5891540672249, 1097.05653138301, 1101.2126329674322, 1113.716002419378, 902.2962089570015, 920.59953920045, 924.5146298193367, 931.9998209605418, 940.8259471997702, 5370.785168593291, 5565.471280228372, 5614.719264036782, 5743.0811070228565, 5840.59115861894, 873.4802792338548, 894.1996912763041, 954.4559601027487, 965.5510187762724, 969.0454901921602, 3613.602503724588, 3662.4506324051604, 3665.52348194733, 3673.7612055216327, 3727.8136093195776, 9191.954040229755, 9588.520573971273, 9676.371035882645, 9700.611975521042, 9729.0, 9448.622055117856, 9500.144986951207, 9617.615295388247, 9623.711288661352, 9688.224942004623, 6875.3812156906115, 6905.343992320822, 6972.755953541703, 7019.262977387403, 7046.929530704628, 4545.090981803719, 4689.413823272091, 4692.272697731857, 4692.671512994194, 4696.976515117402, 8386.37102217324, 8451.704190353308, 8488.915110849059, 8501.617427215913, 8577.914220857712, 8385.53879536607, 8444.451110677786, 8687.348448866487, 8690.087540808125, 8751.824963500821, 5542.445755424425, 6304.211973503312, 6307.779227727007, 6456.386643268882, 6512.902306465501, 7320.231375705474, 7382.52013619113, 7450.0, 7469.962650186714, 7470.589117598584, 6613.503987200883, 6846.246912839484, 6894.379505844498, 7037.824054398681, 7053.612051337226, 6833.760818371333, 6894.655267236518, 6933.202681691469, 6964.825879353057, 6977.476689248225, 6364.777232797015, 6410.391012853772, 6410.711517981609, 6538.215414150332, 6544.214694236532, 4812.8796780080775, 4860.95139048605, 4896.926546101882, 4949.257611358181, 4951.059298733229, 4822.324874517641, 4822.9758851205515, 4846.17615005457, 4864.027194561173, 4938.1358262304675], "value": 4241.21712600753, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.20692406666734, 311.8113541307509, 314.28029811731153, 315.9462891308478, 321.4904376563147, 5412.539934105601, 5440.945590544098, 5447.782088716446, 5465.207544905991, 5469.316335458067, 5351.491608297206, 5353.705546194958, 5355.278081733197, 5364.973175134119, 5375.731213439322, 3939.4287828264814, 4014.2172276406113, 4140.730852494593, 4144.606262405082, 4161.25097482453, 4127.112670775783, 4128.649064829493, 4133.545310015896, 4144.212599606065, 4147.025449019478, 4112.403701463286, 4113.465249517559, 4120.855770048049, 4120.979395103021, 4126.938095928564, 4027.677785777131, 4110.157417729359, 4115.32097203961, 4119.3409054551275, 4124.752514849089, 3603.9099022524383, 3633.382325004729, 3639.5268615080136, 3641.308151451216, 3645.0340659725193, 5041.521055499722, 5068.682142642902, 5075.213341932006, 5084.271347741748, 5097.413797413271, 4601.976990115061, 4746.952530474686, 4770.976145119253, 4782.497837727058, 4806.534007127824, 5576.609637325389, 5585.441455854423, 5610.551155907518, 5630.071038278679, 5630.352509461423, 3965.4250133730447, 3988.441618173458, 4002.7198096133284, 4004.2992476316526, 4017.4777278953843, 5560.916586251209, 5853.326867410217, 5854.297484301868, 5865.0, 5911.852203694899, 3939.783311917872, 4002.639762421396, 4003.159336539301, 4015.2371049500503, 4032.193561287754, 4072.3484242521054, 4079.5716449772344, 4081.5306239782212, 4086.1010577672864, 4093.16090201508, 4579.816807327669, 4686.507916668701, 4700.106979673851, 4701.459332176775, 4711.7879695413785, 5617.651763576794, 5626.212330273765, 5626.381098079208, 5665.971670141623, 5671.347795003628, 1383.8477767445572, 1404.5392791496934, 1411.4213172599184, 1414.1161773891317, 1415.9079659822078, 884.2263019857625, 916.848719961199, 925.893522244937, 938.8592859675528, 941.0918463682442, 4839.346688197119, 4845.563899249085, 4848.878778030577, 4851.878703032452, 4855.271709243571, 5669.0, 5672.914906276409, 5676.858078548069, 5689.630174038674, 5693.715314234271, 4694.976525117421, 4796.448408433075, 4829.154897892855, 4836.46798852126, 4927.384076990376, 3096.6903309669306, 3117.922051948674, 3131.4989601663624, 3132.6554079051284, 3141.167590588496, 5530.806421775299, 5537.390887002426, 5544.112941929272, 5553.361363443256, 5562.888742225133, 5950.553708471882, 6056.545759068, 6084.361142080018, 6088.847778805477, 6099.542534309944, 5456.290682211287, 5459.317585301837, 5465.672059676433, 5493.99999999992, 5527.143292789624, 5650.406707295675, 5804.883902322014, 5817.970910145422, 5828.795992140254, 5853.0, 5813.79651712188, 5820.272465941757, 5828.242328497268, 5834.15404766315, 5842.2405087338375, 5438.891222175455, 5488.9725551371985, 5519.641223320471, 5537.169424586345, 5540.556755459635, 3912.882613521599, 3987.561368249548, 4012.976690943791, 4020.718549701493, 4031.576684448091, 5804.5356371491025, 5830.854228644318, 5835.270591176103, 5858.209141765978, 5865.677387743715, 5654.180143879033, 5658.971705141613, 5666.943330566642, 5672.14917762339, 5674.092145256739, 5453.209284653623, 5648.774049038157, 5668.744906479301, 5681.517071049007, 5689.857753556029, 5297.470252974672, 5520.392756796829, 5559.19391688211, 5564.38791732901, 5596.5242954347705, 5516.475934786189, 5691.8861622768145, 5700.116481945305, 5710.5146062585145, 5736.483716465538, 5507.917381239365, 5529.33647962231, 5538.141588053858, 5547.8890422192135, 5567.415421380859], "value": 4211.955065437433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6688872119579, 741.5921243316182, 758.4084414156956, 783.5298820707575, 795.3915254830056, 11571.305721656707, 11988.700282492942, 12089.758204835898, 12133.211341262811, 12179.57371491998, 10955.766192733006, 10995.34027958323, 11072.778544429106, 11098.4450777461, 11572.132090093255, 785.9096203936534, 810.5501446697095, 819.5492479136451, 822.6832669422286, 823.9093699693029, 808.9069756977964, 811.1401913971209, 813.4102775487754, 813.5728742410223, 813.6297984417106, 836.4061516323418, 840.5713086325987, 844.0082902589463, 845.8181490979438, 848.1476116502906, 835.0563862835019, 836.0302049622439, 836.7196989008689, 836.9790755231168, 839.937004724645, 615.2125279642065, 616.9475594574467, 618.4434009391539, 621.5307442880642, 621.7730528357163, 11834.467448964731, 11856.466459009365, 11858.822117668242, 11926.522939082513, 11939.94030029853, 12402.13185077045, 12519.499220031188, 12627.305498197595, 12682.492700291978, 12770.936145319214, 10042.899571004342, 10075.34510256831, 10160.0, 10312.89687103127, 10423.478826058743, 3248.3828072666356, 3274.746436642824, 3280.8195549244783, 3338.2488939988552, 3340.766146369755, 46284.0, 46525.76737116327, 46777.298340524576, 47153.29270060952, 47599.5240047602, 9156.725298241063, 9865.172003919053, 10062.597496100221, 10081.19350451962, 10116.08955194036, 17493.475195744148, 17496.38762643327, 17509.0, 17521.64956700859, 17567.47297581049, 6624.768133115318, 6766.898496522556, 6810.829729256809, 6815.352541508549, 6860.6912688929115, 3868.4777555030273, 3901.804909754501, 3909.6090390960676, 3929.2458207157647, 3939.2909276330533, 2818.5631227159824, 2875.3961668049524, 2906.8401237932117, 2908.3892382599893, 2913.126062181337, 501.51353187408154, 513.3070355020692, 515.564348125833, 521.2259794205602, 522.0029743190564, 512.5131125430855, 596.8120042186785, 596.9492593129632, 597.3548567547039, 643.0419373009198, 7205.855882882313, 7443.330100291, 7502.6623801929045, 7710.228977102245, 7941.6029198539845, 526.7287347016289, 570.1020892094967, 584.6492104737124, 601.2664549249909, 616.4328817487922, 3509.8771542996383, 3535.416656251741, 3536.381133301662, 3611.530501034849, 3650.1604630935035, 52120.73939630278, 53596.19605705918, 53600.0, 53944.73027634837, 54007.45992540103, 40137.59862401397, 41684.79157604193, 42146.36780448296, 43918.0, 45895.31157032647, 39124.26130170918, 39285.80357098196, 39513.802430987664, 40054.79972600118, 41230.58769412328, 8126.918730812853, 8432.114627963976, 8549.957250213709, 8578.871316930376, 8868.95565522194, 28681.42637147287, 29027.0, 29142.708572913998, 29418.0, 29660.555091674072, 35361.64638353584, 36658.45012324764, 38379.232415350976, 38720.6127938717, 38840.41739373855, 9756.560954756911, 9762.121409073217, 9821.656242031495, 10535.473226338805, 10747.570097196025, 11776.764464710486, 11794.351310677996, 11808.82286765682, 11855.407229638311, 12096.0, 10892.455377230948, 10916.836247456136, 10932.398718070264, 11147.777044458902, 11254.718632034264, 11051.17116216271, 11413.771724565297, 11588.917641651817, 11732.530698771954, 12158.878411216128, 10974.451277435937, 11038.227324087558, 11297.209195356574, 11421.657350279505, 11738.530458781896, 9555.856662150212, 9608.375455595364, 9794.510274486389, 9840.212782977487, 9867.358621689567, 9628.71113866585, 9698.95150524271, 9699.563519641773, 9739.513024348613, 9772.511374431393], "value": 5909.809880964818, "unit": "score"}], "name": "dromaeo_css", "value": 6349.574113486948, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 114.0, 113.0, 115.0, 126.0, 115.0, 114.0, 113.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 158.0, 176.0, 133.0, 164.0, 154.0, 142.0, 184.0, 134.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 170.0, 165.0, 165.0, 163.0, 162.0, 166.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 77.0, 151.0, 79.0, 74.0, 74.0, 73.0, 157.0, 75.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 160.0, 95.0, 94.0, 94.0, 141.0, 94.0, 93.0, 148.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 100.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 85.0, 63.0, 63.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 67.0, 66.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 81.0, 88.0, 80.0, 82.0, 82.0, 81.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 143.0, 139.0, 143.0, 144.0, 140.0, 138.0, 169.0, 146.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 172.0, 173.0, 189.0, 181.0, 183.0, 174.0, 175.0, 174.0, 176.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 72.0, 73.0, 79.0, 72.0, 75.0, 74.0, 71.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1603.0, "alertThreshold": 2.0}]} 07:05:59 INFO - Return code: 0 07:05:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:05:59 ERROR - # TBPL SUCCESS # 07:05:59 INFO - Running post-action listener: _resource_record_post_action 07:05:59 INFO - Running post-run listener: _resource_record_post_run 07:06:00 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 352657408; Read time: 8; Write time: 330824 07:06:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 68423680; Read time: 0; Write time: 79548 07:06:00 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284233728; Read time: 8; Write time: 251276 07:06:00 INFO - Running post-run listener: _upload_blobber_files 07:06:00 INFO - Blob upload gear active. 07:06:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:06:00 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 07:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:06:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:06:01 INFO - (blobuploader) - INFO - Done attempting. 07:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:06:02 INFO - (blobuploader) - INFO - Done attempting. 07:06:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:06:02 INFO - Return code: 0 07:06:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:06:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:06:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad3912e5118d8d47a315e6dd41ca02c2f555011bd0e6053b87e95ee6f133803b1328b37e53d261cf61dcd7556dac0e5f15a4e3968317059afefb460777de4d5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd37909162cfa48380b377220235c9d737820df0f53f9a6099aa03d5541ec4602481c9d7e68e3ea4eacf5514488460961df690786abe3d8af87a1d51267dfb70"} 07:06:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:06:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:06:02 INFO - Contents: 07:06:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad3912e5118d8d47a315e6dd41ca02c2f555011bd0e6053b87e95ee6f133803b1328b37e53d261cf61dcd7556dac0e5f15a4e3968317059afefb460777de4d5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd37909162cfa48380b377220235c9d737820df0f53f9a6099aa03d5541ec4602481c9d7e68e3ea4eacf5514488460961df690786abe3d8af87a1d51267dfb70"} 07:06:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:06:02 INFO - Copying logs to upload dir... 07:06:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:06:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.127067 ========= master_lag: 17.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 07:06:19.847367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 07:06:19.850507) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad3912e5118d8d47a315e6dd41ca02c2f555011bd0e6053b87e95ee6f133803b1328b37e53d261cf61dcd7556dac0e5f15a4e3968317059afefb460777de4d5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd37909162cfa48380b377220235c9d737820df0f53f9a6099aa03d5541ec4602481c9d7e68e3ea4eacf5514488460961df690786abe3d8af87a1d51267dfb70"} build_url:https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/bSbaV6KnQgaEhsOQNIVuVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad3912e5118d8d47a315e6dd41ca02c2f555011bd0e6053b87e95ee6f133803b1328b37e53d261cf61dcd7556dac0e5f15a4e3968317059afefb460777de4d5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd37909162cfa48380b377220235c9d737820df0f53f9a6099aa03d5541ec4602481c9d7e68e3ea4eacf5514488460961df690786abe3d8af87a1d51267dfb70"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 07:06:19.885717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 07:06:19.886022) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461159725.61167-866979255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 2.95 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 07:06:22.838675) ========= ========= Started reboot skipped (results: 3, elapsed: 9 secs) (at 2016-04-20 07:06:22.838956) ========= ========= Finished reboot skipped (results: 3, elapsed: 9 secs) (at 2016-04-20 07:06:32.065202) ========= ========= Total master_lag: 20.34 =========