builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1461380773.28 results: success (0) buildid: 20160422173006 builduid: 5b0e7a1efd314e229321621103269ff5 revision: 3bc647d9bb02ea0284ea7653161f49c9dd2982e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.279136) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.279634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.279942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.340268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.340564) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 20:06: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-04-22 20:06:13 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137041 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.517669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.518185) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017046 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.586330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:13.586839) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3bc647d9bb02ea0284ea7653161f49c9dd2982e4 --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 3bc647d9bb02ea0284ea7653161f49c9dd2982e4 --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=5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 20:06:13,683 truncating revision to first 12 chars 2016-04-22 20:06:13,683 Setting DEBUG logging. 2016-04-22 20:06:13,683 attempt 1/10 2016-04-22 20:06:13,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3bc647d9bb02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 20:06:13,962 unpacking tar archive at: fx-team-3bc647d9bb02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:14.207862) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:14.208191) ========= script_repo_revision: 3bc647d9bb02ea0284ea7653161f49c9dd2982e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:14.208660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:14.208990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 20:06:14.220697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 20:06:14.221048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:14 INFO - MultiFileLogger online at 20160422 20:06:14 in /builds/slave/test 20:06:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:06:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:14 INFO - {'append_to_log': False, 20:06:14 INFO - 'base_work_dir': '/builds/slave/test', 20:06:14 INFO - 'blob_upload_branch': 'Fx-Team', 20:06:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:14 INFO - 'branch': 'Fx-Team', 20:06:14 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:14 INFO - 'config_files': ('talos/linux_config.py',), 20:06:14 INFO - 'default_actions': ('clobber', 20:06:14 INFO - 'read-buildbot-config', 20:06:14 INFO - 'download-and-extract', 20:06:14 INFO - 'populate-webroot', 20:06:14 INFO - 'create-virtualenv', 20:06:14 INFO - 'install', 20:06:14 INFO - 'run-tests'), 20:06:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:14 INFO - 'download_minidump_stackwalk': True, 20:06:14 INFO - 'download_symbols': 'ondemand', 20:06:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:14 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:14 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:14 INFO - 'installer_path': 'installer.exe', 20:06:14 INFO - 'log_level': 'info', 20:06:14 INFO - 'log_name': 'talos', 20:06:14 INFO - 'log_to_console': True, 20:06:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:14 INFO - 'opt_config_files': (), 20:06:14 INFO - 'pip_index': False, 20:06:14 INFO - 'sps_profile': False, 20:06:14 INFO - 'sps_profile_interval': 0, 20:06:14 INFO - 'suite': 'dromaeojs-e10s', 20:06:14 INFO - 'system_bits': '32', 20:06:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:14 INFO - 'title': 'talos-linux64-ix-011', 20:06:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:14 INFO - 'use_talos_json': True, 20:06:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:14 INFO - 'work_dir': 'build'} 20:06:14 INFO - ##### 20:06:14 INFO - ##### Running clobber step. 20:06:14 INFO - ##### 20:06:14 INFO - Running pre-action listener: _resource_record_pre_action 20:06:14 INFO - Running main action method: clobber 20:06:14 INFO - rmtree: /builds/slave/test/build 20:06:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:14 INFO - Running post-action listener: _resource_record_post_action 20:06:14 INFO - ##### 20:06:14 INFO - ##### Running read-buildbot-config step. 20:06:14 INFO - ##### 20:06:14 INFO - Running pre-action listener: _resource_record_pre_action 20:06:14 INFO - Running main action method: read_buildbot_config 20:06:14 INFO - Using buildbot properties: 20:06:14 INFO - { 20:06:14 INFO - "project": "", 20:06:14 INFO - "product": "firefox", 20:06:14 INFO - "script_repo_revision": "production", 20:06:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:06:14 INFO - "repository": "", 20:06:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:06:14 INFO - "buildid": "20160422173006", 20:06:14 INFO - "pgo_build": "True", 20:06:14 INFO - "basedir": "/builds/slave/test", 20:06:14 INFO - "buildnumber": 684, 20:06:14 INFO - "slavename": "talos-linux64-ix-011", 20:06:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:06:14 INFO - "platform": "ubuntu64_hw", 20:06:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:06:14 INFO - "branch": "fx-team", 20:06:14 INFO - "repo_path": "integration/fx-team", 20:06:14 INFO - "revision": "3bc647d9bb02ea0284ea7653161f49c9dd2982e4", 20:06:14 INFO - "stage_platform": "linux64-pgo", 20:06:14 INFO - "builduid": "5b0e7a1efd314e229321621103269ff5", 20:06:14 INFO - "slavebuilddir": "test" 20:06:14 INFO - } 20:06:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:06:14 INFO - Running post-action listener: _resource_record_post_action 20:06:14 INFO - ##### 20:06:14 INFO - ##### Running download-and-extract step. 20:06:14 INFO - ##### 20:06:14 INFO - Running pre-action listener: _resource_record_pre_action 20:06:14 INFO - Running main action method: download_and_extract 20:06:14 INFO - mkdir: /builds/slave/test/build/tests 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:14 INFO - https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:18 INFO - Downloaded 1361 bytes. 20:06:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:06:18 INFO - Using the following test package requirements: 20:06:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'jsshell-linux-x86_64.zip'], 20:06:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06: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')]} 20:06:18 INFO - https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:20 INFO - Downloaded 23857749 bytes. 20:06:20 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'] 20:06:20 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 20:06:21 INFO - Return code: 0 20:06:21 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 20:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:21 INFO - https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:22 INFO - Downloaded 23857749 bytes. 20:06: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'] 20:06: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 20:06:24 INFO - Return code: 0 20:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:24 INFO - https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:25 INFO - Downloaded 10840145 bytes. 20:06:25 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'] 20:06:25 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 20:06:25 INFO - Return code: 0 20:06:25 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')]} 20:06:25 INFO - https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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 20:06:28 INFO - Downloaded 58374127 bytes. 20:06:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:06:28 INFO - mkdir: /builds/slave/test/properties 20:06:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:28 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:28 INFO - Contents: 20:06:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:06:28 INFO - Running post-action listener: _resource_record_post_action 20:06:28 INFO - Running post-action listener: set_extra_try_arguments 20:06:28 INFO - ##### 20:06:28 INFO - ##### Running populate-webroot step. 20:06:28 INFO - ##### 20:06:28 INFO - Running pre-action listener: _resource_record_pre_action 20:06:28 INFO - Running main action method: populate_webroot 20:06:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:28 INFO - '--tppagecycles', 20:06:28 INFO - '7'], 20:06:28 INFO - 'tests': ['tsvgm']}}, 20:06:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['damp', 'tps']}, 20:06:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'tests': ['damp', 'tps']}, 20:06:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['dromaeo_dom']}, 20:06:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['a11yr', 20:06:28 INFO - 'ts_paint', 20:06:28 INFO - 'tpaint', 20:06:28 INFO - 'sessionrestore', 20:06:28 INFO - 'sessionrestore_no_auto_restore', 20:06:28 INFO - 'tabpaint']}, 20:06:28 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:28 INFO - 'ts_paint', 20:06:28 INFO - 'tpaint', 20:06:28 INFO - 'sessionrestore', 20:06:28 INFO - 'sessionrestore_no_auto_restore', 20:06:28 INFO - 'tabpaint']}, 20:06:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:28 INFO - 'ts_paint', 20:06:28 INFO - 'tpaint', 20:06:28 INFO - 'sessionrestore', 20:06:28 INFO - 'sessionrestore_no_auto_restore', 20:06:28 INFO - 'tabpaint']}, 20:06:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:28 INFO - 'ts_paint', 20:06:28 INFO - 'tpaint', 20:06:28 INFO - 'sessionrestore', 20:06:28 INFO - 'sessionrestore_no_auto_restore', 20:06:28 INFO - 'tabpaint']}, 20:06:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['a11yr', 20:06:28 INFO - 'ts_paint', 20:06:28 INFO - 'tpaint', 20:06:28 INFO - 'sessionrestore', 20:06:28 INFO - 'sessionrestore_no_auto_restore', 20:06:28 INFO - 'tabpaint']}, 20:06:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['a11yr', 20:06:28 INFO - 'ts_paint', 20:06:28 INFO - 'tpaint', 20:06:28 INFO - 'sessionrestore', 20:06:28 INFO - 'sessionrestore_no_auto_restore', 20:06:28 INFO - 'tabpaint']}, 20:06:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['tsvgx', 20:06:28 INFO - 'tsvgr_opacity', 20:06:28 INFO - 'tart', 20:06:28 INFO - 'tscrollx', 20:06:28 INFO - 'cart']}, 20:06:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:28 INFO - 'tsvgr_opacity', 20:06:28 INFO - 'tart', 20:06:28 INFO - 'tscrollx', 20:06:28 INFO - 'cart']}, 20:06:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'talos_options': ['--disable-e10s'], 20:06:28 INFO - 'tests': ['tp5o']}, 20:06:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'tests': ['tp5o']}, 20:06:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'talos_options': ['--disable-e10s', 20:06:28 INFO - '--xperf_path', 20:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:28 INFO - 'tests': ['tp5n']}, 20:06:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:28 INFO - 'talos_options': ['--xperf_path', 20:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:28 INFO - 'tests': ['tp5n']}}, 20:06:28 INFO - 'talos.zip': {'path': '', 20:06:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:28 INFO - Running post-action listener: _resource_record_post_action 20:06:28 INFO - ##### 20:06:28 INFO - ##### Running create-virtualenv step. 20:06:28 INFO - ##### 20:06:28 INFO - Running pre-action listener: _resource_record_pre_action 20:06:28 INFO - Running main action method: create_virtualenv 20:06:28 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:28 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 20:06:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:28 INFO - Using real prefix '/usr' 20:06:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:29 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:31 INFO - Installing pip.................done. 20:06:31 INFO - Return code: 0 20:06:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:31 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')]} 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:31 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')]} 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:31 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:31 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 20:06:31 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 20:06:31 INFO - Using env: {'DISPLAY': ':0', 20:06:31 INFO - 'HOME': '/home/cltbld', 20:06:31 INFO - 'LANG': 'en_US.UTF-8', 20:06:31 INFO - 'LANGUAGE': 'en_US:en', 20:06:31 INFO - 'LOGNAME': 'cltbld', 20:06:31 INFO - 'MAIL': '/var/mail/cltbld', 20:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:31 INFO - 'MOZ_NO_REMOTE': '1', 20:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:31 INFO - 'NO_EM_RESTART': '1', 20:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:31 INFO - 'PWD': '/builds/slave/test', 20:06:31 INFO - 'SHELL': '/bin/bash', 20:06:31 INFO - 'SHLVL': '1', 20:06:31 INFO - 'TERM': 'linux', 20:06:31 INFO - 'TMOUT': '86400', 20:06:31 INFO - 'USER': 'cltbld', 20:06:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:31 INFO - '_': '/tools/buildbot/bin/python'} 20:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:31 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 20:06:31 INFO - Cleaning up... 20:06:31 INFO - Return code: 0 20:06:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:06:31 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')]} 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:31 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')]} 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:31 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:31 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 20:06:31 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 20:06:31 INFO - Using env: {'DISPLAY': ':0', 20:06:31 INFO - 'HOME': '/home/cltbld', 20:06:31 INFO - 'LANG': 'en_US.UTF-8', 20:06:31 INFO - 'LANGUAGE': 'en_US:en', 20:06:31 INFO - 'LOGNAME': 'cltbld', 20:06:31 INFO - 'MAIL': '/var/mail/cltbld', 20:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:31 INFO - 'MOZ_NO_REMOTE': '1', 20:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:31 INFO - 'NO_EM_RESTART': '1', 20:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:31 INFO - 'PWD': '/builds/slave/test', 20:06:31 INFO - 'SHELL': '/bin/bash', 20:06:31 INFO - 'SHLVL': '1', 20:06:31 INFO - 'TERM': 'linux', 20:06:31 INFO - 'TMOUT': '86400', 20:06:31 INFO - 'USER': 'cltbld', 20:06:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:31 INFO - '_': '/tools/buildbot/bin/python'} 20:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:31 INFO - Downloading/unpacking psutil>=0.7.1 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:33 INFO - Installing collected packages: psutil 20:06:33 INFO - Running setup.py install for psutil 20:06:33 INFO - building 'psutil._psutil_linux' extension 20:06:33 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 20:06:34 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 20:06:34 INFO - building 'psutil._psutil_posix' extension 20:06:34 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 20:06:34 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 20:06:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:34 INFO - Successfully installed psutil 20:06:34 INFO - Cleaning up... 20:06:34 INFO - Return code: 0 20:06:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:06:34 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')]} 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:34 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')]} 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:34 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:34 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 20:06:34 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 20:06:34 INFO - Using env: {'DISPLAY': ':0', 20:06:34 INFO - 'HOME': '/home/cltbld', 20:06:34 INFO - 'LANG': 'en_US.UTF-8', 20:06:34 INFO - 'LANGUAGE': 'en_US:en', 20:06:34 INFO - 'LOGNAME': 'cltbld', 20:06:34 INFO - 'MAIL': '/var/mail/cltbld', 20:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:34 INFO - 'MOZ_NO_REMOTE': '1', 20:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:34 INFO - 'NO_EM_RESTART': '1', 20:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:34 INFO - 'PWD': '/builds/slave/test', 20:06:34 INFO - 'SHELL': '/bin/bash', 20:06:34 INFO - 'SHLVL': '1', 20:06:34 INFO - 'TERM': 'linux', 20:06:34 INFO - 'TMOUT': '86400', 20:06:34 INFO - 'USER': 'cltbld', 20:06:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:34 INFO - '_': '/tools/buildbot/bin/python'} 20:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:06:34 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 20:06:34 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 20:06:34 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 20:06:34 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 20:06:34 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 20:06:34 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 20:06:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:06:36 INFO - Installing collected packages: mozsystemmonitor 20:06:36 INFO - Running setup.py install for mozsystemmonitor 20:06:36 INFO - Successfully installed mozsystemmonitor 20:06:36 INFO - Cleaning up... 20:06:36 INFO - Return code: 0 20:06:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:36 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:36 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 20:06:36 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 20:06:36 INFO - Using env: {'DISPLAY': ':0', 20:06:36 INFO - 'HOME': '/home/cltbld', 20:06:36 INFO - 'LANG': 'en_US.UTF-8', 20:06:36 INFO - 'LANGUAGE': 'en_US:en', 20:06:36 INFO - 'LOGNAME': 'cltbld', 20:06:36 INFO - 'MAIL': '/var/mail/cltbld', 20:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:36 INFO - 'MOZ_NO_REMOTE': '1', 20:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:36 INFO - 'NO_EM_RESTART': '1', 20:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:36 INFO - 'PWD': '/builds/slave/test', 20:06:36 INFO - 'SHELL': '/bin/bash', 20:06:36 INFO - 'SHLVL': '1', 20:06:36 INFO - 'TERM': 'linux', 20:06:36 INFO - 'TMOUT': '86400', 20:06:36 INFO - 'USER': 'cltbld', 20:06:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:36 INFO - '_': '/tools/buildbot/bin/python'} 20:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:36 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:36 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 20:06:36 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 20:06:36 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 20:06:36 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 20:06:36 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 20:06:36 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 20:06:38 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:38 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 20:06:38 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 20:06:38 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 20:06:38 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 20:06:38 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 20:06:38 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 20:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:39 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 20:06:39 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 20:06:39 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 20:06:39 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 20:06:39 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 20:06:39 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 20:06:39 INFO - Downloading docopt-0.6.1.tar.gz 20:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:39 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:39 INFO - Running setup.py install for blobuploader 20:06:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:39 INFO - Running setup.py install for requests 20:06:39 INFO - Running setup.py install for docopt 20:06:39 INFO - Successfully installed blobuploader requests docopt 20:06:39 INFO - Cleaning up... 20:06:40 INFO - Return code: 0 20:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:40 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:40 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 20:06:40 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 20:06:40 INFO - Using env: {'DISPLAY': ':0', 20:06:40 INFO - 'HOME': '/home/cltbld', 20:06:40 INFO - 'LANG': 'en_US.UTF-8', 20:06:40 INFO - 'LANGUAGE': 'en_US:en', 20:06:40 INFO - 'LOGNAME': 'cltbld', 20:06:40 INFO - 'MAIL': '/var/mail/cltbld', 20:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:40 INFO - 'MOZ_NO_REMOTE': '1', 20:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:40 INFO - 'NO_EM_RESTART': '1', 20:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:40 INFO - 'PWD': '/builds/slave/test', 20:06:40 INFO - 'SHELL': '/bin/bash', 20:06:40 INFO - 'SHLVL': '1', 20:06:40 INFO - 'TERM': 'linux', 20:06:40 INFO - 'TMOUT': '86400', 20:06:40 INFO - 'USER': 'cltbld', 20:06:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:40 INFO - '_': '/tools/buildbot/bin/python'} 20:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:40 INFO - Running setup.py (path:/tmp/pip-B5czyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:40 INFO - Running setup.py (path:/tmp/pip-xQhwMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:40 INFO - Running setup.py (path:/tmp/pip-a3CYSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:40 INFO - Running setup.py (path:/tmp/pip-qEvwcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:40 INFO - Running setup.py (path:/tmp/pip-JCacBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:40 INFO - Running setup.py (path:/tmp/pip-KdivMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:40 INFO - Running setup.py (path:/tmp/pip-EeF_sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:40 INFO - Running setup.py (path:/tmp/pip-iCDpdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:40 INFO - Running setup.py (path:/tmp/pip-OiFjCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:40 INFO - Running setup.py (path:/tmp/pip-hr1nUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:40 INFO - Running setup.py (path:/tmp/pip-Hn7yY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:41 INFO - Running setup.py (path:/tmp/pip-4o4XRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:41 INFO - Running setup.py (path:/tmp/pip-JZk0a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:41 INFO - Running setup.py (path:/tmp/pip-J5yghN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:41 INFO - Running setup.py (path:/tmp/pip-iMEn5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:41 INFO - Running setup.py (path:/tmp/pip-YgPlXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:41 INFO - Running setup.py (path:/tmp/pip-98h8l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:41 INFO - Running setup.py install for manifestparser 20:06:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:41 INFO - Running setup.py install for mozcrash 20:06:41 INFO - Running setup.py install for mozdebug 20:06:41 INFO - Running setup.py install for mozdevice 20:06:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:41 INFO - Running setup.py install for mozfile 20:06:42 INFO - Running setup.py install for mozhttpd 20:06:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for mozinfo 20:06:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for mozInstall 20:06:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for mozleak 20:06:42 INFO - Running setup.py install for mozlog 20:06:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for moznetwork 20:06:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for mozprocess 20:06:42 INFO - Running setup.py install for mozprofile 20:06:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for mozrunner 20:06:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:42 INFO - Running setup.py install for mozscreenshot 20:06:43 INFO - Running setup.py install for moztest 20:06:43 INFO - Running setup.py install for mozversion 20:06:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:43 INFO - Cleaning up... 20:06:43 INFO - Return code: 0 20:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:43 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:43 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 20:06:43 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 20:06:43 INFO - Using env: {'DISPLAY': ':0', 20:06:43 INFO - 'HOME': '/home/cltbld', 20:06:43 INFO - 'LANG': 'en_US.UTF-8', 20:06:43 INFO - 'LANGUAGE': 'en_US:en', 20:06:43 INFO - 'LOGNAME': 'cltbld', 20:06:43 INFO - 'MAIL': '/var/mail/cltbld', 20:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:43 INFO - 'MOZ_NO_REMOTE': '1', 20:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:43 INFO - 'NO_EM_RESTART': '1', 20:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:43 INFO - 'PWD': '/builds/slave/test', 20:06:43 INFO - 'SHELL': '/bin/bash', 20:06:43 INFO - 'SHLVL': '1', 20:06:43 INFO - 'TERM': 'linux', 20:06:43 INFO - 'TMOUT': '86400', 20:06:43 INFO - 'USER': 'cltbld', 20:06:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:43 INFO - '_': '/tools/buildbot/bin/python'} 20:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:43 INFO - Running setup.py (path:/tmp/pip-zV0hpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:43 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)) 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:43 INFO - Running setup.py (path:/tmp/pip-1jyNW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:43 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)) 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:43 INFO - Running setup.py (path:/tmp/pip-FQzNym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:43 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)) 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:43 INFO - Running setup.py (path:/tmp/pip-oI9P9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:43 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)) 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:43 INFO - Running setup.py (path:/tmp/pip-LBZOpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:43 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)) 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:43 INFO - Running setup.py (path:/tmp/pip-Fxb6jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:43 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)) 20:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:43 INFO - Running setup.py (path:/tmp/pip-9dVFuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:44 INFO - Running setup.py (path:/tmp/pip-FJjrbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:44 INFO - Running setup.py (path:/tmp/pip-kaKxXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:44 INFO - Running setup.py (path:/tmp/pip-29byvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:44 INFO - Running setup.py (path:/tmp/pip-hcHX17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:44 INFO - Running setup.py (path:/tmp/pip-ZcHTko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:44 INFO - Running setup.py (path:/tmp/pip-_U2czx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:44 INFO - Running setup.py (path:/tmp/pip-oH8I23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:44 INFO - Running setup.py (path:/tmp/pip-alnjcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:44 INFO - Running setup.py (path:/tmp/pip-KiNqhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:44 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)) 20:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:44 INFO - Running setup.py (path:/tmp/pip-VbSHb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:44 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)) 20:06:44 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)) 20:06:44 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)) 20:06:44 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)) 20:06:44 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)) 20:06:44 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)) 20:06:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:46 INFO - Downloading blessings-1.6.tar.gz 20:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:46 INFO - Installing collected packages: blessings 20:06:46 INFO - Running setup.py install for blessings 20:06:46 INFO - Successfully installed blessings 20:06:46 INFO - Cleaning up... 20:06:46 INFO - Return code: 0 20:06:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:47 INFO - Reading from file tmpfile_stdout 20:06:47 INFO - Current package versions: 20:06:47 INFO - argparse == 1.2.1 20:06:47 INFO - blessings == 1.6 20:06:47 INFO - blobuploader == 1.2.4 20:06:47 INFO - docopt == 0.6.1 20:06:47 INFO - manifestparser == 1.1 20:06:47 INFO - mozInstall == 1.12 20:06:47 INFO - mozcrash == 0.17 20:06:47 INFO - mozdebug == 0.1 20:06:47 INFO - mozdevice == 0.48 20:06:47 INFO - mozfile == 1.2 20:06:47 INFO - mozhttpd == 0.7 20:06:47 INFO - mozinfo == 0.9 20:06:47 INFO - mozleak == 0.1 20:06:47 INFO - mozlog == 3.1 20:06:47 INFO - moznetwork == 0.27 20:06:47 INFO - mozprocess == 0.22 20:06:47 INFO - mozprofile == 0.28 20:06:47 INFO - mozrunner == 6.11 20:06:47 INFO - mozscreenshot == 0.1 20:06:47 INFO - mozsystemmonitor == 0.0 20:06:47 INFO - moztest == 0.7 20:06:47 INFO - mozversion == 1.4 20:06:47 INFO - psutil == 3.1.1 20:06:47 INFO - requests == 1.2.3 20:06:47 INFO - wsgiref == 0.1.2 20:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:47 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 20:06:47 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 20:06:47 INFO - Using env: {'DISPLAY': ':0', 20:06:47 INFO - 'HOME': '/home/cltbld', 20:06:47 INFO - 'LANG': 'en_US.UTF-8', 20:06:47 INFO - 'LANGUAGE': 'en_US:en', 20:06:47 INFO - 'LOGNAME': 'cltbld', 20:06:47 INFO - 'MAIL': '/var/mail/cltbld', 20:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:47 INFO - 'MOZ_NO_REMOTE': '1', 20:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:47 INFO - 'NO_EM_RESTART': '1', 20:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:47 INFO - 'PWD': '/builds/slave/test', 20:06:47 INFO - 'SHELL': '/bin/bash', 20:06:47 INFO - 'SHLVL': '1', 20:06:47 INFO - 'TERM': 'linux', 20:06:47 INFO - 'TMOUT': '86400', 20:06:47 INFO - 'USER': 'cltbld', 20:06:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:47 INFO - '_': '/tools/buildbot/bin/python'} 20:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 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)) 20:06:47 INFO - Cleaning up... 20:06:47 INFO - Return code: 0 20:06:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:06:47 INFO - Using env: {'DISPLAY': ':0', 20:06:47 INFO - 'HOME': '/home/cltbld', 20:06:47 INFO - 'LANG': 'en_US.UTF-8', 20:06:47 INFO - 'LANGUAGE': 'en_US:en', 20:06:47 INFO - 'LOGNAME': 'cltbld', 20:06:47 INFO - 'MAIL': '/var/mail/cltbld', 20:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:47 INFO - 'MOZ_NO_REMOTE': '1', 20:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:47 INFO - 'NO_EM_RESTART': '1', 20:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:47 INFO - 'PWD': '/builds/slave/test', 20:06:47 INFO - 'SHELL': '/bin/bash', 20:06:47 INFO - 'SHLVL': '1', 20:06:47 INFO - 'TERM': 'linux', 20:06:47 INFO - 'TMOUT': '86400', 20:06:47 INFO - 'USER': 'cltbld', 20:06:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:47 INFO - '_': '/tools/buildbot/bin/python'} 20:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:47 INFO - Downloading/unpacking jsonschema 20:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:49 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:49 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 20:06:49 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 20:06:49 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 20:06:49 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 20:06:49 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 20:06:49 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 20:06:49 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:49 INFO - warning: no files found matching '*.txt' 20:06:49 INFO - no previously-included directories found matching 'build' 20:06:49 INFO - no previously-included directories found matching 'dist' 20:06:49 INFO - no previously-included directories found matching '.git*' 20:06:49 INFO - Installing collected packages: jsonschema, functools32 20:06:50 INFO - Running setup.py install for functools32 20:06:50 INFO - warning: no files found matching '*.txt' 20:06:50 INFO - no previously-included directories found matching 'build' 20:06:50 INFO - no previously-included directories found matching 'dist' 20:06:50 INFO - no previously-included directories found matching '.git*' 20:06:50 INFO - Successfully installed jsonschema functools32 20:06:50 INFO - Cleaning up... 20:06:50 INFO - Return code: 0 20:06:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:50 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')]} 20:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:50 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')]} 20:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:50 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 0x7f1ca95d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', '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 20:06:50 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 20:06:50 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 20:06:50 INFO - Using env: {'DISPLAY': ':0', 20:06:50 INFO - 'HOME': '/home/cltbld', 20:06:50 INFO - 'LANG': 'en_US.UTF-8', 20:06:50 INFO - 'LANGUAGE': 'en_US:en', 20:06:50 INFO - 'LOGNAME': 'cltbld', 20:06:50 INFO - 'MAIL': '/var/mail/cltbld', 20:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:50 INFO - 'MOZ_NO_REMOTE': '1', 20:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:50 INFO - 'NO_EM_RESTART': '1', 20:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:50 INFO - 'PWD': '/builds/slave/test', 20:06:50 INFO - 'SHELL': '/bin/bash', 20:06:50 INFO - 'SHLVL': '1', 20:06:50 INFO - 'TERM': 'linux', 20:06:50 INFO - 'TMOUT': '86400', 20:06:50 INFO - 'USER': 'cltbld', 20:06:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:50 INFO - '_': '/tools/buildbot/bin/python'} 20:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:50 INFO - Downloading/unpacking flake8 20:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:53 INFO - no previously-included directories found matching 'docs/_build' 20:06:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:53 INFO - Running setup.py install for pep8 20:06:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:53 INFO - no previously-included directories found matching 'docs/_build' 20:06:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:53 INFO - Cleaning up... 20:06:53 INFO - Return code: 0 20:06:53 INFO - Running post-action listener: _resource_record_post_action 20:06:53 INFO - Running post-action listener: _start_resource_monitoring 20:06:53 INFO - Starting resource monitoring. 20:06:53 INFO - ##### 20:06:53 INFO - ##### Running install step. 20:06:53 INFO - ##### 20:06:53 INFO - Running pre-action listener: _resource_record_pre_action 20:06:53 INFO - Running main action method: install 20:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Output received: 20:06:54 INFO - Usage: mozinstall [options] installer 20:06:54 INFO - Options: 20:06:54 INFO - -h, --help show this help message and exit 20:06:54 INFO - -d DEST, --destination=DEST 20:06:54 INFO - Directory to install application into. [default: 20:06:54 INFO - "/builds/slave/test"] 20:06:54 INFO - --app=APP Application being installed. [default: firefox] 20:06:54 INFO - mkdir: /builds/slave/test/build/application 20:06:54 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'] 20:06:54 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 20:07:10 INFO - Reading from file tmpfile_stdout 20:07:10 INFO - Output received: 20:07:10 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:10 INFO - Running post-action listener: _resource_record_post_action 20:07:10 INFO - ##### 20:07:10 INFO - ##### Running run-tests step. 20:07:10 INFO - ##### 20:07:10 INFO - Running pre-action listener: _resource_record_pre_action 20:07:10 INFO - Running main action method: run_tests 20:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:10 INFO - Python 2.7.3 20:07:10 INFO - Return code: 0 20:07:10 INFO - grabbing minidump binary from tooltool 20:07:10 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')]} 20:07:10 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 0x104c410>, '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 0x104d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:10 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 20:07:10 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 20:07:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:10 INFO - Return code: 0 20:07:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:07:11 INFO - Return code: 0 20:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 20:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 20:07:11 INFO - Using env: {'DISPLAY': ':0', 20:07:11 INFO - 'HOME': '/home/cltbld', 20:07:11 INFO - 'LANG': 'en_US.UTF-8', 20:07:11 INFO - 'LANGUAGE': 'en_US:en', 20:07:11 INFO - 'LOGNAME': 'cltbld', 20:07:11 INFO - 'MAIL': '/var/mail/cltbld', 20:07:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:11 INFO - 'MOZ_NO_REMOTE': '1', 20:07:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:11 INFO - 'NO_EM_RESTART': '1', 20:07:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:11 INFO - 'PWD': '/builds/slave/test', 20:07:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:11 INFO - 'SHELL': '/bin/bash', 20:07:11 INFO - 'SHLVL': '1', 20:07:11 INFO - 'TERM': 'linux', 20:07:11 INFO - 'TMOUT': '86400', 20:07:11 INFO - 'USER': 'cltbld', 20:07:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563', 20:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:11 INFO - '_': '/tools/buildbot/bin/python'} 20:07:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 20:07:11 INFO - mozversion application_buildid: 20160422173006 20:07:11 INFO - mozversion application_changeset: 3bc647d9bb02ea0284ea7653161f49c9dd2982e4 20:07:11 INFO - mozversion application_display_name: Nightly 20:07:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:11 INFO - mozversion application_name: Firefox 20:07:11 INFO - mozversion application_remotingname: firefox 20:07:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:07:11 INFO - mozversion application_vendor: Mozilla 20:07:11 INFO - mozversion application_version: 48.0a1 20:07:11 INFO - mozversion platform_buildid: 20160422173006 20:07:11 INFO - mozversion platform_changeset: 3bc647d9bb02ea0284ea7653161f49c9dd2982e4 20:07:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:07:11 INFO - mozversion platform_version: 48.0a1 20:07:11 INFO - using testdate: 1461380831 20:07:11 INFO - actual date: 1461380831 20:07:11 INFO - starting webserver on 'localhost:57482' 20:07:11 INFO - SUITE-START | Running 2 tests 20:07:11 INFO - TEST-START | dromaeo_css 20:07:11 INFO - operating with platform_type : linux_ 20:07:11 INFO - Initialising browser for dromaeo_css test... 20:07:11 INFO - TEST-INFO | started process 7104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoLFa6m/profile http://localhost:57482/getInfo.html) 20:07:16 INFO - PROCESS | 7104 | 20:07:16 INFO - PROCESS | 7104 | (process:7169): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:17 INFO - PROCESS | 7104 | __metrics Screen width/height:1600/1200 20:07:17 INFO - PROCESS | 7104 | colorDepth:24 20:07:17 INFO - PROCESS | 7104 | Browser inner width/height: 1024/697 20:07:17 INFO - PROCESS | 7104 | __metrics 20:07:18 ERROR - PROCESS | 7104 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:07:19 INFO - TEST-INFO | 7104: exit 0 20:07:19 INFO - Browser initialized. 20:07:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:19 INFO - TEST-INFO | started process 7220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoLFa6m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:20 INFO - PROCESS | 7220 | 20:07:20 INFO - PROCESS | 7220 | (process:7280): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:30 INFO - PROCESS | 7220 | RSS: Main: 164515840 20:07:30 INFO - PROCESS | 7220 | 20:08:20 INFO - PROCESS | 7220 | 1461380900449 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] 20:10:27 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57482/tests/dromaeo/cssquery-ext.html) 20:10:28 INFO - PROCESS | 7220 | RSS: Main: 169418752 20:10:28 INFO - PROCESS | 7220 | 20:13:30 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-ext.html (next: http://localhost:57482/tests/dromaeo/cssquery-jquery.html) 20:13:31 INFO - PROCESS | 7220 | RSS: Main: 165670912 20:13:31 INFO - PROCESS | 7220 | 20:16:33 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57482/tests/dromaeo/cssquery-mootools.html) 20:16:33 INFO - PROCESS | 7220 | RSS: Main: 167358464 20:16:33 INFO - PROCESS | 7220 | 20:19:35 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57482/tests/dromaeo/cssquery-prototype.html) 20:19:35 INFO - PROCESS | 7220 | RSS: Main: 164773888 20:19:35 INFO - PROCESS | 7220 | 20:22:38 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57482/tests/dromaeo/cssquery-yui.html) 20:22:39 INFO - PROCESS | 7220 | RSS: Main: 166113280 20:22:39 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-yui.html (next: http://localhost:57482/tests/dromaeo/cssquery-dojo.html) 20:25:41 INFO - PROCESS | 7220 | RSS: Main: 168046592 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | __start_tp_report 20:25:41 INFO - PROCESS | 7220 | _x_x_mozilla_page_load 20:25:41 INFO - PROCESS | 7220 | _x_x_mozilla_page_load_details 20:25:41 INFO - PROCESS | 7220 | |i|pagename|runs| 20:25:41 INFO - PROCESS | 7220 | |0;dojo.html;3111.471049921514;3160.8261545614987;3167.9841600791992;3191.1064901827494;3202.5676533667947;5309.097453432916;5323.76043078061;5347.7326133693305;5350.946490535093;5374.946250537493;5192.558632516231;5288.101022826119;5290.418054014055;5357.678539287645;5402.702851343174;4796.280557916306;4834.033193361324;4877.341558889558;4902.509749025105;4962.578180854632;700.0413798863383;4700.858974230779;4761.238201887699;4833.492483289257;4890.486498917616;4845.055214233226;4860.708357498544;4865.68373055752;4888.9511104889025;4920.655554111214;4841.8063277468855;4844.249141383091;4857.052874689437;4865.19724245499;4880.536349046835;4658.138244424792;4788.377510923592;4842.297866809328;4877.853664390074;4887.95112048882;5197.922031169498;5200;5205.141151709963;5207.218917162418;5252.8686782830355;5524.171374293848;5622.887542249132;5625;5626.803061892855;5643.435656434365;5745;5748.310202775694;5757.827265182052;5819.912701309484;5855.736491857834;5288.709120998344;5296.682199068068;5305.44292849253;5314.654547454403;5318.680879147263;5595.104783234663;5728.427157284322;5787.594868359259;5791.710414479259;5848.2397288353095;5582.720863956867;5583.302087239095;5590.413006634326;5599.412061733541;5631.099024156116;5647.745851436695;5662.094064949588;5662.490375866192;5662.773489060474;5672.149177623307;5506.779728810803;5610.943890561124;5626.2685850839125;5637.295338082739;5679.801206957819;5619.578531610146;5647.011772939802;5654.5193658538665;5655.660660360391;5697.230873832063;4259.723117997382;4286.764227967492;4294.763787991628;4298.312270036841;4325.416068830667;3784.1674831537016;3876.9418458723144;3880.553736320303;3894.5521265054313;3936.566977632458;5327.547158491494;5431.619786614978;5478.58910581708;5542.2795036644975;5596.3284405871555;5632.52123569493;5647.745851436695;5659.688717120598;5661.915071273934;5678.574106941914;5296.09966305729;5429.83710488678;5432.158015507603;5458.4541545845095;5508.91736623951;4882.658213925062;4903.632227582945;4903.926441103386;4921.409430868319;4943.209086546135;5878.882422351529;5913.615614985099;5920.911186332209;5923.881522369528;5928.288605367384;5482.862928426662;5696.060150075191;5711.600187986967;5715.742791574306;5762.596618236767;5925.614835035709;5941.792037278675;5949.91075133882;5950.4644581986095;5968.045112781934;5637.408072152365;5644.6330988485615;5647.971760141338;5651.4348565143155;5656;5598.048331783525;5603.747831347518;5639.943600563942;5698.772049117989;5739.167820665896;5566.415526369673;5568.303962004749;5582.4138465462165;5589.55283577321;5619.943800561942;5568.777248909998;5573.581981351496;5580.386157522588;5580.553555715452;5582.385937546947;5299.7615107321035;5401.8919621606565;5494.615376923737;5512.91730624033;5535.916961245504;5548.9722551386985;5598.076317407745;5631.7184140793615;5639.097744360883;5654.575906806924;5459.153831156177;5460.726963651722;5489.64317319373;5500.28496295479;5503.394626590992 20:25:41 INFO - PROCESS | 7220 | |1;ext.html;612.7916508387148;636.3000699230847;642.1876326447045;653.1215515132145;668.4886062162446;28915.710842891564;35098.29803403933;35774.642253577455;35806.8209658952;35860.2827943441;35525.644743552555;36031.279374412494;36155;36162.45756313657;36200.637993620054;8321.375896807733;8454.492730436163;8485.957570212171;8506.489610623352;8522.531260780655;8415.747527574153;8523.57382130894;8537.658493660278;8569.742907712747;8571.485710857338;8627.352948528855;8630.525321107336;8666.350023748213;8685.218330350268;8689.04420513743;8569.185927336894;8584.31325493959;8600.655973761042;8613.870791938127;8659.393842431033;8078.636461359194;8084.919150808475;8110.594470276522;8127.187281271885;8135.227153420416;39014;39623.60376396228;39658.40512392316;39669.22315437921;39736.80131599352;3398.0825177202264;3436.6563343665434;3519.9616113246652;3539.1859872229275;3574.6782789549065;26101;26558.86720566385;26778.464430711276;26866.328341791417;26965.46069078627;4100.7334523255895;4159.396887451303;4176.91646167078;4177.26897792885;4215.156968606291;294458;294774;295918;296200;297851;49546.752266238436;49761;49796.50203497991;49867.25199121943;49941.25088123681;61419.38580614136;62871;63081.68459157675;63113.368866310746;63428;16203.351865925231;16369.42707005249;16452.34190632385;16458.588535286475;16508.092054937093;11542.653720388402;11653.184277100521;11670.241434306743;11708;11747.412629368497;18615;18683.626327473376;18806.52983675419;18938.337158199673;18968.33610823642;7082.929170708227;7097.757892368815;7279.1265048194555;7307.3423391894985;7417.147028091838;1052.1372474570778;1079.9028087472166;1086.6196831109207;1100.8899110089087;1137.5336112194127;30349;30613.846930765205;31096.22259443532;31412.37175256482;31630.841845790623;972.2367941166151;1105.7125147461556;1121.3384103379046;1146.5700362364114;1148.9655310340704;14577.416903323749;14631.049567020058;14962.336290558542;15028.774568381483;15037.849621503863;478481;485880;486335;486669;489034;51676.74161629168;53162.46837531575;53320.46679533233;53330;53662.7316863421;1346.670065833877;1404.389090745529;1429.0496819614839;1438.7266419380285;1451.1945870042227;28432.147035588965;28444.288892777848;28807.855960720062;29236.415271694874;29275.85362073261;45428;51958;53986;54036.459635403146;54281.457185427644;315359;318683;318972;320427;321006;38711.29020968505;39184.412233817086;39244.41133382944;39460.40809387919;39495.80252098836;42811.35782963196;43112.56887431211;43796.34305485484;43920.78039609781;47244.7637761809;38532;39271.58668637921;39712;39839.601603984745;40720.3891941627;38611;39670;40095.799521002205;40231.59768402279;40410;34396.82801585976;39509.604903950596;41230.587694122674;42912;44309.77845110754;32077.198070048435;33214.5017824728;33387.33225335431;33508.49737253894;33806.32387352288;25695.614565781154;26345.60481592816;26632.60051099274;27157.59263611087;27167.59248611312 20:25:41 INFO - PROCESS | 7220 | |2;jquery.html;376.6365755963412;383.17617123185164;392.26450405489703;397.84682897084616;398.63126607887733;16667.41664041759;18070.909645451753;18386.540336491576;18472.907635461837;18593.628127437478;17819.821801781978;18181.636367272647;18437.354692585763;18493.167807448663;18698.15858286377;5458.4541545845295;5497.285352904127;5649.067903795889;5677.829665110054;5693.231413759131;5467.699276539789;5543.833684989457;5547.472990065938;5557.749901254453;5569.805056823012;5300.072487314724;5504.146857237135;5511.338639363282;5537.473939975716;5540.806071787489;5491.780328786864;5532.197831314477;5546.473085056933;5557.110862262039;5564.081926482126;4898.2162853943555;4956.3804524434445;4988.02733466974;4992.575631071363;4994.225894986283;22088;22179.11283548672;22194.778052219594;22250.109995600156;22583.54832903333;2401.1955994741784;2483.503299340121;2520.6345079963303;2572.5626643470655;2812.02984970185;13508.594742157653;13516.864831351659;13677.726445471135;13826.170429774145;14333.068350557285;1829.7895741989576;1892.6120145370166;1904.1241029126618;1920.6830872905953;1939.4084804134734;74180.62909685471;74549.62725186393;74610.626946866;75298.62350688211;76671.23328766697;9809.460479673686;9841.950790246146;10099.293049486465;10284.382937023653;10445;13963.371648275852;14033.929830350782;14034.43862245519;14053.85946140546;14073.648158795908;7793.337566306927;7804.219578042151;7872.488288261245;7949.7217597383815;8051.396145289127;7562.886556701654;7647.273509016634;7840.09838868526;7879.133295337509;7896.249856263646;6067.848303792441;6238.157848690459;6254.124422580842;6350.523710721714;6354.142190804275;1847.9630407392046;1869.3831035758167;1893.6118095790605;1901.1159810688096;1914.5309399197286;864.2955990867423;909.8407778638712;953.4851180362526;957.4877440569401;1018.180364806338;17471.20693531861;17684.557886052953;17901.19444624969;18127.2574611109;18202.271909123487;972.4457059476172;976.2824324121765;990.8166989107038;1004.2066767253933;1078.9676309710721;10269.332493387907;10336.844947325797;10350.954244190725;10372.948135259276;10542.103921166787;394361;401099;403340;403717;414694;71193;75466.24533754592;78774;79348.20651793409;80736.59631701803;1046.1839764983174;1055.5724931402794;1058.9470526473644;1078.4769386847372;1086.7337502311984;16474.505764827074;17017.82982170212;17121;17149.056801876017;17245.310187592357;22938.311850644506;24904.37739056538;35214;36734;37099.25801484009;48105.278420823015;48110.27834582414;48386;48527.5147248523;48648.75675621599;8099;8113.7565873023905;8151.918480815116;8160.591970401338;8242.052164000977;7086.822829429099;12543.372831358578;12807.93596032014;12876.291803950873;12971;11131.220814542905;11189.440527973406;11301.71745706364;11447.885521145015;11725.296482211095;11027.44862756875;11193.72015699614;11194.152964760724;11308.660740177807;11310.83033754478;11485.138614604106;11575.536978521102;11685.649430517098;11728.648140555797;11886;8127.1466496017065;8200.138985406445;8256.339492840678;8266.504009759434;8321.043080045873;11427;11495.137864660017;11550.249233799776;11582.073434125417;11600.94199528997 20:25:41 INFO - PROCESS | 7220 | |3;mootools.html;1388.3266615691389;1410.4499245294337;1416.7166566686665;1428.6785473268512;1482.362584088842;7053.0478385417955;7501.624918754061;7652.579108149056;7653.31120199182;7841.568713720743;7877.487963282382;7918.0894197167345;7929.246721561442;7943.404244681643;7961.641726122324;2275.6358982562833;2275.7838005389544;2281.3384118605586;2290.4044948313476;2297.8506397084134;2183.1049269799387;2192.166976548909;2219.367480268124;2221.0782525252002;2229.9219527316545;2216.7783221677864;2223.377454312795;2245.3264020793777;2253.8873056347197;2281.817454603636;2182.2798476502717;2186.606410846047;2191.495955930129;2198.835087368454;2204.437868343562;2142.057494702326;2156.9784302156936;2159.524904521003;2159.946001349963;2160.611090003799;7648;7730.7294244701725;7759.185285544993;7774.144844067148;7911.090224624184;4986.202207646759;5105.948940510584;5128.8461346159675;5136.383633963948;5138.768755406016;3136.6549679535233;3260.576125103745;3328.700416962485;3355.5302257683697;3374.561307030095;1153.2215754365852;1159.431878379588;1162.8197629367462;1169.2692067457838;1172.73613436976;10917.181211409175;10976.012158905736;11024.779504409868;11030.338179709242;11090.445477726162;4243.469566304212;4339.587739164775;4343.04453020335;4402.801873915681;4467.218236808546;9350.625974960925;9362.812743745088;9410.106039926197;9442.716718498456;9448.763780905394;5002.774875130628;5048.5203905628905;5074.035933172685;5083.186690129562;5111.233315002779;4256.553061928515;4634.351190833286;4686.906261874743;4721.3390125382475;4763.69036012658;3732.64539868712;3764.5294338207723;3812.599677033927;3855.768653880776;3879.4568760373572;1194.7491026884277;1196.3778835005749;1208.0758219961735;1211.236920739928;1223.9143259971715;868.6134670071883;925.9861102083474;931.2084727981297;962.4562122400821;977.7360112769512;5473.397926228112;5540.2243685884005;5579.944200558024;5590.301212348457;5635.520980716685;391.9059425737859;403.1071177342201;417.2447869356474;417.32393522493754;419.8656429942389;3991.1020020495157;4004.2391945530258;4059.594040595917;4098.672106231495;4104.52797928242;9852.605895764233;10312.690619281433;10354.326968747007;10358.482075896174;10425.635102771366;10135.341202821794;10241.975802419847;10263.2302577307;10268.281220314655;10277.075063244343;7785.18255583167;7836.373090152774;7838.412119091091;7892.4869883457395;7911.881321780178;5685.744141513725;5726.654236254561;5730.684812335361;5834.358220595816;5841.824745257649;9433.669821556212;9455.952720236355;9482.478463684563;9486.28852836054;9712.223022158352;9096.636134554543;9302.767430814283;9325.347225694137;9405.95297023538;9422.199113075465;6418.614883107029;6820.522563420712;7000.194977577644;7690.923090769021;7946.046474423106;7900.762977110696;7951.363890888831;7956.920430795618;7965.442419030844;8000.4399692021;7050.894236586353;7287.344139027513;7297.562146271241;7315.085614298213;7352.669129889061;7085.14978202619;7129.7861064168155;7185.065941427581;7211.38703210212;7306.086739157606;6467.902981455376;6534.83662908412;6590.275069742229;6597.2742998271115;6610.504212184009;4891.095147397743;4984.42679091909;4987.177115775857;5008.749562521933;5071.442141364373;4960.057589058068;5090.567301779242;5107.642465027412;5127.64117508853;5251.816186433456 20:25:41 INFO - PROCESS | 7220 | |4;prototype.html;302.6973026973027;305.410557623786;307.6754024504149;312.82950791818445;312.9405412971534;5979.282486101669;6036.12476190952;6036.909446358308;6066.150738896553;6090.695465226743;5973.850653733648;5984.64092154471;6008.158857759917;6009.669468179249;6013.188219590354;4243.978780106095;4367.847125350613;4494.460664720238;4501.414816073906;4528.886777830564;4467.5755803198645;4498.370228168059;4519.887002824923;4532.637389008888;4538.092381523692;4488.743151917468;4493.3484644726495;4505.43682039745;4508.571685689854;4516.412866327373;4380.802863871133;4485.282354823229;4499.392582001421;4521.751303678297;4523.32150177476;3885.203533275672;3897.649211570944;3904.39481880309;3907.159960608483;3909.4526766252748;5694.345150307726;5698.715064246812;5714.200011998323;5720.799772008001;5724.370319264877;5093.694378337312;5102.872428189325;5115.872103197413;5225.921611175835;5232.424433312332;6142.754289828402;6162.352952939967;6178.752849885999;6217.751289948442;6227;4260.360945858146;4298.26929421999;4307.504636966726;4322.416473776063;4331.783410829477;6321;6504.902426463606;6519.739210431624;6535.0850880876715;6562.442192413603;4386.670999675037;4408.493023302297;4411.448568928884;4430.867073987721;4430.933535996963;4267.125239325931;4482.103579284091;4482.506924238396;4486.170058539181;4487.865364039084;5173.534381905646;5197.922031169535;5207.29701490294;5210.84367468969;5226.72637402731;6337.904931426032;6345.873082538324;6355.459785918156;6366.936330636727;6371.74513019474;1503.5639664497392;1530.0972426268554;1554.6735185610921;1568.9843101569068;1578.0689393258033;1018.1040684198007;1022.6522982186092;1048.6591857646295;1048.8059708953867;1050.8528805967171;6055.485283750931;6066.847299013173;6081.8479538011015;6085.117657939574;6102.908456373158;6429.54993150475;6460.773872914426;6473.967630161819;6479.643619600967;6503.414692677682;5953.3451320354725;6199;6239.625622462576;6245.406686364788;6250.9062364064575;3470.89587312376;3506.561679790026;3527.4655524846776;3547.52108465359;3549.1482044309696;6475.4819614430735;6747.291534388818;6843.794686159423;6875.449964002868;6880.552764070319;6645.568038077509;6684.131062961881;6685.732570697215;6720.260771315151;6729.1252137221845;6664.300248473937;6829.93170068293;6847.760328388582;6864.141982252118;6865.382115609519;6509.772157974448;6560.081588577507;6579.4736421085245;6582.210134783665;6583.539152259296;6145.631262124287;6446.774362897276;6482.319356467691;6499.545031847914;6500.804975850732;6766.661666916733;6806.591604503746;6809.557378770364;6814.454843612598;6836.794896153124;4168.583141685807;4175.770332631734;4176.331786914079;4192.601702838226;4201.18076974987;6427.357264273535;6473.870522589427;6499.707513162014;6502.024696295404;6538.705758240986;6367.458766004756;6379.170707807955;6383.96808015957;6408.711607977745;6417.8395540110005;6261.68691565429;6319.3364696706185;6356.237251529846;6409;6412.839679008062;6084.90872636902;6216.844578885564;6254.124422580751;6277.340879207617;6305.842353941188;6365.713542890674;6378.808635740936;6444.712127194965;6464.709088091141;6481.0926470295135;6102.6643534604245;6281.246250449975;6282.403171698681;6296.150019747275;6305.117283580211 20:25:41 INFO - PROCESS | 7220 | |5;yui.html;693.5076095971859;736.797380720302;749.2058418076836;754.5397307642337;765.9999999999993;12398.938005309972;12434.937825310872;12460.376981150928;12532.498700051987;12643.178193417421;11320.773584528304;11456;11457.427128643556;11466.08271338293;11480.598179063714;627.4823270801584;763.5113527342505;772.8840673898918;778.01581000035;779.76996785948;623.9438450539451;625.1841347042108;628.4061561824078;628.6573817269576;629.9212598425197;806.9596520173997;810.4934415990007;812.2202685421972;813.4631143445328;813.495632707722;809.4536188073027;811.1604489353491;812.3907069697726;812.7033632724073;812.7968007998;590.7371219807187;594.3996563470882;597.9760809567612;599.0983569727532;599.5952731905946;11759.47082381295;11867.169298149047;11885.524579016828;11895.821562676567;11914.106442016884;10701.571937122506;10906.485273408513;10922.726931826688;11006.009459148636;11437.656870293904;9899.604015839357;9953;9991.773462975625;10069.69790906274;10103.292769506137;3716.4239542870896;3735.0475628714776;3751.756135851161;3762.887113386603;3765.3222419964395;51775.22337164945;51798.741006294724;51896.22155667668;52437;52625.210621840706;8352.16478352172;8430.789230269293;8671.609777560025;8709.520976346235;9547.140757331734;15947.202639868192;15983.44057957966;15992.92003539975;16137.677246455005;16164.595885102966;7475.415716007913;7603;7622.428317876071;7766.417518686121;7776.455648104691;4100.36444351126;4123.299039163289;4152.294110001307;4215;4274.893127671771;2928.6192794936524;3030.863611137504;3056.8930087446834;3131.639861415966;3229.3218424131196;599.6252342286072;601.7713268957856;609.0225188572366;610.1488423648984;618.6350053468385;616.1312549305458;651.5308977536262;655.8327626455318;661.2312065225502;698.7744035247753;8378.371622128365;8378.413511054168;8700.912990870136;8850.911490885137;9212.953935230282;707.0878566648965;710.5736558065223;718.57963091592;722.9096362954631;731.1445608637906;4126.711130220916;4222.3244280914905;4250.42619246404;4278.63631591312;4282.400463935051;64013.35986640167;64931.35068649253;65068.67465662736;65189.67405162944;65869;54195.76748673874;55475;55649.721751390985;55979.44020559742;56664.716676416356;50889.49110508922;51658.74170629123;51867.22199167016;52340.73829630828;52573.7371313141;8092.878606820785;8135.430519863789;8154.796130096795;8302.667893284442;8359.582020899052;32635.18412039623;32928;33214;33329.50005749867;33812.323753525285;42158.36762448504;46131;46186.769066154455;46742.76628616835;46870.06259874852;10104.595816167272;10112;10157.746056348651;10347.586096556053;10766.623168189075;11070.889291106985;11097.445127743418;11212.66362009141;11314.377709226072;11517.308961462339;11229.606963756229;11406.429678515875;11717.355545445082;11744.530218791153;11874.406279686154;10229.84655230187;10398.428086455318;10501.107405870282;10694.19793515474;10781.083607893102;10938.507767150657;11285.71785705364;11300.039496642548;11359.54561817551;11651.067914566984;8478.194571515696;8505;8677.739667809976;8794.472331660121;8906.198442140238;9149;9283.72148835536;9407.952960235156;9439.433633981984;9703.12671859536 20:25:41 INFO - PROCESS | 7220 | __end_tp_report 20:25:41 INFO - PROCESS | 7220 | __start_cc_report 20:25:41 INFO - PROCESS | 7220 | _x_x_mozilla_cycle_collect,352 20:25:41 INFO - PROCESS | 7220 | __end_cc_report 20:25:41 INFO - PROCESS | 7220 | __startTimestamp1461381941495__endTimestamp 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | ------- Summary: start ------- 20:25:41 INFO - PROCESS | 7220 | Number of tests: 6 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | [#0] dojo.html Cycles:165 Average:5259.98 Median:5512.92 stddev:690.89 (12.5%) stddev-sans-first:672.13 20:25:41 INFO - PROCESS | 7220 | Values: 3111.5 3160.8 3168.0 3191.1 3202.6 5309.1 5323.8 5347.7 5350.9 5374.9 5192.6 5288.1 5290.4 5357.7 5402.7 4796.3 4834.0 4877.3 4902.5 4962.6 700.0 4700.9 4761.2 4833.5 4890.5 4845.1 4860.7 4865.7 4889.0 4920.7 4841.8 4844.2 4857.1 4865.2 4880.5 4658.1 4788.4 4842.3 4877.9 4888.0 5197.9 5200.0 5205.1 5207.2 5252.9 5524.2 5622.9 5625.0 5626.8 5643.4 5745.0 5748.3 5757.8 5819.9 5855.7 5288.7 5296.7 5305.4 5314.7 5318.7 5595.1 5728.4 5787.6 5791.7 5848.2 5582.7 5583.3 5590.4 5599.4 5631.1 5647.7 5662.1 5662.5 5662.8 5672.1 5506.8 5610.9 5626.3 5637.3 5679.8 5619.6 5647.0 5654.5 5655.7 5697.2 4259.7 4286.8 4294.8 4298.3 4325.4 3784.2 3876.9 3880.6 3894.6 3936.6 5327.5 5431.6 5478.6 5542.3 5596.3 5632.5 5647.7 5659.7 5661.9 5678.6 5296.1 5429.8 5432.2 5458.5 5508.9 4882.7 4903.6 4903.9 4921.4 4943.2 5878.9 5913.6 5920.9 5923.9 5928.3 5482.9 5696.1 5711.6 5715.7 5762.6 5925.6 5941.8 5949.9 5950.5 5968.0 5637.4 5644.6 5648.0 5651.4 5656.0 5598.0 5603.7 5639.9 5698.8 5739.2 5566.4 5568.3 5582.4 5589.6 5619.9 5568.8 5573.6 5580.4 5580.6 5582.4 5299.8 5401.9 5494.6 5512.9 5535.9 5549.0 5598.1 5631.7 5639.1 5654.6 5459.2 5460.7 5489.6 5500.3 5503.4 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | [#1] ext.html Cycles:180 Average:52783.31 Median:39258.00 stddev:99502.99 (253.5%) stddev-sans-first:99705.03 20:25:41 INFO - PROCESS | 7220 | Values: 612.8 636.3 642.2 653.1 668.5 28915.7 35098.3 35774.6 35806.8 35860.3 35525.6 36031.3 36155.0 36162.5 36200.6 8321.4 8454.5 8486.0 8506.5 8522.5 8415.7 8523.6 8537.7 8569.7 8571.5 8627.4 8630.5 8666.4 8685.2 8689.0 8569.2 8584.3 8600.7 8613.9 8659.4 8078.6 8084.9 8110.6 8127.2 8135.2 39014.0 39623.6 39658.4 39669.2 39736.8 3398.1 3436.7 3520.0 3539.2 3574.7 26101.0 26558.9 26778.5 26866.3 26965.5 4100.7 4159.4 4176.9 4177.3 4215.2 294458.0 294774.0 295918.0 296200.0 297851.0 49546.8 49761.0 49796.5 49867.3 49941.3 61419.4 62871.0 63081.7 63113.4 63428.0 16203.4 16369.4 16452.3 16458.6 16508.1 11542.7 11653.2 11670.2 11708.0 11747.4 18615.0 18683.6 18806.5 18938.3 18968.3 7082.9 7097.8 7279.1 7307.3 7417.1 1052.1 1079.9 1086.6 1100.9 1137.5 30349.0 30613.8 31096.2 31412.4 31630.8 972.2 1105.7 1121.3 1146.6 1149.0 14577.4 14631.0 14962.3 15028.8 15037.8 478481.0 485880.0 486335.0 486669.0 489034.0 51676.7 53162.5 53320.5 53330.0 53662.7 1346.7 1404.4 1429.0 1438.7 1451.2 28432.1 28444.3 28807.9 29236.4 29275.9 45428.0 51958.0 53986.0 54036.5 54281.5 315359.0 318683.0 318972.0 320427.0 321006.0 38711.3 39184.4 39244.4 39460.4 39495.8 42811.4 43112.6 43796.3 43920.8 47244.8 38532.0 39271.6 39712.0 39839.6 40720.4 38611.0 39670.0 40095.8 40231.6 40410.0 34396.8 39509.6 41230.6 42912.0 44309.8 32077.2 33214.5 33387.3 33508.5 33806.3 25695.6 26345.6 26632.6 27157.6 27167.6 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | [#2] jquery.html Cycles:180 Average:25269.48 Median:2692.30 stddev:66488.36 (2469.6%) stddev-sans-first:66648.61 20:25:41 INFO - PROCESS | 7220 | Values: 376.6 383.2 392.3 397.8 398.6 16667.4 18070.9 18386.5 18472.9 18593.6 17819.8 18181.6 18437.4 18493.2 18698.2 5458.5 5497.3 5649.1 5677.8 5693.2 5467.7 5543.8 5547.5 5557.7 5569.8 5300.1 5504.1 5511.3 5537.5 5540.8 5491.8 5532.2 5546.5 5557.1 5564.1 4898.2 4956.4 4988.0 4992.6 4994.2 22088.0 22179.1 22194.8 22250.1 22583.5 2401.2 2483.5 2520.6 2572.6 2812.0 13508.6 13516.9 13677.7 13826.2 14333.1 1829.8 1892.6 1904.1 1920.7 1939.4 74180.6 74549.6 74610.6 75298.6 76671.2 9809.5 9842.0 10099.3 10284.4 10445.0 13963.4 14033.9 14034.4 14053.9 14073.6 7793.3 7804.2 7872.5 7949.7 8051.4 7562.9 7647.3 7840.1 7879.1 7896.2 6067.8 6238.2 6254.1 6350.5 6354.1 1848.0 1869.4 1893.6 1901.1 1914.5 864.3 909.8 953.5 957.5 1018.2 17471.2 17684.6 17901.2 18127.3 18202.3 972.4 976.3 990.8 1004.2 1079.0 10269.3 10336.8 10351.0 10372.9 10542.1 394361.0 401099.0 403340.0 403717.0 414694.0 71193.0 75466.2 78774.0 79348.2 80736.6 1046.2 1055.6 1058.9 1078.5 1086.7 16474.5 17017.8 17121.0 17149.1 17245.3 22938.3 24904.4 35214.0 36734.0 37099.3 48105.3 48110.3 48386.0 48527.5 48648.8 8099.0 8113.8 8151.9 8160.6 8242.1 7086.8 12543.4 12807.9 12876.3 12971.0 11131.2 11189.4 11301.7 11447.9 11725.3 11027.4 11193.7 11194.2 11308.7 11310.8 11485.1 11575.5 11685.6 11728.6 11886.0 8127.1 8200.1 8256.3 8266.5 8321.0 11427.0 11495.1 11550.2 11582.1 11600.9 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | [#3] mootools.html Cycles:180 Average:5413.54 Median:5028.63 stddev:3015.23 (60.0%) stddev-sans-first:3008.51 20:25:41 INFO - PROCESS | 7220 | Values: 1388.3 1410.4 1416.7 1428.7 1482.4 7053.0 7501.6 7652.6 7653.3 7841.6 7877.5 7918.1 7929.2 7943.4 7961.6 2275.6 2275.8 2281.3 2290.4 2297.9 2183.1 2192.2 2219.4 2221.1 2229.9 2216.8 2223.4 2245.3 2253.9 2281.8 2182.3 2186.6 2191.5 2198.8 2204.4 2142.1 2157.0 2159.5 2159.9 2160.6 7648.0 7730.7 7759.2 7774.1 7911.1 4986.2 5105.9 5128.8 5136.4 5138.8 3136.7 3260.6 3328.7 3355.5 3374.6 1153.2 1159.4 1162.8 1169.3 1172.7 10917.2 10976.0 11024.8 11030.3 11090.4 4243.5 4339.6 4343.0 4402.8 4467.2 9350.6 9362.8 9410.1 9442.7 9448.8 5002.8 5048.5 5074.0 5083.2 5111.2 4256.6 4634.4 4686.9 4721.3 4763.7 3732.6 3764.5 3812.6 3855.8 3879.5 1194.7 1196.4 1208.1 1211.2 1223.9 868.6 926.0 931.2 962.5 977.7 5473.4 5540.2 5579.9 5590.3 5635.5 391.9 403.1 417.2 417.3 419.9 3991.1 4004.2 4059.6 4098.7 4104.5 9852.6 10312.7 10354.3 10358.5 10425.6 10135.3 10242.0 10263.2 10268.3 10277.1 7785.2 7836.4 7838.4 7892.5 7911.9 5685.7 5726.7 5730.7 5834.4 5841.8 9433.7 9456.0 9482.5 9486.3 9712.2 9096.6 9302.8 9325.3 9406.0 9422.2 6418.6 6820.5 7000.2 7690.9 7946.0 7900.8 7951.4 7956.9 7965.4 8000.4 7050.9 7287.3 7297.6 7315.1 7352.7 7085.1 7129.8 7185.1 7211.4 7306.1 6467.9 6534.8 6590.3 6597.3 6610.5 4891.1 4984.4 4987.2 5008.7 5071.4 4960.1 5090.6 5107.6 5127.6 5251.8 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | [#4] prototype.html Cycles:180 Average:5267.75 Median:6066.50 stddev:1623.48 (26.8%) stddev-sans-first:1584.69 20:25:41 INFO - PROCESS | 7220 | Values: 302.7 305.4 307.7 312.8 312.9 5979.3 6036.1 6036.9 6066.2 6090.7 5973.9 5984.6 6008.2 6009.7 6013.2 4244.0 4367.8 4494.5 4501.4 4528.9 4467.6 4498.4 4519.9 4532.6 4538.1 4488.7 4493.3 4505.4 4508.6 4516.4 4380.8 4485.3 4499.4 4521.8 4523.3 3885.2 3897.6 3904.4 3907.2 3909.5 5694.3 5698.7 5714.2 5720.8 5724.4 5093.7 5102.9 5115.9 5225.9 5232.4 6142.8 6162.4 6178.8 6217.8 6227.0 4260.4 4298.3 4307.5 4322.4 4331.8 6321.0 6504.9 6519.7 6535.1 6562.4 4386.7 4408.5 4411.4 4430.9 4430.9 4267.1 4482.1 4482.5 4486.2 4487.9 5173.5 5197.9 5207.3 5210.8 5226.7 6337.9 6345.9 6355.5 6366.9 6371.7 1503.6 1530.1 1554.7 1569.0 1578.1 1018.1 1022.7 1048.7 1048.8 1050.9 6055.5 6066.8 6081.8 6085.1 6102.9 6429.5 6460.8 6474.0 6479.6 6503.4 5953.3 6199.0 6239.6 6245.4 6250.9 3470.9 3506.6 3527.5 3547.5 3549.1 6475.5 6747.3 6843.8 6875.4 6880.6 6645.6 6684.1 6685.7 6720.3 6729.1 6664.3 6829.9 6847.8 6864.1 6865.4 6509.8 6560.1 6579.5 6582.2 6583.5 6145.6 6446.8 6482.3 6499.5 6500.8 6766.7 6806.6 6809.6 6814.5 6836.8 4168.6 4175.8 4176.3 4192.6 4201.2 6427.4 6473.9 6499.7 6502.0 6538.7 6367.5 6379.2 6384.0 6408.7 6417.8 6261.7 6319.3 6356.2 6409.0 6412.8 6084.9 6216.8 6254.1 6277.3 6305.8 6365.7 6378.8 6444.7 6464.7 6481.1 6102.7 6281.2 6282.4 6296.2 6305.1 20:25:41 INFO - PROCESS | 7220 | 20:25:41 INFO - PROCESS | 7220 | [#5] yui.html Cycles:180 Average:14002.67 Median:52599.47 stddev:17423.29 (33.1%) stddev-sans-first:17443.51 20:25:41 INFO - PROCESS | 7220 | Values: 693.5 736.8 749.2 754.5 766.0 12398.9 12434.9 12460.4 12532.5 12643.2 11320.8 11456.0 11457.4 11466.1 11480.6 627.5 763.5 772.9 778.0 779.8 623.9 625.2 628.4 628.7 629.9 807.0 810.5 812.2 813.5 813.5 809.5 811.2 812.4 812.7 812.8 590.7 594.4 598.0 599.1 599.6 11759.5 11867.2 11885.5 11895.8 11914.1 10701.6 10906.5 10922.7 11006.0 11437.7 9899.6 9953.0 9991.8 10069.7 10103.3 3716.4 3735.0 3751.8 3762.9 3765.3 51775.2 51798.7 51896.2 52437.0 52625.2 8352.2 8430.8 8671.6 8709.5 9547.1 15947.2 15983.4 15992.9 16137.7 16164.6 7475.4 7603.0 7622.4 7766.4 7776.5 4100.4 4123.3 4152.3 4215.0 4274.9 2928.6 3030.9 3056.9 3131.6 3229.3 599.6 601.8 609.0 610.1 618.6 616.1 651.5 655.8 661.2 698.8 8378.4 8378.4 8700.9 8850.9 9213.0 707.1 710.6 718.6 722.9 731.1 4126.7 4222.3 4250.4 4278.6 4282.4 64013.4 64931.4 65068.7 65189.7 65869.0 54195.8 55475.0 55649.7 55979.4 56664.7 50889.5 51658.7 51867.2 52340.7 52573.7 8092.9 8135.4 8154.8 8302.7 8359.6 32635.2 32928.0 33214.0 33329.5 33812.3 42158.4 46131.0 46186.8 46742.8 46870.1 10104.6 10112.0 10157.7 10347.6 10766.6 11070.9 11097.4 11212.7 11314.4 11517.3 11229.6 11406.4 11717.4 11744.5 11874.4 10229.8 10398.4 10501.1 10694.2 10781.1 10938.5 11285.7 11300.0 11359.5 11651.1 8478.2 8505.0 8677.7 8794.5 8906.2 9149.0 9283.7 9408.0 9439.4 9703.1 20:25:41 INFO - PROCESS | 7220 | -------- Summary: end -------- 20:25:41 INFO - PROCESS | 7220 | 20:25:42 INFO - TEST-INFO | 7220: exit 0 20:25:42 INFO - TEST-OK | dromaeo_css | took 1110306ms 20:25:42 INFO - TEST-START | kraken 20:25:42 INFO - operating with platform_type : linux_ 20:25:42 INFO - Initialising browser for kraken test... 20:25:42 INFO - TEST-INFO | started process 7458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOtIcQx/profile http://localhost:57482/getInfo.html) 20:25:46 INFO - PROCESS | 7458 | 20:25:46 INFO - PROCESS | 7458 | (process:7524): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:25:47 INFO - PROCESS | 7458 | __metrics Screen width/height:1600/1200 20:25:47 INFO - PROCESS | 7458 | colorDepth:24 20:25:47 INFO - PROCESS | 7458 | Browser inner width/height: 1024/697 20:25:47 INFO - PROCESS | 7458 | __metrics 20:25:48 ERROR - PROCESS | 7458 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:25:49 INFO - TEST-INFO | 7458: exit 0 20:25:49 INFO - Browser initialized. 20:25:49 INFO - Running cycle 1/1 for kraken test... 20:25:49 INFO - TEST-INFO | started process 7575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOtIcQx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:50 INFO - PROCESS | 7575 | 20:25:50 INFO - PROCESS | 7575 | (process:7634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:26:00 INFO - PROCESS | 7575 | RSS: Main: 164503552 20:26:00 INFO - PROCESS | 7575 | 20:26:03 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:04 INFO - PROCESS | 7575 | RSS: Main: 168943616 20:26:04 INFO - PROCESS | 7575 | 20:26:07 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-dft) 20:26:07 INFO - PROCESS | 7575 | RSS: Main: 172285952 20:26:07 INFO - PROCESS | 7575 | 20:26:10 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-fft) 20:26:11 INFO - PROCESS | 7575 | RSS: Main: 163270656 20:26:11 INFO - PROCESS | 7575 | 20:26:13 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-oscillator) 20:26:13 INFO - PROCESS | 7575 | RSS: Main: 163934208 20:26:13 INFO - PROCESS | 7575 | 20:26:16 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:16 INFO - PROCESS | 7575 | RSS: Main: 164290560 20:26:16 INFO - PROCESS | 7575 | 20:26:19 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:20 INFO - PROCESS | 7575 | RSS: Main: 164745216 20:26:20 INFO - PROCESS | 7575 | 20:26:23 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:24 INFO - PROCESS | 7575 | RSS: Main: 164970496 20:26:24 INFO - PROCESS | 7575 | 20:26:27 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57482/tests/kraken/driver.html?testName=json-parse-financial) 20:26:27 INFO - PROCESS | 7575 | RSS: Main: 167387136 20:26:27 INFO - PROCESS | 7575 | 20:26:29 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:30 INFO - PROCESS | 7575 | RSS: Main: 167096320 20:26:30 INFO - PROCESS | 7575 | 20:26:31 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:32 INFO - PROCESS | 7575 | RSS: Main: 166989824 20:26:32 INFO - PROCESS | 7575 | 20:26:34 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:35 INFO - PROCESS | 7575 | RSS: Main: 168058880 20:26:35 INFO - PROCESS | 7575 | 20:26:37 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:38 INFO - PROCESS | 7575 | RSS: Main: 167366656 20:26:38 INFO - PROCESS | 7575 | 20:26:41 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:41 INFO - PROCESS | 7575 | RSS: Main: 167514112 20:26:41 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57482/tests/kraken/driver.html?testName=ai-astar) 20:26:43 INFO - PROCESS | 7575 | RSS: Main: 169361408 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | __start_tp_report 20:26:43 INFO - PROCESS | 7575 | _x_x_mozilla_page_load 20:26:43 INFO - PROCESS | 7575 | _x_x_mozilla_page_load_details 20:26:43 INFO - PROCESS | 7575 | |i|pagename|runs| 20:26:43 INFO - PROCESS | 7575 | |0;ai-astar;113;108;111;111;112;122;113;112;111;109 20:26:43 INFO - PROCESS | 7575 | |1;audio-beat-detection;154;127;157;174;136;168;162;136;187;128 20:26:43 INFO - PROCESS | 7575 | |2;audio-dft;162;162;162;163;162;166;175;161;163;162 20:26:43 INFO - PROCESS | 7575 | |3;audio-fft;76;73;73;152;76;77;78;75;159;76 20:26:43 INFO - PROCESS | 7575 | |4;audio-oscillator;93;93;159;94;92;92;152;93;91;139 20:26:43 INFO - PROCESS | 7575 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 20:26:43 INFO - PROCESS | 7575 | |6;imaging-darkroom;146;147;147;147;145;146;147;148;147;147 20:26:43 INFO - PROCESS | 7575 | |7;imaging-desaturate;94;95;96;95;95;95;94;95;96;94 20:26:43 INFO - PROCESS | 7575 | |8;json-parse-financial;59;59;58;59;60;62;59;74;60;58 20:26:43 INFO - PROCESS | 7575 | |9;json-stringify-tinderbox;61;61;60;61;61;61;60;61;61;61 20:26:43 INFO - PROCESS | 7575 | |10;stanford-crypto-aes;77;89;77;77;86;77;78;78;78;76 20:26:43 INFO - PROCESS | 7575 | |11;stanford-crypto-ccm;134;132;133;125;127;128;125;128;170;128 20:26:43 INFO - PROCESS | 7575 | |12;stanford-crypto-pbkdf2;173;174;172;172;170;167;172;164;175;173 20:26:43 INFO - PROCESS | 7575 | |13;stanford-crypto-sha256-iterative;69;68;72;80;69;68;68;67;68;67 20:26:43 INFO - PROCESS | 7575 | __end_tp_report 20:26:43 INFO - PROCESS | 7575 | __start_cc_report 20:26:43 INFO - PROCESS | 7575 | _x_x_mozilla_cycle_collect,886 20:26:43 INFO - PROCESS | 7575 | __end_cc_report 20:26:43 INFO - PROCESS | 7575 | __startTimestamp1461382003847__endTimestamp 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | ------- Summary: start ------- 20:26:43 INFO - PROCESS | 7575 | Number of tests: 14 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:3.79 (3.4%) stddev-sans-first:4.01 20:26:43 INFO - PROCESS | 7575 | Values: 113.0 108.0 111.0 111.0 112.0 122.0 113.0 112.0 111.0 109.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:159.50 stddev:20.55 (12.9%) stddev-sans-first:21.79 20:26:43 INFO - PROCESS | 7575 | Values: 154.0 127.0 157.0 174.0 136.0 168.0 162.0 136.0 187.0 128.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#2] audio-dft Cycles:10 Average:163.80 Median:162.50 stddev:4.16 (2.6%) stddev-sans-first:4.36 20:26:43 INFO - PROCESS | 7575 | Values: 162.0 162.0 162.0 163.0 162.0 166.0 175.0 161.0 163.0 162.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#3] audio-fft Cycles:10 Average:91.50 Median:76.00 stddev:33.81 (44.5%) stddev-sans-first:35.39 20:26:43 INFO - PROCESS | 7575 | Values: 76.0 73.0 73.0 152.0 76.0 77.0 78.0 75.0 159.0 76.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.50 stddev:28.16 (30.4%) stddev-sans-first:29.21 20:26:43 INFO - PROCESS | 7575 | Values: 93.0 93.0 159.0 94.0 92.0 92.0 152.0 93.0 91.0 139.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:26:43 INFO - PROCESS | 7575 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 20:26:43 INFO - PROCESS | 7575 | Values: 146.0 147.0 147.0 147.0 145.0 146.0 147.0 148.0 147.0 147.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 20:26:43 INFO - PROCESS | 7575 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 96.0 94.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.50 stddev:4.78 (8.0%) stddev-sans-first:5.02 20:26:43 INFO - PROCESS | 7575 | Values: 59.0 59.0 58.0 59.0 60.0 62.0 59.0 74.0 60.0 58.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 20:26:43 INFO - PROCESS | 7575 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.00 stddev:4.42 (5.7%) stddev-sans-first:4.61 20:26:43 INFO - PROCESS | 7575 | Values: 77.0 89.0 77.0 77.0 86.0 77.0 78.0 78.0 78.0 76.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:130.00 stddev:13.37 (10.3%) stddev-sans-first:14.18 20:26:43 INFO - PROCESS | 7575 | Values: 134.0 132.0 133.0 125.0 127.0 128.0 125.0 128.0 170.0 128.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.50 stddev:3.36 (1.9%) stddev-sans-first:3.50 20:26:43 INFO - PROCESS | 7575 | Values: 173.0 174.0 172.0 172.0 170.0 167.0 172.0 164.0 175.0 173.0 20:26:43 INFO - PROCESS | 7575 | 20:26:43 INFO - PROCESS | 7575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.50 stddev:3.92 (5.7%) stddev-sans-first:4.15 20:26:43 INFO - PROCESS | 7575 | Values: 69.0 68.0 72.0 80.0 69.0 68.0 68.0 67.0 68.0 67.0 20:26:43 INFO - PROCESS | 7575 | -------- Summary: end -------- 20:26:43 INFO - PROCESS | 7575 | 20:26:44 INFO - TEST-INFO | 7575: exit 0 20:26:44 INFO - TEST-OK | kraken | took 62586ms 20:26:44 INFO - SUITE-END | took 1172s 20:26:45 INFO - Completed test suite (00:19:33) 20:26:45 INFO - javascript benchmark 20:26:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.471049921514, 3160.8261545614987, 3167.9841600791992, 3191.1064901827494, 3202.5676533667947, 5309.097453432916, 5323.76043078061, 5347.7326133693305, 5350.946490535093, 5374.946250537493, 5192.558632516231, 5288.101022826119, 5290.418054014055, 5357.678539287645, 5402.702851343174, 4796.280557916306, 4834.033193361324, 4877.341558889558, 4902.509749025105, 4962.578180854632, 700.0413798863383, 4700.858974230779, 4761.238201887699, 4833.492483289257, 4890.486498917616, 4845.055214233226, 4860.708357498544, 4865.68373055752, 4888.9511104889025, 4920.655554111214, 4841.8063277468855, 4844.249141383091, 4857.052874689437, 4865.19724245499, 4880.536349046835, 4658.138244424792, 4788.377510923592, 4842.297866809328, 4877.853664390074, 4887.95112048882, 5197.922031169498, 5200.0, 5205.141151709963, 5207.218917162418, 5252.8686782830355, 5524.171374293848, 5622.887542249132, 5625.0, 5626.803061892855, 5643.435656434365, 5745.0, 5748.310202775694, 5757.827265182052, 5819.912701309484, 5855.736491857834, 5288.709120998344, 5296.682199068068, 5305.44292849253, 5314.654547454403, 5318.680879147263, 5595.104783234663, 5728.427157284322, 5787.594868359259, 5791.710414479259, 5848.2397288353095, 5582.720863956867, 5583.302087239095, 5590.413006634326, 5599.412061733541, 5631.099024156116, 5647.745851436695, 5662.094064949588, 5662.490375866192, 5662.773489060474, 5672.149177623307, 5506.779728810803, 5610.943890561124, 5626.2685850839125, 5637.295338082739, 5679.801206957819, 5619.578531610146, 5647.011772939802, 5654.5193658538665, 5655.660660360391, 5697.230873832063, 4259.723117997382, 4286.764227967492, 4294.763787991628, 4298.312270036841, 4325.416068830667, 3784.1674831537016, 3876.9418458723144, 3880.553736320303, 3894.5521265054313, 3936.566977632458, 5327.547158491494, 5431.619786614978, 5478.58910581708, 5542.2795036644975, 5596.3284405871555, 5632.52123569493, 5647.745851436695, 5659.688717120598, 5661.915071273934, 5678.574106941914, 5296.09966305729, 5429.83710488678, 5432.158015507603, 5458.4541545845095, 5508.91736623951, 4882.658213925062, 4903.632227582945, 4903.926441103386, 4921.409430868319, 4943.209086546135, 5878.882422351529, 5913.615614985099, 5920.911186332209, 5923.881522369528, 5928.288605367384, 5482.862928426662, 5696.060150075191, 5711.600187986967, 5715.742791574306, 5762.596618236767, 5925.614835035709, 5941.792037278675, 5949.91075133882, 5950.4644581986095, 5968.045112781934, 5637.408072152365, 5644.6330988485615, 5647.971760141338, 5651.4348565143155, 5656.0, 5598.048331783525, 5603.747831347518, 5639.943600563942, 5698.772049117989, 5739.167820665896, 5566.415526369673, 5568.303962004749, 5582.4138465462165, 5589.55283577321, 5619.943800561942, 5568.777248909998, 5573.581981351496, 5580.386157522588, 5580.553555715452, 5582.385937546947, 5299.7615107321035, 5401.8919621606565, 5494.615376923737, 5512.91730624033, 5535.916961245504, 5548.9722551386985, 5598.076317407745, 5631.7184140793615, 5639.097744360883, 5654.575906806924, 5459.153831156177, 5460.726963651722, 5489.64317319373, 5500.28496295479, 5503.394626590992], "value": 5216.063255025116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.7916508387148, 636.3000699230847, 642.1876326447045, 653.1215515132145, 668.4886062162446, 28915.710842891564, 35098.29803403933, 35774.642253577455, 35806.8209658952, 35860.2827943441, 35525.644743552555, 36031.279374412494, 36155.0, 36162.45756313657, 36200.637993620054, 8321.375896807733, 8454.492730436163, 8485.957570212171, 8506.489610623352, 8522.531260780655, 8415.747527574153, 8523.57382130894, 8537.658493660278, 8569.742907712747, 8571.485710857338, 8627.352948528855, 8630.525321107336, 8666.350023748213, 8685.218330350268, 8689.04420513743, 8569.185927336894, 8584.31325493959, 8600.655973761042, 8613.870791938127, 8659.393842431033, 8078.636461359194, 8084.919150808475, 8110.594470276522, 8127.187281271885, 8135.227153420416, 39014.0, 39623.60376396228, 39658.40512392316, 39669.22315437921, 39736.80131599352, 3398.0825177202264, 3436.6563343665434, 3519.9616113246652, 3539.1859872229275, 3574.6782789549065, 26101.0, 26558.86720566385, 26778.464430711276, 26866.328341791417, 26965.46069078627, 4100.7334523255895, 4159.396887451303, 4176.91646167078, 4177.26897792885, 4215.156968606291, 294458.0, 294774.0, 295918.0, 296200.0, 297851.0, 49546.752266238436, 49761.0, 49796.50203497991, 49867.25199121943, 49941.25088123681, 61419.38580614136, 62871.0, 63081.68459157675, 63113.368866310746, 63428.0, 16203.351865925231, 16369.42707005249, 16452.34190632385, 16458.588535286475, 16508.092054937093, 11542.653720388402, 11653.184277100521, 11670.241434306743, 11708.0, 11747.412629368497, 18615.0, 18683.626327473376, 18806.52983675419, 18938.337158199673, 18968.33610823642, 7082.929170708227, 7097.757892368815, 7279.1265048194555, 7307.3423391894985, 7417.147028091838, 1052.1372474570778, 1079.9028087472166, 1086.6196831109207, 1100.8899110089087, 1137.5336112194127, 30349.0, 30613.846930765205, 31096.22259443532, 31412.37175256482, 31630.841845790623, 972.2367941166151, 1105.7125147461556, 1121.3384103379046, 1146.5700362364114, 1148.9655310340704, 14577.416903323749, 14631.049567020058, 14962.336290558542, 15028.774568381483, 15037.849621503863, 478481.0, 485880.0, 486335.0, 486669.0, 489034.0, 51676.74161629168, 53162.46837531575, 53320.46679533233, 53330.0, 53662.7316863421, 1346.670065833877, 1404.389090745529, 1429.0496819614839, 1438.7266419380285, 1451.1945870042227, 28432.147035588965, 28444.288892777848, 28807.855960720062, 29236.415271694874, 29275.85362073261, 45428.0, 51958.0, 53986.0, 54036.459635403146, 54281.457185427644, 315359.0, 318683.0, 318972.0, 320427.0, 321006.0, 38711.29020968505, 39184.412233817086, 39244.41133382944, 39460.40809387919, 39495.80252098836, 42811.35782963196, 43112.56887431211, 43796.34305485484, 43920.78039609781, 47244.7637761809, 38532.0, 39271.58668637921, 39712.0, 39839.601603984745, 40720.3891941627, 38611.0, 39670.0, 40095.799521002205, 40231.59768402279, 40410.0, 34396.82801585976, 39509.604903950596, 41230.587694122674, 42912.0, 44309.77845110754, 32077.198070048435, 33214.5017824728, 33387.33225335431, 33508.49737253894, 33806.32387352288, 25695.614565781154, 26345.60481592816, 26632.60051099274, 27157.59263611087, 27167.59248611312], "value": 19054.17723912553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6365755963412, 383.17617123185164, 392.26450405489703, 397.84682897084616, 398.63126607887733, 16667.41664041759, 18070.909645451753, 18386.540336491576, 18472.907635461837, 18593.628127437478, 17819.821801781978, 18181.636367272647, 18437.354692585763, 18493.167807448663, 18698.15858286377, 5458.4541545845295, 5497.285352904127, 5649.067903795889, 5677.829665110054, 5693.231413759131, 5467.699276539789, 5543.833684989457, 5547.472990065938, 5557.749901254453, 5569.805056823012, 5300.072487314724, 5504.146857237135, 5511.338639363282, 5537.473939975716, 5540.806071787489, 5491.780328786864, 5532.197831314477, 5546.473085056933, 5557.110862262039, 5564.081926482126, 4898.2162853943555, 4956.3804524434445, 4988.02733466974, 4992.575631071363, 4994.225894986283, 22088.0, 22179.11283548672, 22194.778052219594, 22250.109995600156, 22583.54832903333, 2401.1955994741784, 2483.503299340121, 2520.6345079963303, 2572.5626643470655, 2812.02984970185, 13508.594742157653, 13516.864831351659, 13677.726445471135, 13826.170429774145, 14333.068350557285, 1829.7895741989576, 1892.6120145370166, 1904.1241029126618, 1920.6830872905953, 1939.4084804134734, 74180.62909685471, 74549.62725186393, 74610.626946866, 75298.62350688211, 76671.23328766697, 9809.460479673686, 9841.950790246146, 10099.293049486465, 10284.382937023653, 10445.0, 13963.371648275852, 14033.929830350782, 14034.43862245519, 14053.85946140546, 14073.648158795908, 7793.337566306927, 7804.219578042151, 7872.488288261245, 7949.7217597383815, 8051.396145289127, 7562.886556701654, 7647.273509016634, 7840.09838868526, 7879.133295337509, 7896.249856263646, 6067.848303792441, 6238.157848690459, 6254.124422580842, 6350.523710721714, 6354.142190804275, 1847.9630407392046, 1869.3831035758167, 1893.6118095790605, 1901.1159810688096, 1914.5309399197286, 864.2955990867423, 909.8407778638712, 953.4851180362526, 957.4877440569401, 1018.180364806338, 17471.20693531861, 17684.557886052953, 17901.19444624969, 18127.2574611109, 18202.271909123487, 972.4457059476172, 976.2824324121765, 990.8166989107038, 1004.2066767253933, 1078.9676309710721, 10269.332493387907, 10336.844947325797, 10350.954244190725, 10372.948135259276, 10542.103921166787, 394361.0, 401099.0, 403340.0, 403717.0, 414694.0, 71193.0, 75466.24533754592, 78774.0, 79348.20651793409, 80736.59631701803, 1046.1839764983174, 1055.5724931402794, 1058.9470526473644, 1078.4769386847372, 1086.7337502311984, 16474.505764827074, 17017.82982170212, 17121.0, 17149.056801876017, 17245.310187592357, 22938.311850644506, 24904.37739056538, 35214.0, 36734.0, 37099.25801484009, 48105.278420823015, 48110.27834582414, 48386.0, 48527.5147248523, 48648.75675621599, 8099.0, 8113.7565873023905, 8151.918480815116, 8160.591970401338, 8242.052164000977, 7086.822829429099, 12543.372831358578, 12807.93596032014, 12876.291803950873, 12971.0, 11131.220814542905, 11189.440527973406, 11301.71745706364, 11447.885521145015, 11725.296482211095, 11027.44862756875, 11193.72015699614, 11194.152964760724, 11308.660740177807, 11310.83033754478, 11485.138614604106, 11575.536978521102, 11685.649430517098, 11728.648140555797, 11886.0, 8127.1466496017065, 8200.138985406445, 8256.339492840678, 8266.504009759434, 8321.043080045873, 11427.0, 11495.137864660017, 11550.249233799776, 11582.073434125417, 11600.94199528997], "value": 8879.921225245722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.3266615691389, 1410.4499245294337, 1416.7166566686665, 1428.6785473268512, 1482.362584088842, 7053.0478385417955, 7501.624918754061, 7652.579108149056, 7653.31120199182, 7841.568713720743, 7877.487963282382, 7918.0894197167345, 7929.246721561442, 7943.404244681643, 7961.641726122324, 2275.6358982562833, 2275.7838005389544, 2281.3384118605586, 2290.4044948313476, 2297.8506397084134, 2183.1049269799387, 2192.166976548909, 2219.367480268124, 2221.0782525252002, 2229.9219527316545, 2216.7783221677864, 2223.377454312795, 2245.3264020793777, 2253.8873056347197, 2281.817454603636, 2182.2798476502717, 2186.606410846047, 2191.495955930129, 2198.835087368454, 2204.437868343562, 2142.057494702326, 2156.9784302156936, 2159.524904521003, 2159.946001349963, 2160.611090003799, 7648.0, 7730.7294244701725, 7759.185285544993, 7774.144844067148, 7911.090224624184, 4986.202207646759, 5105.948940510584, 5128.8461346159675, 5136.383633963948, 5138.768755406016, 3136.6549679535233, 3260.576125103745, 3328.700416962485, 3355.5302257683697, 3374.561307030095, 1153.2215754365852, 1159.431878379588, 1162.8197629367462, 1169.2692067457838, 1172.73613436976, 10917.181211409175, 10976.012158905736, 11024.779504409868, 11030.338179709242, 11090.445477726162, 4243.469566304212, 4339.587739164775, 4343.04453020335, 4402.801873915681, 4467.218236808546, 9350.625974960925, 9362.812743745088, 9410.106039926197, 9442.716718498456, 9448.763780905394, 5002.774875130628, 5048.5203905628905, 5074.035933172685, 5083.186690129562, 5111.233315002779, 4256.553061928515, 4634.351190833286, 4686.906261874743, 4721.3390125382475, 4763.69036012658, 3732.64539868712, 3764.5294338207723, 3812.599677033927, 3855.768653880776, 3879.4568760373572, 1194.7491026884277, 1196.3778835005749, 1208.0758219961735, 1211.236920739928, 1223.9143259971715, 868.6134670071883, 925.9861102083474, 931.2084727981297, 962.4562122400821, 977.7360112769512, 5473.397926228112, 5540.2243685884005, 5579.944200558024, 5590.301212348457, 5635.520980716685, 391.9059425737859, 403.1071177342201, 417.2447869356474, 417.32393522493754, 419.8656429942389, 3991.1020020495157, 4004.2391945530258, 4059.594040595917, 4098.672106231495, 4104.52797928242, 9852.605895764233, 10312.690619281433, 10354.326968747007, 10358.482075896174, 10425.635102771366, 10135.341202821794, 10241.975802419847, 10263.2302577307, 10268.281220314655, 10277.075063244343, 7785.18255583167, 7836.373090152774, 7838.412119091091, 7892.4869883457395, 7911.881321780178, 5685.744141513725, 5726.654236254561, 5730.684812335361, 5834.358220595816, 5841.824745257649, 9433.669821556212, 9455.952720236355, 9482.478463684563, 9486.28852836054, 9712.223022158352, 9096.636134554543, 9302.767430814283, 9325.347225694137, 9405.95297023538, 9422.199113075465, 6418.614883107029, 6820.522563420712, 7000.194977577644, 7690.923090769021, 7946.046474423106, 7900.762977110696, 7951.363890888831, 7956.920430795618, 7965.442419030844, 8000.4399692021, 7050.894236586353, 7287.344139027513, 7297.562146271241, 7315.085614298213, 7352.669129889061, 7085.14978202619, 7129.7861064168155, 7185.065941427581, 7211.38703210212, 7306.086739157606, 6467.902981455376, 6534.83662908412, 6590.275069742229, 6597.2742998271115, 6610.504212184009, 4891.095147397743, 4984.42679091909, 4987.177115775857, 5008.749562521933, 5071.442141364373, 4960.057589058068, 5090.567301779242, 5107.642465027412, 5127.64117508853, 5251.816186433456], "value": 4294.1897356408035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6973026973027, 305.410557623786, 307.6754024504149, 312.82950791818445, 312.9405412971534, 5979.282486101669, 6036.12476190952, 6036.909446358308, 6066.150738896553, 6090.695465226743, 5973.850653733648, 5984.64092154471, 6008.158857759917, 6009.669468179249, 6013.188219590354, 4243.978780106095, 4367.847125350613, 4494.460664720238, 4501.414816073906, 4528.886777830564, 4467.5755803198645, 4498.370228168059, 4519.887002824923, 4532.637389008888, 4538.092381523692, 4488.743151917468, 4493.3484644726495, 4505.43682039745, 4508.571685689854, 4516.412866327373, 4380.802863871133, 4485.282354823229, 4499.392582001421, 4521.751303678297, 4523.32150177476, 3885.203533275672, 3897.649211570944, 3904.39481880309, 3907.159960608483, 3909.4526766252748, 5694.345150307726, 5698.715064246812, 5714.200011998323, 5720.799772008001, 5724.370319264877, 5093.694378337312, 5102.872428189325, 5115.872103197413, 5225.921611175835, 5232.424433312332, 6142.754289828402, 6162.352952939967, 6178.752849885999, 6217.751289948442, 6227.0, 4260.360945858146, 4298.26929421999, 4307.504636966726, 4322.416473776063, 4331.783410829477, 6321.0, 6504.902426463606, 6519.739210431624, 6535.0850880876715, 6562.442192413603, 4386.670999675037, 4408.493023302297, 4411.448568928884, 4430.867073987721, 4430.933535996963, 4267.125239325931, 4482.103579284091, 4482.506924238396, 4486.170058539181, 4487.865364039084, 5173.534381905646, 5197.922031169535, 5207.29701490294, 5210.84367468969, 5226.72637402731, 6337.904931426032, 6345.873082538324, 6355.459785918156, 6366.936330636727, 6371.74513019474, 1503.5639664497392, 1530.0972426268554, 1554.6735185610921, 1568.9843101569068, 1578.0689393258033, 1018.1040684198007, 1022.6522982186092, 1048.6591857646295, 1048.8059708953867, 1050.8528805967171, 6055.485283750931, 6066.847299013173, 6081.8479538011015, 6085.117657939574, 6102.908456373158, 6429.54993150475, 6460.773872914426, 6473.967630161819, 6479.643619600967, 6503.414692677682, 5953.3451320354725, 6199.0, 6239.625622462576, 6245.406686364788, 6250.9062364064575, 3470.89587312376, 3506.561679790026, 3527.4655524846776, 3547.52108465359, 3549.1482044309696, 6475.4819614430735, 6747.291534388818, 6843.794686159423, 6875.449964002868, 6880.552764070319, 6645.568038077509, 6684.131062961881, 6685.732570697215, 6720.260771315151, 6729.1252137221845, 6664.300248473937, 6829.93170068293, 6847.760328388582, 6864.141982252118, 6865.382115609519, 6509.772157974448, 6560.081588577507, 6579.4736421085245, 6582.210134783665, 6583.539152259296, 6145.631262124287, 6446.774362897276, 6482.319356467691, 6499.545031847914, 6500.804975850732, 6766.661666916733, 6806.591604503746, 6809.557378770364, 6814.454843612598, 6836.794896153124, 4168.583141685807, 4175.770332631734, 4176.331786914079, 4192.601702838226, 4201.18076974987, 6427.357264273535, 6473.870522589427, 6499.707513162014, 6502.024696295404, 6538.705758240986, 6367.458766004756, 6379.170707807955, 6383.96808015957, 6408.711607977745, 6417.8395540110005, 6261.68691565429, 6319.3364696706185, 6356.237251529846, 6409.0, 6412.839679008062, 6084.90872636902, 6216.844578885564, 6254.124422580751, 6277.340879207617, 6305.842353941188, 6365.713542890674, 6378.808635740936, 6444.712127194965, 6464.709088091141, 6481.0926470295135, 6102.6643534604245, 6281.246250449975, 6282.403171698681, 6296.150019747275, 6305.117283580211], "value": 4728.151145995409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5076095971859, 736.797380720302, 749.2058418076836, 754.5397307642337, 765.9999999999993, 12398.938005309972, 12434.937825310872, 12460.376981150928, 12532.498700051987, 12643.178193417421, 11320.773584528304, 11456.0, 11457.427128643556, 11466.08271338293, 11480.598179063714, 627.4823270801584, 763.5113527342505, 772.8840673898918, 778.01581000035, 779.76996785948, 623.9438450539451, 625.1841347042108, 628.4061561824078, 628.6573817269576, 629.9212598425197, 806.9596520173997, 810.4934415990007, 812.2202685421972, 813.4631143445328, 813.495632707722, 809.4536188073027, 811.1604489353491, 812.3907069697726, 812.7033632724073, 812.7968007998, 590.7371219807187, 594.3996563470882, 597.9760809567612, 599.0983569727532, 599.5952731905946, 11759.47082381295, 11867.169298149047, 11885.524579016828, 11895.821562676567, 11914.106442016884, 10701.571937122506, 10906.485273408513, 10922.726931826688, 11006.009459148636, 11437.656870293904, 9899.604015839357, 9953.0, 9991.773462975625, 10069.69790906274, 10103.292769506137, 3716.4239542870896, 3735.0475628714776, 3751.756135851161, 3762.887113386603, 3765.3222419964395, 51775.22337164945, 51798.741006294724, 51896.22155667668, 52437.0, 52625.210621840706, 8352.16478352172, 8430.789230269293, 8671.609777560025, 8709.520976346235, 9547.140757331734, 15947.202639868192, 15983.44057957966, 15992.92003539975, 16137.677246455005, 16164.595885102966, 7475.415716007913, 7603.0, 7622.428317876071, 7766.417518686121, 7776.455648104691, 4100.36444351126, 4123.299039163289, 4152.294110001307, 4215.0, 4274.893127671771, 2928.6192794936524, 3030.863611137504, 3056.8930087446834, 3131.639861415966, 3229.3218424131196, 599.6252342286072, 601.7713268957856, 609.0225188572366, 610.1488423648984, 618.6350053468385, 616.1312549305458, 651.5308977536262, 655.8327626455318, 661.2312065225502, 698.7744035247753, 8378.371622128365, 8378.413511054168, 8700.912990870136, 8850.911490885137, 9212.953935230282, 707.0878566648965, 710.5736558065223, 718.57963091592, 722.9096362954631, 731.1445608637906, 4126.711130220916, 4222.3244280914905, 4250.42619246404, 4278.63631591312, 4282.400463935051, 64013.35986640167, 64931.35068649253, 65068.67465662736, 65189.67405162944, 65869.0, 54195.76748673874, 55475.0, 55649.721751390985, 55979.44020559742, 56664.716676416356, 50889.49110508922, 51658.74170629123, 51867.22199167016, 52340.73829630828, 52573.7371313141, 8092.878606820785, 8135.430519863789, 8154.796130096795, 8302.667893284442, 8359.582020899052, 32635.18412039623, 32928.0, 33214.0, 33329.50005749867, 33812.323753525285, 42158.36762448504, 46131.0, 46186.769066154455, 46742.76628616835, 46870.06259874852, 10104.595816167272, 10112.0, 10157.746056348651, 10347.586096556053, 10766.623168189075, 11070.889291106985, 11097.445127743418, 11212.66362009141, 11314.377709226072, 11517.308961462339, 11229.606963756229, 11406.429678515875, 11717.355545445082, 11744.530218791153, 11874.406279686154, 10229.84655230187, 10398.428086455318, 10501.107405870282, 10694.19793515474, 10781.083607893102, 10938.507767150657, 11285.71785705364, 11300.039496642548, 11359.54561817551, 11651.067914566984, 8478.194571515696, 8505.0, 8677.739667809976, 8794.472331660121, 8906.198442140238, 9149.0, 9283.72148835536, 9407.952960235156, 9439.433633981984, 9703.12671859536], "value": 6127.45711914451, "unit": "score"}], "name": "dromaeo_css", "value": 6920.001903749754, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 111.0, 111.0, 112.0, 122.0, 113.0, 112.0, 111.0, 109.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 157.0, 174.0, 136.0, 168.0, 162.0, 136.0, 187.0, 128.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 166.0, 175.0, 161.0, 163.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 73.0, 152.0, 76.0, 77.0, 78.0, 75.0, 159.0, 76.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 159.0, 94.0, 92.0, 92.0, 152.0, 93.0, 91.0, 139.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 62.0, 59.0, 74.0, 60.0, 58.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 89.0, 77.0, 77.0, 86.0, 77.0, 78.0, 78.0, 78.0, 76.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 133.0, 125.0, 127.0, 128.0, 125.0, 128.0, 170.0, 128.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 172.0, 172.0, 170.0, 167.0, 172.0, 164.0, 175.0, 173.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 72.0, 80.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1563.5, "alertThreshold": 2.0}]} 20:26:45 INFO - Return code: 0 20:26:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:45 ERROR - # TBPL SUCCESS # 20:26:45 INFO - Running post-action listener: _resource_record_post_action 20:26:45 INFO - Running post-run listener: _resource_record_post_run 20:26:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283439104; Read time: 16; Write time: 551680 20:26:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 716800; Read time: 0; Write time: 52 20:26:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282722304; Read time: 16; Write time: 551628 20:26:46 INFO - Running post-run listener: _upload_blobber_files 20:26:46 INFO - Blob upload gear active. 20:26:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:46 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 20:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:46 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:47 INFO - (blobuploader) - INFO - Done attempting. 20:26:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:48 INFO - (blobuploader) - INFO - Done attempting. 20:26:48 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:48 INFO - Return code: 0 20:26:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d14da4bb49d9769a3e16df9b7056aa1360902551f1b330df075966936d54ef17add2227aab282a59f96431da1abc9a3d720398cc8f7cee656d4b9714962af60a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a3c068c4df1d7ffe9bec56803085c8984f26081ea329ede12ed6b9171fefd66aaa4b7dc94ece0abbadbf9a0c1488d7a2e9493790397d1cfb11e5377810935be"} 20:26:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:48 INFO - Contents: 20:26:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d14da4bb49d9769a3e16df9b7056aa1360902551f1b330df075966936d54ef17add2227aab282a59f96431da1abc9a3d720398cc8f7cee656d4b9714962af60a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a3c068c4df1d7ffe9bec56803085c8984f26081ea329ede12ed6b9171fefd66aaa4b7dc94ece0abbadbf9a0c1488d7a2e9493790397d1cfb11e5377810935be"} 20:26:48 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:48 INFO - Copying logs to upload dir... 20:26:48 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.020652 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 20:26:48.270389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 20:26:48.274147) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d14da4bb49d9769a3e16df9b7056aa1360902551f1b330df075966936d54ef17add2227aab282a59f96431da1abc9a3d720398cc8f7cee656d4b9714962af60a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a3c068c4df1d7ffe9bec56803085c8984f26081ea329ede12ed6b9171fefd66aaa4b7dc94ece0abbadbf9a0c1488d7a2e9493790397d1cfb11e5377810935be"} build_url:https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/ZuxW5ymaRDywPEH1TCvcXg/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/sha512/d14da4bb49d9769a3e16df9b7056aa1360902551f1b330df075966936d54ef17add2227aab282a59f96431da1abc9a3d720398cc8f7cee656d4b9714962af60a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a3c068c4df1d7ffe9bec56803085c8984f26081ea329ede12ed6b9171fefd66aaa4b7dc94ece0abbadbf9a0c1488d7a2e9493790397d1cfb11e5377810935be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 20:26:48.303380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:26:48.303747) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461375603.913856-1416951563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 20:26:48.389035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 20:26:48.389754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 20:26:48.390479) ========= ========= Total master_lag: 0.24 =========