builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1461315253.19 results: success (0) buildid: 20160421233050 builduid: cc76337d732748279d00e8dcab10d2cb revision: 244de786f7140a642165d39b279e86ae1faa6895 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.194825) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.195279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.195569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.224808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.225089) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 01:54: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% 65.4M=0s 2016-04-22 01:54:13 (65.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.386369) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.386670) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.437685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:13.438031) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 244de786f7140a642165d39b279e86ae1faa6895 --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 244de786f7140a642165d39b279e86ae1faa6895 --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=9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 01:54:13,664 truncating revision to first 12 chars 2016-04-22 01:54:13,664 Setting DEBUG logging. 2016-04-22 01:54:13,664 attempt 1/10 2016-04-22 01:54:13,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/244de786f714?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 01:54:14,365 unpacking tar archive at: fx-team-244de786f714/testing/mozharness/ program finished with exit code 0 elapsedTime=0.974525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:14.426844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:14.427172) ========= script_repo_revision: 244de786f7140a642165d39b279e86ae1faa6895 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:14.427572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:14.427860) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 01:54:14.439794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 58 secs) (at 2016-04-22 01:54:14.440097) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:54:14 INFO - MultiFileLogger online at 20160422 01:54:14 in /builds/slave/test 01:54: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 01:54:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:14 INFO - {'append_to_log': False, 01:54:14 INFO - 'base_work_dir': '/builds/slave/test', 01:54:14 INFO - 'blob_upload_branch': 'Fx-Team', 01:54:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:14 INFO - 'branch': 'Fx-Team', 01:54:14 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:14 INFO - 'config_files': ('talos/linux_config.py',), 01:54:14 INFO - 'default_actions': ('clobber', 01:54:14 INFO - 'read-buildbot-config', 01:54:14 INFO - 'download-and-extract', 01:54:14 INFO - 'populate-webroot', 01:54:14 INFO - 'create-virtualenv', 01:54:14 INFO - 'install', 01:54:14 INFO - 'run-tests'), 01:54:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:14 INFO - 'download_minidump_stackwalk': True, 01:54:14 INFO - 'download_symbols': 'ondemand', 01:54:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:14 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:14 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:14 INFO - 'installer_path': 'installer.exe', 01:54:14 INFO - 'log_level': 'info', 01:54:14 INFO - 'log_name': 'talos', 01:54:14 INFO - 'log_to_console': True, 01:54:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:54:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:54:14 INFO - 'opt_config_files': (), 01:54:14 INFO - 'pip_index': False, 01:54:14 INFO - 'sps_profile': False, 01:54:14 INFO - 'sps_profile_interval': 0, 01:54:14 INFO - 'suite': 'dromaeojs-e10s', 01:54:14 INFO - 'system_bits': '32', 01:54:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:14 INFO - 'title': 'talos-linux64-ix-040', 01:54:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:14 INFO - 'use_talos_json': True, 01:54:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:14 INFO - 'work_dir': 'build'} 01:54:14 INFO - ##### 01:54:14 INFO - ##### Running clobber step. 01:54:14 INFO - ##### 01:54:14 INFO - Running pre-action listener: _resource_record_pre_action 01:54:14 INFO - Running main action method: clobber 01:54:14 INFO - rmtree: /builds/slave/test/build 01:54:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:15 INFO - Running post-action listener: _resource_record_post_action 01:54:15 INFO - ##### 01:54:15 INFO - ##### Running read-buildbot-config step. 01:54:15 INFO - ##### 01:54:15 INFO - Running pre-action listener: _resource_record_pre_action 01:54:15 INFO - Running main action method: read_buildbot_config 01:54:15 INFO - Using buildbot properties: 01:54:15 INFO - { 01:54:15 INFO - "project": "", 01:54:15 INFO - "product": "firefox", 01:54:15 INFO - "script_repo_revision": "production", 01:54:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:54:15 INFO - "repository": "", 01:54:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:54:15 INFO - "buildid": "20160421233050", 01:54:15 INFO - "pgo_build": "True", 01:54:15 INFO - "basedir": "/builds/slave/test", 01:54:15 INFO - "buildnumber": 678, 01:54:15 INFO - "slavename": "talos-linux64-ix-040", 01:54:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:54:15 INFO - "platform": "ubuntu64_hw", 01:54:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:54:15 INFO - "branch": "fx-team", 01:54:15 INFO - "repo_path": "integration/fx-team", 01:54:15 INFO - "revision": "244de786f7140a642165d39b279e86ae1faa6895", 01:54:15 INFO - "stage_platform": "linux64-pgo", 01:54:15 INFO - "builduid": "cc76337d732748279d00e8dcab10d2cb", 01:54:15 INFO - "slavebuilddir": "test" 01:54:15 INFO - } 01:54:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:54:15 INFO - Running post-action listener: _resource_record_post_action 01:54:15 INFO - ##### 01:54:15 INFO - ##### Running download-and-extract step. 01:54:15 INFO - ##### 01:54:15 INFO - Running pre-action listener: _resource_record_pre_action 01:54:15 INFO - Running main action method: download_and_extract 01:54:15 INFO - mkdir: /builds/slave/test/build/tests 01:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:15 INFO - https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:18 INFO - Downloaded 1361 bytes. 01:54:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:54:18 INFO - Using the following test package requirements: 01:54:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:54:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:54:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:54:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'jsshell-linux-x86_64.zip'], 01:54:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:54:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:54:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:54:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:54:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:54:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:54:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:54:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:54: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')]} 01:54:18 INFO - https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:54:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:54:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:54:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:20 INFO - Downloaded 23853527 bytes. 01:54: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'] 01:54: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 01:54:21 INFO - Return code: 0 01:54: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 01:54: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')]} 01:54:21 INFO - https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:54:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:54:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:23 INFO - Downloaded 23853527 bytes. 01:54:23 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'] 01:54:23 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 01:54:24 INFO - Return code: 0 01:54: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')]} 01:54:24 INFO - https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:25 INFO - Downloaded 10845952 bytes. 01:54: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'] 01:54: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 01:54:26 INFO - Return code: 0 01:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:26 INFO - https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5Sv03OTQwq40EqYeHEd6g/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 01:54:28 INFO - Downloaded 58338067 bytes. 01:54:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:54:28 INFO - mkdir: /builds/slave/test/properties 01:54:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:54:28 INFO - Writing to file /builds/slave/test/properties/build_url 01:54:28 INFO - Contents: 01:54:28 INFO - build_url:https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:54:29 INFO - Running post-action listener: _resource_record_post_action 01:54:29 INFO - Running post-action listener: set_extra_try_arguments 01:54:29 INFO - ##### 01:54:29 INFO - ##### Running populate-webroot step. 01:54:29 INFO - ##### 01:54:29 INFO - Running pre-action listener: _resource_record_pre_action 01:54:29 INFO - Running main action method: populate_webroot 01:54:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:54:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:54:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:54:29 INFO - '--tppagecycles', 01:54:29 INFO - '7'], 01:54:29 INFO - 'tests': ['tsvgm']}}, 01:54:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:54:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:54:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:54:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:54:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['damp', 'tps']}, 01:54:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'tests': ['damp', 'tps']}, 01:54:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['dromaeo_dom']}, 01:54:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:54:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['a11yr', 01:54:29 INFO - 'ts_paint', 01:54:29 INFO - 'tpaint', 01:54:29 INFO - 'sessionrestore', 01:54:29 INFO - 'sessionrestore_no_auto_restore', 01:54:29 INFO - 'tabpaint']}, 01:54:29 INFO - 'other-e10s': {'tests': ['a11yr', 01:54:29 INFO - 'ts_paint', 01:54:29 INFO - 'tpaint', 01:54:29 INFO - 'sessionrestore', 01:54:29 INFO - 'sessionrestore_no_auto_restore', 01:54:29 INFO - 'tabpaint']}, 01:54:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:54:29 INFO - 'ts_paint', 01:54:29 INFO - 'tpaint', 01:54:29 INFO - 'sessionrestore', 01:54:29 INFO - 'sessionrestore_no_auto_restore', 01:54:29 INFO - 'tabpaint']}, 01:54:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:54:29 INFO - 'ts_paint', 01:54:29 INFO - 'tpaint', 01:54:29 INFO - 'sessionrestore', 01:54:29 INFO - 'sessionrestore_no_auto_restore', 01:54:29 INFO - 'tabpaint']}, 01:54:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['a11yr', 01:54:29 INFO - 'ts_paint', 01:54:29 INFO - 'tpaint', 01:54:29 INFO - 'sessionrestore', 01:54:29 INFO - 'sessionrestore_no_auto_restore', 01:54:29 INFO - 'tabpaint']}, 01:54:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['a11yr', 01:54:29 INFO - 'ts_paint', 01:54:29 INFO - 'tpaint', 01:54:29 INFO - 'sessionrestore', 01:54:29 INFO - 'sessionrestore_no_auto_restore', 01:54:29 INFO - 'tabpaint']}, 01:54:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['tsvgx', 01:54:29 INFO - 'tsvgr_opacity', 01:54:29 INFO - 'tart', 01:54:29 INFO - 'tscrollx', 01:54:29 INFO - 'cart']}, 01:54:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:54:29 INFO - 'tsvgr_opacity', 01:54:29 INFO - 'tart', 01:54:29 INFO - 'tscrollx', 01:54:29 INFO - 'cart']}, 01:54:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'talos_options': ['--disable-e10s'], 01:54:29 INFO - 'tests': ['tp5o']}, 01:54:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'tests': ['tp5o']}, 01:54:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'talos_options': ['--disable-e10s', 01:54:29 INFO - '--xperf_path', 01:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:29 INFO - 'tests': ['tp5n']}, 01:54:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:29 INFO - 'talos_options': ['--xperf_path', 01:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:29 INFO - 'tests': ['tp5n']}}, 01:54:29 INFO - 'talos.zip': {'path': '', 01:54:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:54:29 INFO - Running post-action listener: _resource_record_post_action 01:54:29 INFO - ##### 01:54:29 INFO - ##### Running create-virtualenv step. 01:54:29 INFO - ##### 01:54:29 INFO - Running pre-action listener: _resource_record_pre_action 01:54:29 INFO - Running main action method: create_virtualenv 01:54:29 INFO - Creating virtualenv /builds/slave/test/build/venv 01:54:29 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 01:54:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:54:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:54:29 INFO - Using real prefix '/usr' 01:54:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:54:29 INFO - Installing distribute.............................................................................................................................................................................................done. 01:54:31 INFO - Installing pip.................done. 01:54:31 INFO - Return code: 0 01:54:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:31 INFO - Using env: {'DISPLAY': ':0', 01:54:31 INFO - 'HOME': '/home/cltbld', 01:54:31 INFO - 'LANG': 'en_US.UTF-8', 01:54:31 INFO - 'LANGUAGE': 'en_US:en', 01:54:31 INFO - 'LOGNAME': 'cltbld', 01:54:31 INFO - 'MAIL': '/var/mail/cltbld', 01:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:31 INFO - 'MOZ_NO_REMOTE': '1', 01:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:31 INFO - 'NO_EM_RESTART': '1', 01:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:31 INFO - 'PWD': '/builds/slave/test', 01:54:31 INFO - 'SHELL': '/bin/bash', 01:54:31 INFO - 'SHLVL': '1', 01:54:31 INFO - 'TERM': 'linux', 01:54:31 INFO - 'TMOUT': '86400', 01:54:31 INFO - 'USER': 'cltbld', 01:54:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:31 INFO - '_': '/tools/buildbot/bin/python'} 01:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:32 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 01:54:32 INFO - Cleaning up... 01:54:32 INFO - Return code: 0 01:54:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:32 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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54:32 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 01:54:32 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 01:54:32 INFO - Using env: {'DISPLAY': ':0', 01:54:32 INFO - 'HOME': '/home/cltbld', 01:54:32 INFO - 'LANG': 'en_US.UTF-8', 01:54:32 INFO - 'LANGUAGE': 'en_US:en', 01:54:32 INFO - 'LOGNAME': 'cltbld', 01:54:32 INFO - 'MAIL': '/var/mail/cltbld', 01:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:32 INFO - 'MOZ_NO_REMOTE': '1', 01:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:32 INFO - 'NO_EM_RESTART': '1', 01:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:32 INFO - 'PWD': '/builds/slave/test', 01:54:32 INFO - 'SHELL': '/bin/bash', 01:54:32 INFO - 'SHLVL': '1', 01:54:32 INFO - 'TERM': 'linux', 01:54:32 INFO - 'TMOUT': '86400', 01:54:32 INFO - 'USER': 'cltbld', 01:54:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:32 INFO - '_': '/tools/buildbot/bin/python'} 01:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:32 INFO - Downloading/unpacking psutil>=0.7.1 01:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:54:34 INFO - Installing collected packages: psutil 01:54:34 INFO - Running setup.py install for psutil 01:54:34 INFO - building 'psutil._psutil_linux' extension 01:54:34 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 01:54: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 01:54:34 INFO - building 'psutil._psutil_posix' extension 01:54: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 01:54: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 01:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:54:34 INFO - Successfully installed psutil 01:54:34 INFO - Cleaning up... 01:54:34 INFO - Return code: 0 01:54:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:34 INFO - Using env: {'DISPLAY': ':0', 01:54:34 INFO - 'HOME': '/home/cltbld', 01:54:34 INFO - 'LANG': 'en_US.UTF-8', 01:54:34 INFO - 'LANGUAGE': 'en_US:en', 01:54:34 INFO - 'LOGNAME': 'cltbld', 01:54:34 INFO - 'MAIL': '/var/mail/cltbld', 01:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:34 INFO - 'MOZ_NO_REMOTE': '1', 01:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:34 INFO - 'NO_EM_RESTART': '1', 01:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:34 INFO - 'PWD': '/builds/slave/test', 01:54:34 INFO - 'SHELL': '/bin/bash', 01:54:34 INFO - 'SHLVL': '1', 01:54:34 INFO - 'TERM': 'linux', 01:54:34 INFO - 'TMOUT': '86400', 01:54:34 INFO - 'USER': 'cltbld', 01:54:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:34 INFO - '_': '/tools/buildbot/bin/python'} 01:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:54:35 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 01:54:35 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 01:54:35 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 01:54:35 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 01:54:35 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 01:54:35 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 01:54:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:54: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) 01:54:36 INFO - Installing collected packages: mozsystemmonitor 01:54:36 INFO - Running setup.py install for mozsystemmonitor 01:54:37 INFO - Successfully installed mozsystemmonitor 01:54:37 INFO - Cleaning up... 01:54:37 INFO - Return code: 0 01:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:37 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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54:37 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 01:54:37 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 01:54:37 INFO - Using env: {'DISPLAY': ':0', 01:54:37 INFO - 'HOME': '/home/cltbld', 01:54:37 INFO - 'LANG': 'en_US.UTF-8', 01:54:37 INFO - 'LANGUAGE': 'en_US:en', 01:54:37 INFO - 'LOGNAME': 'cltbld', 01:54:37 INFO - 'MAIL': '/var/mail/cltbld', 01:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:37 INFO - 'MOZ_NO_REMOTE': '1', 01:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:37 INFO - 'NO_EM_RESTART': '1', 01:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:37 INFO - 'PWD': '/builds/slave/test', 01:54:37 INFO - 'SHELL': '/bin/bash', 01:54:37 INFO - 'SHLVL': '1', 01:54:37 INFO - 'TERM': 'linux', 01:54:37 INFO - 'TMOUT': '86400', 01:54:37 INFO - 'USER': 'cltbld', 01:54:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:37 INFO - '_': '/tools/buildbot/bin/python'} 01:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 01:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:39 INFO - Downloading blobuploader-1.2.4.tar.gz 01:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:54:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:54:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:39 INFO - Downloading docopt-0.6.1.tar.gz 01:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:54:39 INFO - Installing collected packages: blobuploader, requests, docopt 01:54:39 INFO - Running setup.py install for blobuploader 01:54:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:54:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:54:40 INFO - Running setup.py install for requests 01:54:40 INFO - Running setup.py install for docopt 01:54:40 INFO - Successfully installed blobuploader requests docopt 01:54:40 INFO - Cleaning up... 01:54:40 INFO - Return code: 0 01:54:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:40 INFO - Using env: {'DISPLAY': ':0', 01:54:40 INFO - 'HOME': '/home/cltbld', 01:54:40 INFO - 'LANG': 'en_US.UTF-8', 01:54:40 INFO - 'LANGUAGE': 'en_US:en', 01:54:40 INFO - 'LOGNAME': 'cltbld', 01:54:40 INFO - 'MAIL': '/var/mail/cltbld', 01:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:40 INFO - 'MOZ_NO_REMOTE': '1', 01:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:40 INFO - 'NO_EM_RESTART': '1', 01:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:40 INFO - 'PWD': '/builds/slave/test', 01:54:40 INFO - 'SHELL': '/bin/bash', 01:54:40 INFO - 'SHLVL': '1', 01:54:40 INFO - 'TERM': 'linux', 01:54:40 INFO - 'TMOUT': '86400', 01:54:40 INFO - 'USER': 'cltbld', 01:54:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:40 INFO - '_': '/tools/buildbot/bin/python'} 01:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:54:40 INFO - Running setup.py (path:/tmp/pip-G8kuLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:54:40 INFO - Running setup.py (path:/tmp/pip-yD_sdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:54:40 INFO - Running setup.py (path:/tmp/pip-FwPyhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:54:41 INFO - Running setup.py (path:/tmp/pip-aUuppN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:54:41 INFO - Running setup.py (path:/tmp/pip-jxdd7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:54:41 INFO - Running setup.py (path:/tmp/pip-i09LBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:54:41 INFO - Running setup.py (path:/tmp/pip-H14iqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:54:41 INFO - Running setup.py (path:/tmp/pip-WyfrBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:54:41 INFO - Running setup.py (path:/tmp/pip-nZQAHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:54:41 INFO - Running setup.py (path:/tmp/pip-u6rZP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:54:41 INFO - Running setup.py (path:/tmp/pip-2Avtjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:54:41 INFO - Running setup.py (path:/tmp/pip-ocd4_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:54:41 INFO - Running setup.py (path:/tmp/pip-OYPpAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:54:41 INFO - Running setup.py (path:/tmp/pip-UH2YEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:41 INFO - Running setup.py (path:/tmp/pip-MhA4nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:54:41 INFO - Running setup.py (path:/tmp/pip-mS7dQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:54:41 INFO - Running setup.py (path:/tmp/pip-pmwzcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:54:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:54:42 INFO - Running setup.py install for manifestparser 01:54:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Running setup.py install for mozcrash 01:54:42 INFO - Running setup.py install for mozdebug 01:54:42 INFO - Running setup.py install for mozdevice 01:54:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Running setup.py install for mozfile 01:54:42 INFO - Running setup.py install for mozhttpd 01:54:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Running setup.py install for mozinfo 01:54:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Running setup.py install for mozInstall 01:54:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:54:42 INFO - Running setup.py install for mozleak 01:54:42 INFO - Running setup.py install for mozlog 01:54:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Running setup.py install for moznetwork 01:54:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Running setup.py install for mozprocess 01:54:43 INFO - Running setup.py install for mozprofile 01:54:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Running setup.py install for mozrunner 01:54:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Running setup.py install for mozscreenshot 01:54:43 INFO - Running setup.py install for moztest 01:54:43 INFO - Running setup.py install for mozversion 01:54:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:54:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:54:43 INFO - Cleaning up... 01:54:43 INFO - Return code: 0 01:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:43 INFO - Using env: {'DISPLAY': ':0', 01:54:43 INFO - 'HOME': '/home/cltbld', 01:54:43 INFO - 'LANG': 'en_US.UTF-8', 01:54:43 INFO - 'LANGUAGE': 'en_US:en', 01:54:43 INFO - 'LOGNAME': 'cltbld', 01:54:43 INFO - 'MAIL': '/var/mail/cltbld', 01:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:43 INFO - 'MOZ_NO_REMOTE': '1', 01:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:43 INFO - 'NO_EM_RESTART': '1', 01:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:43 INFO - 'PWD': '/builds/slave/test', 01:54:43 INFO - 'SHELL': '/bin/bash', 01:54:43 INFO - 'SHLVL': '1', 01:54:43 INFO - 'TERM': 'linux', 01:54:43 INFO - 'TMOUT': '86400', 01:54:43 INFO - 'USER': 'cltbld', 01:54:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:43 INFO - '_': '/tools/buildbot/bin/python'} 01:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:54:44 INFO - Running setup.py (path:/tmp/pip-obAc1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:54:44 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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:54:44 INFO - Running setup.py (path:/tmp/pip-7osulp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:54:44 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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:54:44 INFO - Running setup.py (path:/tmp/pip-JE9ab1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:54:44 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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:54:44 INFO - Running setup.py (path:/tmp/pip-S5Shqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:54:44 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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:54:44 INFO - Running setup.py (path:/tmp/pip-3qqCPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:54:44 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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:54:44 INFO - Running setup.py (path:/tmp/pip-0hIaMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:54:44 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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:54:44 INFO - Running setup.py (path:/tmp/pip-AY522A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:54:44 INFO - Running setup.py (path:/tmp/pip-1edyTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:54:44 INFO - Running setup.py (path:/tmp/pip-5rhaRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:54:44 INFO - Running setup.py (path:/tmp/pip-JY1YIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:54:44 INFO - Running setup.py (path:/tmp/pip-tQvV_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:54:44 INFO - Running setup.py (path:/tmp/pip-V6hR4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:54:44 INFO - Running setup.py (path:/tmp/pip-lHR6QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:54: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)) 01:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:54:44 INFO - Running setup.py (path:/tmp/pip-dHH6NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:54:45 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)) 01:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:45 INFO - Running setup.py (path:/tmp/pip-7T0QqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:45 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)) 01:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:54:45 INFO - Running setup.py (path:/tmp/pip-j_2tsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:54:45 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)) 01:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:54:45 INFO - Running setup.py (path:/tmp/pip-aRoAsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:54:45 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)) 01:54:45 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)) 01:54:45 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)) 01:54:45 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)) 01:54:45 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)) 01:54:45 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)) 01:54:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:47 INFO - Downloading blessings-1.6.tar.gz 01:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:54:47 INFO - Installing collected packages: blessings 01:54:47 INFO - Running setup.py install for blessings 01:54:47 INFO - Successfully installed blessings 01:54:47 INFO - Cleaning up... 01:54:47 INFO - Return code: 0 01:54:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:54:47 INFO - Reading from file tmpfile_stdout 01:54:47 INFO - Current package versions: 01:54:47 INFO - argparse == 1.2.1 01:54:47 INFO - blessings == 1.6 01:54:47 INFO - blobuploader == 1.2.4 01:54:47 INFO - docopt == 0.6.1 01:54:47 INFO - manifestparser == 1.1 01:54:47 INFO - mozInstall == 1.12 01:54:47 INFO - mozcrash == 0.17 01:54:47 INFO - mozdebug == 0.1 01:54:47 INFO - mozdevice == 0.48 01:54:47 INFO - mozfile == 1.2 01:54:47 INFO - mozhttpd == 0.7 01:54:47 INFO - mozinfo == 0.9 01:54:47 INFO - mozleak == 0.1 01:54:47 INFO - mozlog == 3.1 01:54:47 INFO - moznetwork == 0.27 01:54:47 INFO - mozprocess == 0.22 01:54:47 INFO - mozprofile == 0.28 01:54:47 INFO - mozrunner == 6.11 01:54:47 INFO - mozscreenshot == 0.1 01:54:47 INFO - mozsystemmonitor == 0.0 01:54:47 INFO - moztest == 0.7 01:54:47 INFO - mozversion == 1.4 01:54:47 INFO - psutil == 3.1.1 01:54:47 INFO - requests == 1.2.3 01:54:47 INFO - wsgiref == 0.1.2 01:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:47 INFO - Using env: {'DISPLAY': ':0', 01:54:47 INFO - 'HOME': '/home/cltbld', 01:54:47 INFO - 'LANG': 'en_US.UTF-8', 01:54:47 INFO - 'LANGUAGE': 'en_US:en', 01:54:47 INFO - 'LOGNAME': 'cltbld', 01:54:47 INFO - 'MAIL': '/var/mail/cltbld', 01:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:47 INFO - 'MOZ_NO_REMOTE': '1', 01:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:47 INFO - 'NO_EM_RESTART': '1', 01:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:47 INFO - 'PWD': '/builds/slave/test', 01:54:47 INFO - 'SHELL': '/bin/bash', 01:54:47 INFO - 'SHLVL': '1', 01:54:47 INFO - 'TERM': 'linux', 01:54:47 INFO - 'TMOUT': '86400', 01:54:47 INFO - 'USER': 'cltbld', 01:54:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:47 INFO - '_': '/tools/buildbot/bin/python'} 01:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54: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)) 01:54:47 INFO - Cleaning up... 01:54:47 INFO - Return code: 0 01:54:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:47 INFO - Using env: {'DISPLAY': ':0', 01:54:47 INFO - 'HOME': '/home/cltbld', 01:54:47 INFO - 'LANG': 'en_US.UTF-8', 01:54:47 INFO - 'LANGUAGE': 'en_US:en', 01:54:47 INFO - 'LOGNAME': 'cltbld', 01:54:47 INFO - 'MAIL': '/var/mail/cltbld', 01:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:47 INFO - 'MOZ_NO_REMOTE': '1', 01:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:47 INFO - 'NO_EM_RESTART': '1', 01:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:47 INFO - 'PWD': '/builds/slave/test', 01:54:47 INFO - 'SHELL': '/bin/bash', 01:54:47 INFO - 'SHLVL': '1', 01:54:47 INFO - 'TERM': 'linux', 01:54:47 INFO - 'TMOUT': '86400', 01:54:47 INFO - 'USER': 'cltbld', 01:54:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:47 INFO - '_': '/tools/buildbot/bin/python'} 01:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:48 INFO - Downloading/unpacking jsonschema 01:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:54:49 INFO - Downloading/unpacking functools32 (from jsonschema) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:50 INFO - Downloading functools32-3.2.3-2.tar.gz 01:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:54:50 INFO - warning: no files found matching '*.txt' 01:54:50 INFO - no previously-included directories found matching 'build' 01:54:50 INFO - no previously-included directories found matching 'dist' 01:54:50 INFO - no previously-included directories found matching '.git*' 01:54:50 INFO - Installing collected packages: jsonschema, functools32 01:54:50 INFO - Running setup.py install for functools32 01:54:50 INFO - warning: no files found matching '*.txt' 01:54:50 INFO - no previously-included directories found matching 'build' 01:54:50 INFO - no previously-included directories found matching 'dist' 01:54:50 INFO - no previously-included directories found matching '.git*' 01:54:50 INFO - Successfully installed jsonschema functools32 01:54:50 INFO - Cleaning up... 01:54:50 INFO - Return code: 0 01:54:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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 0x7f2e97453f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', '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 01:54: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 01:54: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 01:54:50 INFO - Using env: {'DISPLAY': ':0', 01:54:50 INFO - 'HOME': '/home/cltbld', 01:54:50 INFO - 'LANG': 'en_US.UTF-8', 01:54:50 INFO - 'LANGUAGE': 'en_US:en', 01:54:50 INFO - 'LOGNAME': 'cltbld', 01:54:50 INFO - 'MAIL': '/var/mail/cltbld', 01:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:50 INFO - 'MOZ_NO_REMOTE': '1', 01:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:50 INFO - 'NO_EM_RESTART': '1', 01:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:50 INFO - 'PWD': '/builds/slave/test', 01:54:50 INFO - 'SHELL': '/bin/bash', 01:54:50 INFO - 'SHLVL': '1', 01:54:50 INFO - 'TERM': 'linux', 01:54:50 INFO - 'TMOUT': '86400', 01:54:50 INFO - 'USER': 'cltbld', 01:54:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:50 INFO - '_': '/tools/buildbot/bin/python'} 01:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:50 INFO - Downloading/unpacking flake8 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:54:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:54:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:53 INFO - no previously-included directories found matching 'docs/_build' 01:54:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:54:53 INFO - Running setup.py install for pep8 01:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:53 INFO - no previously-included directories found matching 'docs/_build' 01:54:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:54:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:54:53 INFO - Cleaning up... 01:54:53 INFO - Return code: 0 01:54:53 INFO - Running post-action listener: _resource_record_post_action 01:54:53 INFO - Running post-action listener: _start_resource_monitoring 01:54:53 INFO - Starting resource monitoring. 01:54:53 INFO - ##### 01:54:53 INFO - ##### Running install step. 01:54:53 INFO - ##### 01:54:53 INFO - Running pre-action listener: _resource_record_pre_action 01:54:53 INFO - Running main action method: install 01:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:54:53 INFO - Reading from file tmpfile_stdout 01:54:53 INFO - Detecting whether we're running mozinstall >=1.0... 01:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:54:53 INFO - Reading from file tmpfile_stdout 01:54:53 INFO - Output received: 01:54:53 INFO - Usage: mozinstall [options] installer 01:54:53 INFO - Options: 01:54:53 INFO - -h, --help show this help message and exit 01:54:53 INFO - -d DEST, --destination=DEST 01:54:53 INFO - Directory to install application into. [default: 01:54:53 INFO - "/builds/slave/test"] 01:54:53 INFO - --app=APP Application being installed. [default: firefox] 01:54:53 INFO - mkdir: /builds/slave/test/build/application 01:54:53 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'] 01:54:53 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 01:55:10 INFO - Reading from file tmpfile_stdout 01:55:10 INFO - Output received: 01:55:10 INFO - /builds/slave/test/build/application/firefox/firefox 01:55:10 INFO - Running post-action listener: _resource_record_post_action 01:55:10 INFO - ##### 01:55:10 INFO - ##### Running run-tests step. 01:55:10 INFO - ##### 01:55:10 INFO - Running pre-action listener: _resource_record_pre_action 01:55:10 INFO - Running main action method: run_tests 01:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:55:10 INFO - Python 2.7.3 01:55:10 INFO - Return code: 0 01:55:10 INFO - grabbing minidump binary from tooltool 01:55: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')]} 01:55: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 0x19cf640>, '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 0x19d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d09d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:55: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 01:55: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 01:55:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:55:10 INFO - Return code: 0 01:55:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:55:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:55:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:55:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:55:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:55:11 INFO - Return code: 0 01:55: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/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 01:55: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/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 01:55:11 INFO - Using env: {'DISPLAY': ':0', 01:55:11 INFO - 'HOME': '/home/cltbld', 01:55:11 INFO - 'LANG': 'en_US.UTF-8', 01:55:11 INFO - 'LANGUAGE': 'en_US:en', 01:55:11 INFO - 'LOGNAME': 'cltbld', 01:55:11 INFO - 'MAIL': '/var/mail/cltbld', 01:55:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:55:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:11 INFO - 'MOZ_NO_REMOTE': '1', 01:55:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:11 INFO - 'NO_EM_RESTART': '1', 01:55:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:11 INFO - 'PWD': '/builds/slave/test', 01:55:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:55:11 INFO - 'SHELL': '/bin/bash', 01:55:11 INFO - 'SHLVL': '1', 01:55:11 INFO - 'TERM': 'linux', 01:55:11 INFO - 'TMOUT': '86400', 01:55:11 INFO - 'USER': 'cltbld', 01:55:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855', 01:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:11 INFO - '_': '/tools/buildbot/bin/python'} 01:55: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/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 01:55:11 INFO - mozversion application_buildid: 20160421233050 01:55:11 INFO - mozversion application_changeset: 244de786f7140a642165d39b279e86ae1faa6895 01:55:11 INFO - mozversion application_display_name: Nightly 01:55:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:55:11 INFO - mozversion application_name: Firefox 01:55:11 INFO - mozversion application_remotingname: firefox 01:55:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:55:11 INFO - mozversion application_vendor: Mozilla 01:55:11 INFO - mozversion application_version: 48.0a1 01:55:11 INFO - mozversion platform_buildid: 20160421233050 01:55:11 INFO - mozversion platform_changeset: 244de786f7140a642165d39b279e86ae1faa6895 01:55:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:55:11 INFO - mozversion platform_version: 48.0a1 01:55:11 INFO - using testdate: 1461315311 01:55:11 INFO - actual date: 1461315311 01:55:11 INFO - starting webserver on 'localhost:41720' 01:55:11 INFO - SUITE-START | Running 2 tests 01:55:11 INFO - TEST-START | dromaeo_css 01:55:11 INFO - operating with platform_type : linux_ 01:55:11 INFO - Initialising browser for dromaeo_css test... 01:55:11 INFO - TEST-INFO | started process 21819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXSTbk/profile http://localhost:41720/getInfo.html) 01:55:15 INFO - PROCESS | 21819 | 01:55:15 INFO - PROCESS | 21819 | (process:21886): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:55:16 INFO - PROCESS | 21819 | __metrics Screen width/height:1600/1200 01:55:16 INFO - PROCESS | 21819 | colorDepth:24 01:55:16 INFO - PROCESS | 21819 | Browser inner width/height: 1024/697 01:55:16 INFO - PROCESS | 21819 | __metrics 01:55:17 ERROR - PROCESS | 21819 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:55:17 INFO - TEST-INFO | 21819: exit 0 01:55:17 INFO - Browser initialized. 01:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 01:55:17 INFO - TEST-INFO | started process 21937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXSTbk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:55:19 INFO - PROCESS | 21937 | 01:55:19 INFO - PROCESS | 21937 | (process:21998): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:55:29 INFO - PROCESS | 21937 | RSS: Main: 163782656 01:55:29 INFO - PROCESS | 21937 | 01:56:19 INFO - PROCESS | 21937 | 1461315379200 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] 01:58:26 INFO - PROCESS | 21937 | Cycle 1(1): loaded http://localhost:41720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41720/tests/dromaeo/cssquery-ext.html) 01:58:27 INFO - PROCESS | 21937 | RSS: Main: 167014400 01:58:27 INFO - PROCESS | 21937 | 02:01:29 INFO - PROCESS | 21937 | Cycle 1(1): loaded http://localhost:41720/tests/dromaeo/cssquery-ext.html (next: http://localhost:41720/tests/dromaeo/cssquery-jquery.html) 02:01:29 INFO - PROCESS | 21937 | RSS: Main: 165666816 02:01:29 INFO - PROCESS | 21937 | 02:04:31 INFO - PROCESS | 21937 | Cycle 1(1): loaded http://localhost:41720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41720/tests/dromaeo/cssquery-mootools.html) 02:04:32 INFO - PROCESS | 21937 | RSS: Main: 167038976 02:04:32 INFO - PROCESS | 21937 | 02:07:33 INFO - PROCESS | 21937 | Cycle 1(1): loaded http://localhost:41720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41720/tests/dromaeo/cssquery-prototype.html) 02:07:34 INFO - PROCESS | 21937 | RSS: Main: 164442112 02:07:34 INFO - PROCESS | 21937 | 02:10:36 INFO - PROCESS | 21937 | Cycle 1(1): loaded http://localhost:41720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41720/tests/dromaeo/cssquery-yui.html) 02:10:37 INFO - PROCESS | 21937 | RSS: Main: 166277120 02:10:37 INFO - PROCESS | 21937 | 02:13:39 INFO - PROCESS | 21937 | Cycle 1(1): loaded http://localhost:41720/tests/dromaeo/cssquery-yui.html (next: http://localhost:41720/tests/dromaeo/cssquery-dojo.html) 02:13:40 INFO - PROCESS | 21937 | RSS: Main: 167641088 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | __start_tp_report 02:13:40 INFO - PROCESS | 21937 | _x_x_mozilla_page_load 02:13:40 INFO - PROCESS | 21937 | _x_x_mozilla_page_load_details 02:13:40 INFO - PROCESS | 21937 | |i|pagename|runs| 02:13:40 INFO - PROCESS | 21937 | |0;dojo.html;3080.8767649294027;3138.215446138466;3140.842957852107;3203.8718451261952;3208.0856955767613;5193.246979188016;5198.610104242182;5228.73856307185;5231.738413079341;5284.471552844713;5261.605379596526;5393.541548968343;5416.891662166754;5463.726813659321;5498.0653288940875;4888.731119788419;4915.434725006617;4952.727599981999;4968.031233909389;5003.874903127415;599.2454907296102;4802.615790736732;4927;4942.678725882806;4975.179095449246;4899.559039686445;4903.877403064934;4909.435414927293;4914.631402644816;4953.975230123862;4771.785269662873;5010.749462526859;5038.874028149289;5039.269305950616;5084.084864724348;4881.4630390657;4884.853454396374;4897.314375987365;4904.632152588534;4936.703797772145;5198.506141916512;5245.423003469616;5274.947250527484;5279.366476022863;5323.467653234684;5668.858278543069;5692.857678558069;5715.571332150063;5744.942550574524;5801.593888427812;5684.175794509773;5736.340320863071;5745.310562732457;5761.366249712528;5778.942210577925;5321;5342.198670199462;5349.812756553502;5351.759170837283;5363.9463605363835;5678;5917.704114794243;5927.407259274038;6004.039353703474;6013.368596297413;5652.236948011966;5654.971725141348;5694.5159661428415;5697.886042279131;5716.514096301861;5746.511546518509;5756.366799652035;5758.337791154071;5758.654480731169;5763.538916886639;5548.278723765965;5691.800786972519;5741.425857414225;5756.683382414008;5801.564882633819;5544.528715059185;5605.663660180402;5608.887822243532;5614.550835933115;5770.711464426762;4291.6137547620865;4310.892227694333;4359.12817436514;4371.213181627338;4408.25059739845;3839.6736277416176;3897.2595206911164;3902.70729695274;3944.6252606002386;3944.6449819515806;5455.645383050089;5480.7533660985355;5490.945090549043;5496.835094947158;5554.86112847174;5766.625169363978;5782.537397008229;5799.5070419014855;5803.47768700819;5851.444112809277;5348.625596208228;5454.509094181463;5469.042917489423;5501.504864562128;5515.448455154453;4883.926741098815;4941.036497882878;4953.578945789648;4959.280904268933;4990.6257030722845;5839.328477225174;5911.467967882825;5913.438223368859;5937.317208520989;5942.940570594325;5660.632058916322;5681.346645135863;5745.224394706828;5746.597738158289;5820.534357251409;5799.2750906136735;5809.8547536311935;5811.622244554091;5812.82561523155;5821.534277257894;5560.498665360249;5562.833115006556;5563.13771365439;5564.4991950724625;5575.8884822304135;5656.717164141859;5672.2342483765815;5751.626144300607;5847.970760146172;5871.266091738533;5566.805161819317;5618.6628802272;5622.409646987171;5631.577631677558;5672.404397538199;5540.7783688652;5563.443655634404;5568.220449137205;5573.414791447002;5639.718014099197;5395.13677811564;5395.676259424447;5468.972655136858;5513.476219759116;5566.443355664564;5583.357913839798;5594.328680558359;5623.718814059199;5630.071038278638;5719.914201286901;5533.723313834373;5570.108782594765;5579.19101730255;5579.776808927598;5580.079286917613 02:13:40 INFO - PROCESS | 21937 | |1;ext.html;603.131490653459;631;644.709880553751;647.8607099473618;658.2594581096266;35782.463263051046;36244.81877590615;36529.817350913276;36585;36590.451143232836;38173;38598;38684;38879.611203888024;38970.61029389705;8410;8550.786230344229;8595.312375009984;8602.483850968962;8624;8405.663773449054;8469.153084691512;8477.533735644538;8646.524441155734;8684.8697269541;8748.825023499558;8836.734897953073;8842.336824738139;8844.823103537925;8897.243734282594;8695.565221738887;8760.386772925898;8776.956115219447;8835.823283534326;8841;8686.391952563323;8797.912020879774;8798.51608161551;8805.075467075929;8806.559672016374;37672;37835.432468513;37850.81074594637;37889.242215155544;37997.81001094977;3410.7782994105305;3516.1912760065075;3601.963980360189;3811.104390468238;3982.6614737747327;30647.2338191547;31101.222469438446;31138.22154446157;31282.37435251305;31755.52366714501;4266.445362102938;4293.48478182617;4323.913521729579;4333.285007973681;4353.651033086573;216584;217571;217883;218450;218781;34595.48106778401;54348;54351;55148;55155.72422137944;34520.13699657529;34704.826475867456;34726.30547389088;34728.65271347254;34794.47808282878;14815.185164815823;14902.552923412315;15008.399664013536;15021.671640895678;15077.623059423382;12085.939570302267;12129.21160124589;12184.939075304566;12185.32980686053;12219.877801221874;8449.197326253996;8488.618012189467;8560.443571167854;8613.784655383666;8635.13648635144;3282.491213861855;3306.3883181611477;3335.966640333614;3356.9496457553155;3403.302323023774;1092.9945350273356;1130.4291332876844;1132.2300835431986;1140.361397617337;1176.4064598292323;30354.241143971576;30888.382232355227;31237.687623123933;31601.209969750482;31825;1108.157800071935;1170.9297442153497;1177.7055736065984;1180.3272134883034;1249.3940438887132;16355.91822040906;16559.83440165607;16939.407120750715;16950.660986780196;17010.319587216374;486019;491738;495737;495740;496078;54921.45078549163;55622;55930.720346398004;56219;56242.437575624535;1405.3465138710753;1407.8099456573436;1420.3253454608978;1433.5341014170435;1516.0373163041547;29921.401571968872;30327.696723032488;30361.544576831806;30943;31614.26121563244;53210.73394633002;54543.18185227145;54601.63495912475;54647;54666.180007299125;407010;418838;420433;420604;421063;41708.3743743838;42091.7895410521;42220.788896055325;42328;43800.56199437965;46446.53553464422;46561;47125.764371177924;47577;48524;39225.62710305126;40303.19393612053;40391.3941290875;41158;41302.79348603238;37714.43428348522;39152;39228.803855980535;39960.600393995686;40677.796611016754;39017.41473877951;40276.3958540628;40620;40945;41054.58945410627;32436.83781581077;34917.650823492455;35371.82314088413;35730.28539429145;35910.28179436449;27808.304792380353;27834.58248126239;28105.71894281031;28163.43673126567;28349.858250708614 02:13:40 INFO - PROCESS | 21937 | |2;jquery.html;396.44893597898914;397.2273927211573;398.61533620056656;401.90957034667224;409.9200655872106;13226.280583524152;17926.28294868207;18277.634447311062;18775.718364224547;19001.809981900176;16916.407925722604;17608.647827043453;18127.093645317746;18516.537086572844;18611.348602798906;5104.8979020419565;5550.27846379971;5700.9714951425185;5741.052726300176;5761.164631128484;5713.085906255;5716.771329146829;5731.742071606767;5758.136279558058;5761.4814666679995;5437.102878025141;5627.634203776762;5660.801871934483;5711.628744131618;5723.713814309289;5595.244641973342;5651.547876169897;5660.660360378391;5679.318481782192;5709.8572535686735;4824.107540105092;5021.472745361721;5046.772895219724;5073.797048118071;5075.492450754932;21093.894530527403;21769.346919592437;21979;22132.225372111898;22159.667604985938;2426.598873436013;2448.70615526138;2531.316544532984;2551.617257411385;2797.37059161689;13788.379522921492;14261.85738142626;14306.856931430657;14438.855611443856;14492;1759.463363674079;1829.7804263488467;1873.8594605404649;1879.6334714730633;1904.523993904721;65913.67043164754;80223.19776802216;80725.19274807235;81157;81220;9688.9031109688;9953.900460995297;10431;10545.789084218273;10701.571937122584;14219.786703199461;14222;14339.78490322646;14348.784768228485;14353.78469322961;7893.526388416713;7911.28798408146;7978.760637180778;8016.959915200387;8046.476978996347;7723.189065148191;7723.729669461542;7727.265909738566;7733.729319473791;8174.550399727953;4594.264917613166;4630.703403047152;4659.883502912454;4682.9531704683195;4690.718556886598;1921.5196200949763;1945.5622484940775;1968.5275533872054;1996.7304413904228;1999.8600097993;821.4906757810077;977.941323520591;1014.0569270578433;1072.485207100596;1109.5118148014847;17952.371666991592;17953.551161221076;18171.364002259856;18343.17455714496;18632.906835465736;1001.1590264178126;1010.2473657125488;1017.9338343007681;1029.7477118105962;1037.7457522906784;10200.489975501343;10498.160147188206;10548.103411209979;10561.31351462168;10601.893981060244;438298.70207787637;491292;494448;494536;496366;90446;93302.53348733213;93767;94032.52983735174;94070;994.8457989011715;1011.3830563356347;1012.7569383347943;1018.0582960761266;1047.0471870597871;16261.67476650484;16313.59216019609;16333.836661633231;16369.608583270556;16380.918095409446;38145;38588.421173681854;38745;39321.80339098286;39590.40614390729;50258.748706256236;53180.20229696635;53532.46467535275;54112.45887541074;54128.188077178085;7834.0599128105;7966.760997170094;8016.959915200387;8071.798205044686;8247.257746802816;12772.233665980071;13019.609411717664;13108.2135071896;13186.340682966005;13355.866441335462;5798.739056742373;9904.207663387057;10810.783784324427;11578.363190024293;11857.40712964331;6661.067450556829;9679.548067789889;10263.332883362558;10565.841512377167;11231.26996745209;11724.472398742248;11906.880931190577;11986.64040078764;12066.577669781867;12317.568885088978;8314.750557483285;8356.331493480386;8508.106648801786;8519.148085191431;8563.914360856561;11691.649250522498;11989.520419183134;11991.880081199426;12082.45628946682;12235.204711693712 02:13:40 INFO - PROCESS | 21937 | |3;mootools.html;1522.322566457926;1535.2784191430028;1698.5498842806658;1745.7643218165545;1825.2425243523937;7336.779896603097;8098;8159.184081591838;8375.790605234864;8431.409801313903;8124.187581241873;8148.592570371473;8176.91823081769;8205.425620206588;8228.958855205716;2316.455632926261;2340.5903966805827;2344.15610380263;2344.76552344765;2347.3896786835376;2273.9886300568555;2277.874716890579;2345.812335013203;2357.3635118518077;2358.8820558971984;2256.7630398808137;2287.6797248385155;2295.104909085458;2336.404216924682;2361.3152185866165;2247.415671925311;2254.0532976149975;2254.5941730488507;2257.6726374675663;2257.7064981552294;2196.2532738868863;2199.7030400895833;2220.5336879255374;2228.0530774420968;2233.7766223377694;8347.081820999685;8445.873311900326;8473.872891906627;8474.915250847474;8482.78793030173;4971;5121.795128194868;5131.794728210867;5135.255387968724;5166;3059.847007649631;3254.5769050023346;3313.718333941618;3315.2209230830736;3321.96678033219;1148.9827652585218;1171.0572988744057;1177.7055736065984;1219.3659297165514;1225.0934308611652;11443.828342574869;11472.885271147265;11480.82778758311;11554.422278886022;11555.422228888521;4383.60547550722;4627.514111018295;4642.582167604932;4671.11248862715;4683.039976804746;9715.12563869241;9790.706278811647;9814.705558833246;9835.213182945346;9855.11303982645;5192.428832828386;5209.739513024334;5211.478852114758;5211.609129315317;5242.76407561653;3979.3633018716864;4483.506814250495;4603.5396460353695;4657.464391594942;4675.579197872208;3729.9556124285245;3741.345264578688;3776.8489260429274;3795;3813.161104556993;1226.5093962415106;1288.6907142285784;1292.3021568353172;1293.430890408236;1306.5884246462333;895.359817730326;966.9226461883032;1018.5314755212537;1026.4046852825343;1042.1870940666292;5940.376260492586;5955.3151387590115;6039.667818270037;6053.939460605426;6181.320054793969;451.0325352119685;457.6293202505981;461.16759249554207;468.59934755783996;471.66276112578987;4127.7936103194725;4275.935860962088;4277.272863613193;4291.6137547620865;4301.333293339538;9922.751931201778;10261.897381026094;10350.53422595985;10360.740981475372;10379.688609341732;9739.805203895883;10074.143697785623;10094.14199793026;10165.593376265015;10216.897831021743;7679.961600191963;7860.685572577033;7873.212678732196;7893.329067029252;7928.286454219148;5735.426457354231;5768.7404066817935;5806.564507662027;5878.470937615635;5991.131285963598;9010.684626038319;9122.817543649222;9188.678396256098;9188.95405522968;9273.536323183678;8962.058983806866;8977.147171018743;9153.954230228806;9182.95408522953;9380.48407337603;6377.617342959437;7239.8552028960175;7410.333070023724;7440.069991251094;7490.812729681584;7928.682852685828;7930.60346982637;7940.682372705258;7946.32456241226;7986.920130798618;6993.580385176906;7213.639318033972;7282;7342.853142937218;7487.3261406473675;7105.147382313949;7197.064381630355;7236.312550307713;7294.489385742947;7311.8903216450735;6774.830629234309;6822.181338239443;6843.110395648534;6843.349881761224;6889.655517224219;4973.5523802857915;5098.1842905135;5163.922541161961;5197.0905091608065;5245.423003469539;5137.8715532112;5192.844214673566;5235.712035838065;5278.656887302313;5350.822818979818 02:13:40 INFO - PROCESS | 21937 | |4;prototype.html;322.8466478422748;331.4249776637534;336.08417063501946;342.64022776085136;342.6693241022414;5913;6014.616638173223;6029.788957386492;6111.786087486938;6143.416375444325;6024.216851809269;6027.87944241116;6036.547258955585;6058.818235452933;6077.662914158878;4638.860834174963;4643.907121857553;4654.255319148937;4655.0448811499255;4660.510646382132;4309.383981007122;4533.863984080483;4546.317862390903;4572.314152877078;4646.697964632288;4516.0967806438675;4537.706753575232;4540.545945405466;4542.727436353829;4565.1098035883015;4534.433195850519;4556.929121656408;4562.977185114087;4573.359729637853;4591.265397536395;3806.143617686026;3909.139989202371;3928.135810121797;3957.1887763008513;3962.603739626043;5730.598858079936;5754.223179870705;5769.769209231626;5769.88460230793;5802.274715660543;5192.1432963560965;5199.298094757197;5210.557102646279;5216.217567364888;5237.47625237477;5963.224780778471;6234.781782637586;6237.407446292595;6291.62250264981;6315.842103947392;4343.913121737579;4352.781221258053;4355.607995280408;4359.12817436514;4367.781610919473;6255.343188965184;6572.507061970371;6615.404613584752;6622.73509059637;6623.867522649568;4411.1618792429335;4412.867613971522;4436.711613745097;4440.111977604492;4441.689081764245;4480.305552639346;4507.211238033331;4508.571685689854;4518.977405112953;4521.615662668644;5092.38891333035;5226.608004399685;5232.084385232569;5238.345206849144;5262.947370526245;6014.18808460861;6163.274283200711;6391.424771770563;6394.424501794861;6415.26224484181;1558.6025563481467;1563.5465714942538;1567.42005457979;1575.314738088935;1577.4478932373806;1008.4655132779639;1018.9592416303414;1038.631285893512;1043.436544266103;1052.4474650808233;6107.267127944675;6125.693715314216;6139.7413530226195;6159.84600384985;6161.168242287234;6577.276499585042;6578.572392794453;6603.669816509156;6605.70274337656;6632.535722499475;5887.175795388649;6115.205023346936;6130.478909292671;6150.692465376714;6153.353897840751;3519.6656317650295;3530.046887340404;3549.3256281306985;3554.9466757998653;3561.1809283864854;6651.46788256948;6733.427658648971;6838.521303508706;6845.657717114124;6845.8973115403305;6601.207855057424;6665.700043498055;6668;6678.964760462136;6681.265060843303;6570.437529363552;6760.357766012221;6766.796996090026;6805.9659701701175;6877.2091209510545;6573.474122070318;6612.768553100618;6619.66901654925;6628.171478565179;6646.501512386687;6368.96815515938;6474.158359413246;6529.575577587441;6548;6554.967225163844;6824.692888820115;6837.247902730596;6851.280615535297;6864.759733409506;6893.75952815327;4405.735655860659;4418.955810441855;4421.09367579639;4433.534478879671;4446.9777651111535;6420.775272865428;6453.193350831146;6480.509482819072;6554.016897465228;6700.195976482658;6451.290358060516;6467.223933128054;6467.870642587028;6469.28837827848;6476.352364763486;6255.874882502416;6370.203724534434;6410;6437.871242575216;6463.127477790438;6298.779542715983;6319.178506794087;6323.430891219812;6326.4622507087415;6334.968325158345;6467.159269294962;6474.1583594134345;6480.416762491398;6495.253045899782;6506.219253689398;6230.943788549677;6326;6335.4931605472375;6339.397757213057;6339.5562310637815 02:13:40 INFO - PROCESS | 21937 | |5;yui.html;667.8263651450625;675.15942651399;699.1365663405696;713.2938390992915;717.5371885134089;12124.151309408346;12166.513339466423;12226.327551984648;13105.868941310584;14989.325480353384;14112.92943535281;14200.14799112054;14210.71578568428;14210.857891421108;14245.928770356133;772.9961350193241;806.508030101639;815.7675062607158;816.4407380944043;819.9303059239971;816.8611336072881;822.5845947796355;823.5017814222399;827.0778082438069;828.8590939540293;848.3594885861166;854.3549620036863;854.3677678517884;854.8674955381925;858.716623514242;843.5149788871362;848.5460278750869;853.7054716122959;854.0264098927228;858.0175698824842;618.1809102938579;620.4447019917194;622.3341025103141;622.4957784194817;622.6855438003824;14910.850891491164;15007.474738384104;15013.924930375388;15029.624259393602;15031.248437578077;13515.932420337835;13529.864701353057;13530.86469135306;13613.183209007491;13637.908967282692;10735.62425315118;10866.130709543218;10973.067289280421;11110.666679999613;11459;3861.555921069085;3868.477755502999;3878.728489005771;3932.292187406266;3978.8209530570903;61725.69137154285;62098;62595.687021565514;62636;63122;10788;10872.347659140476;10904.781904362027;10936.671899843017;11006.834897476545;17735.201915913814;18164.364247251284;18243.72634410485;18278.725819112726;19434.319798807257;7734.342580880688;7846.764597062097;8239.134890836376;8246.8350632987;8457.492550446992;4595.862124136282;4785.976070119627;4802.255650374198;4830.227163653799;4931.211006238985;3173.984130079335;3246.2371342734436;3247.447933851251;3247.4641684121857;3264.1186879542865;596.0909612840367;600.3396264109444;601.3986013986014;622.5890911998059;631.782035197856;634.2199095113036;663.8174502011985;748.4311922938606;759.8062494063978;775.441681988967;8616.913830861737;8997.55012249398;9088.136627020554;9096.226820720181;9327.813443731087;654.9934500655028;656.0454538646259;657.263864471785;673.3771261583016;679.5481005131533;4343.066240758252;4350.260455722535;4379.474463064453;4397.1865204937185;4491.865244042684;63595.68202158959;64359.678201608695;65448.67275663591;65752.67123664351;65839.34160658428;56139.438605613424;56304;56326.718366407906;56327.71836140793;56704;52084.47915520872;52395.999999999236;53178;53366;54505.45494545004;9153.267738581031;9230.984591695042;9233.630654774002;9289.72130836076;9301.488418136796;29217;30137.684854666408;30604.08187754371;32152.839235803673;35334.29331413409;43304.78347608242;43306.78346608247;43799.781001094794;44059.55940440555;44248;10457.215708822021;10773.461326933779;11218.775624487627;11298.265612735146;11629.59296424621;12643.114981951176;12796.296203708886;12805.743885122432;12901.677458063623;13103.803442948554;12904.225746455242;13019.804702929652;13035.608931732064;13048.804267935799;13540.052196346162;12046.879531204575;12057.336846473178;12353.938230308791;12664.303463309607;13243.404046817725;12514;12686.429110689856;12728.554500592434;12729.172603780724;12901.870981290067;10016.549255283675;10256.07695307396;10278.17774578017;10291.742706432398;10357.741056473347;10432;10518.579256829642;10527.894721052691;10581.735456613646;10602.946985265024 02:13:40 INFO - PROCESS | 21937 | __end_tp_report 02:13:40 INFO - PROCESS | 21937 | __start_cc_report 02:13:40 INFO - PROCESS | 21937 | _x_x_mozilla_cycle_collect,332 02:13:40 INFO - PROCESS | 21937 | __end_cc_report 02:13:40 INFO - PROCESS | 21937 | __startTimestamp1461316420043__endTimestamp 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | ------- Summary: start ------- 02:13:40 INFO - PROCESS | 21937 | Number of tests: 6 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | [#0] dojo.html Cycles:165 Average:5301.43 Median:5560.50 stddev:697.10 (12.5%) stddev-sans-first:677.13 02:13:40 INFO - PROCESS | 21937 | Values: 3080.9 3138.2 3140.8 3203.9 3208.1 5193.2 5198.6 5228.7 5231.7 5284.5 5261.6 5393.5 5416.9 5463.7 5498.1 4888.7 4915.4 4952.7 4968.0 5003.9 599.2 4802.6 4927.0 4942.7 4975.2 4899.6 4903.9 4909.4 4914.6 4954.0 4771.8 5010.7 5038.9 5039.3 5084.1 4881.5 4884.9 4897.3 4904.6 4936.7 5198.5 5245.4 5274.9 5279.4 5323.5 5668.9 5692.9 5715.6 5744.9 5801.6 5684.2 5736.3 5745.3 5761.4 5778.9 5321.0 5342.2 5349.8 5351.8 5363.9 5678.0 5917.7 5927.4 6004.0 6013.4 5652.2 5655.0 5694.5 5697.9 5716.5 5746.5 5756.4 5758.3 5758.7 5763.5 5548.3 5691.8 5741.4 5756.7 5801.6 5544.5 5605.7 5608.9 5614.6 5770.7 4291.6 4310.9 4359.1 4371.2 4408.3 3839.7 3897.3 3902.7 3944.6 3944.6 5455.6 5480.8 5490.9 5496.8 5554.9 5766.6 5782.5 5799.5 5803.5 5851.4 5348.6 5454.5 5469.0 5501.5 5515.4 4883.9 4941.0 4953.6 4959.3 4990.6 5839.3 5911.5 5913.4 5937.3 5942.9 5660.6 5681.3 5745.2 5746.6 5820.5 5799.3 5809.9 5811.6 5812.8 5821.5 5560.5 5562.8 5563.1 5564.5 5575.9 5656.7 5672.2 5751.6 5848.0 5871.3 5566.8 5618.7 5622.4 5631.6 5672.4 5540.8 5563.4 5568.2 5573.4 5639.7 5395.1 5395.7 5469.0 5513.5 5566.4 5583.4 5594.3 5623.7 5630.1 5719.9 5533.7 5570.1 5579.2 5579.8 5580.1 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | [#1] ext.html Cycles:180 Average:53175.94 Median:38994.01 stddev:104674.09 (268.4%) stddev-sans-first:104893.30 02:13:40 INFO - PROCESS | 21937 | Values: 603.1 631.0 644.7 647.9 658.3 35782.5 36244.8 36529.8 36585.0 36590.5 38173.0 38598.0 38684.0 38879.6 38970.6 8410.0 8550.8 8595.3 8602.5 8624.0 8405.7 8469.2 8477.5 8646.5 8684.9 8748.8 8836.7 8842.3 8844.8 8897.2 8695.6 8760.4 8777.0 8835.8 8841.0 8686.4 8797.9 8798.5 8805.1 8806.6 37672.0 37835.4 37850.8 37889.2 37997.8 3410.8 3516.2 3602.0 3811.1 3982.7 30647.2 31101.2 31138.2 31282.4 31755.5 4266.4 4293.5 4323.9 4333.3 4353.7 216584.0 217571.0 217883.0 218450.0 218781.0 34595.5 54348.0 54351.0 55148.0 55155.7 34520.1 34704.8 34726.3 34728.7 34794.5 14815.2 14902.6 15008.4 15021.7 15077.6 12085.9 12129.2 12184.9 12185.3 12219.9 8449.2 8488.6 8560.4 8613.8 8635.1 3282.5 3306.4 3336.0 3356.9 3403.3 1093.0 1130.4 1132.2 1140.4 1176.4 30354.2 30888.4 31237.7 31601.2 31825.0 1108.2 1170.9 1177.7 1180.3 1249.4 16355.9 16559.8 16939.4 16950.7 17010.3 486019.0 491738.0 495737.0 495740.0 496078.0 54921.5 55622.0 55930.7 56219.0 56242.4 1405.3 1407.8 1420.3 1433.5 1516.0 29921.4 30327.7 30361.5 30943.0 31614.3 53210.7 54543.2 54601.6 54647.0 54666.2 407010.0 418838.0 420433.0 420604.0 421063.0 41708.4 42091.8 42220.8 42328.0 43800.6 46446.5 46561.0 47125.8 47577.0 48524.0 39225.6 40303.2 40391.4 41158.0 41302.8 37714.4 39152.0 39228.8 39960.6 40677.8 39017.4 40276.4 40620.0 40945.0 41054.6 32436.8 34917.7 35371.8 35730.3 35910.3 27808.3 27834.6 28105.7 28163.4 28349.9 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | [#2] jquery.html Cycles:180 Average:28278.70 Median:20471.19 stddev:79721.97 (389.4%) stddev-sans-first:79918.12 02:13:40 INFO - PROCESS | 21937 | Values: 396.4 397.2 398.6 401.9 409.9 13226.3 17926.3 18277.6 18775.7 19001.8 16916.4 17608.6 18127.1 18516.5 18611.3 5104.9 5550.3 5701.0 5741.1 5761.2 5713.1 5716.8 5731.7 5758.1 5761.5 5437.1 5627.6 5660.8 5711.6 5723.7 5595.2 5651.5 5660.7 5679.3 5709.9 4824.1 5021.5 5046.8 5073.8 5075.5 21093.9 21769.3 21979.0 22132.2 22159.7 2426.6 2448.7 2531.3 2551.6 2797.4 13788.4 14261.9 14306.9 14438.9 14492.0 1759.5 1829.8 1873.9 1879.6 1904.5 65913.7 80223.2 80725.2 81157.0 81220.0 9688.9 9953.9 10431.0 10545.8 10701.6 14219.8 14222.0 14339.8 14348.8 14353.8 7893.5 7911.3 7978.8 8017.0 8046.5 7723.2 7723.7 7727.3 7733.7 8174.6 4594.3 4630.7 4659.9 4683.0 4690.7 1921.5 1945.6 1968.5 1996.7 1999.9 821.5 977.9 1014.1 1072.5 1109.5 17952.4 17953.6 18171.4 18343.2 18632.9 1001.2 1010.2 1017.9 1029.7 1037.7 10200.5 10498.2 10548.1 10561.3 10601.9 438298.7 491292.0 494448.0 494536.0 496366.0 90446.0 93302.5 93767.0 94032.5 94070.0 994.8 1011.4 1012.8 1018.1 1047.0 16261.7 16313.6 16333.8 16369.6 16380.9 38145.0 38588.4 38745.0 39321.8 39590.4 50258.7 53180.2 53532.5 54112.5 54128.2 7834.1 7966.8 8017.0 8071.8 8247.3 12772.2 13019.6 13108.2 13186.3 13355.9 5798.7 9904.2 10810.8 11578.4 11857.4 6661.1 9679.5 10263.3 10565.8 11231.3 11724.5 11906.9 11986.6 12066.6 12317.6 8314.8 8356.3 8508.1 8519.1 8563.9 11691.6 11989.5 11991.9 12082.5 12235.2 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | [#3] mootools.html Cycles:180 Average:5524.18 Median:5133.53 stddev:3038.35 (59.2%) stddev-sans-first:3031.99 02:13:40 INFO - PROCESS | 21937 | Values: 1522.3 1535.3 1698.5 1745.8 1825.2 7336.8 8098.0 8159.2 8375.8 8431.4 8124.2 8148.6 8176.9 8205.4 8229.0 2316.5 2340.6 2344.2 2344.8 2347.4 2274.0 2277.9 2345.8 2357.4 2358.9 2256.8 2287.7 2295.1 2336.4 2361.3 2247.4 2254.1 2254.6 2257.7 2257.7 2196.3 2199.7 2220.5 2228.1 2233.8 8347.1 8445.9 8473.9 8474.9 8482.8 4971.0 5121.8 5131.8 5135.3 5166.0 3059.8 3254.6 3313.7 3315.2 3322.0 1149.0 1171.1 1177.7 1219.4 1225.1 11443.8 11472.9 11480.8 11554.4 11555.4 4383.6 4627.5 4642.6 4671.1 4683.0 9715.1 9790.7 9814.7 9835.2 9855.1 5192.4 5209.7 5211.5 5211.6 5242.8 3979.4 4483.5 4603.5 4657.5 4675.6 3730.0 3741.3 3776.8 3795.0 3813.2 1226.5 1288.7 1292.3 1293.4 1306.6 895.4 966.9 1018.5 1026.4 1042.2 5940.4 5955.3 6039.7 6053.9 6181.3 451.0 457.6 461.2 468.6 471.7 4127.8 4275.9 4277.3 4291.6 4301.3 9922.8 10261.9 10350.5 10360.7 10379.7 9739.8 10074.1 10094.1 10165.6 10216.9 7680.0 7860.7 7873.2 7893.3 7928.3 5735.4 5768.7 5806.6 5878.5 5991.1 9010.7 9122.8 9188.7 9189.0 9273.5 8962.1 8977.1 9154.0 9183.0 9380.5 6377.6 7239.9 7410.3 7440.1 7490.8 7928.7 7930.6 7940.7 7946.3 7986.9 6993.6 7213.6 7282.0 7342.9 7487.3 7105.1 7197.1 7236.3 7294.5 7311.9 6774.8 6822.2 6843.1 6843.3 6889.7 4973.6 5098.2 5163.9 5197.1 5245.4 5137.9 5192.8 5235.7 5278.7 5350.8 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | [#4] prototype.html Cycles:180 Average:5310.18 Median:6092.47 stddev:1620.77 (26.6%) stddev-sans-first:1581.49 02:13:40 INFO - PROCESS | 21937 | Values: 322.8 331.4 336.1 342.6 342.7 5913.0 6014.6 6029.8 6111.8 6143.4 6024.2 6027.9 6036.5 6058.8 6077.7 4638.9 4643.9 4654.3 4655.0 4660.5 4309.4 4533.9 4546.3 4572.3 4646.7 4516.1 4537.7 4540.5 4542.7 4565.1 4534.4 4556.9 4563.0 4573.4 4591.3 3806.1 3909.1 3928.1 3957.2 3962.6 5730.6 5754.2 5769.8 5769.9 5802.3 5192.1 5199.3 5210.6 5216.2 5237.5 5963.2 6234.8 6237.4 6291.6 6315.8 4343.9 4352.8 4355.6 4359.1 4367.8 6255.3 6572.5 6615.4 6622.7 6623.9 4411.2 4412.9 4436.7 4440.1 4441.7 4480.3 4507.2 4508.6 4519.0 4521.6 5092.4 5226.6 5232.1 5238.3 5262.9 6014.2 6163.3 6391.4 6394.4 6415.3 1558.6 1563.5 1567.4 1575.3 1577.4 1008.5 1019.0 1038.6 1043.4 1052.4 6107.3 6125.7 6139.7 6159.8 6161.2 6577.3 6578.6 6603.7 6605.7 6632.5 5887.2 6115.2 6130.5 6150.7 6153.4 3519.7 3530.0 3549.3 3554.9 3561.2 6651.5 6733.4 6838.5 6845.7 6845.9 6601.2 6665.7 6668.0 6679.0 6681.3 6570.4 6760.4 6766.8 6806.0 6877.2 6573.5 6612.8 6619.7 6628.2 6646.5 6369.0 6474.2 6529.6 6548.0 6555.0 6824.7 6837.2 6851.3 6864.8 6893.8 4405.7 4419.0 4421.1 4433.5 4447.0 6420.8 6453.2 6480.5 6554.0 6700.2 6451.3 6467.2 6467.9 6469.3 6476.4 6255.9 6370.2 6410.0 6437.9 6463.1 6298.8 6319.2 6323.4 6326.5 6335.0 6467.2 6474.2 6480.4 6495.3 6506.2 6230.9 6326.0 6335.5 6339.4 6339.6 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - PROCESS | 21937 | [#5] yui.html Cycles:180 Average:15012.44 Median:24098.48 stddev:17980.27 (74.6%) stddev-sans-first:17998.44 02:13:40 INFO - PROCESS | 21937 | Values: 667.8 675.2 699.1 713.3 717.5 12124.2 12166.5 12226.3 13105.9 14989.3 14112.9 14200.1 14210.7 14210.9 14245.9 773.0 806.5 815.8 816.4 819.9 816.9 822.6 823.5 827.1 828.9 848.4 854.4 854.4 854.9 858.7 843.5 848.5 853.7 854.0 858.0 618.2 620.4 622.3 622.5 622.7 14910.9 15007.5 15013.9 15029.6 15031.2 13515.9 13529.9 13530.9 13613.2 13637.9 10735.6 10866.1 10973.1 11110.7 11459.0 3861.6 3868.5 3878.7 3932.3 3978.8 61725.7 62098.0 62595.7 62636.0 63122.0 10788.0 10872.3 10904.8 10936.7 11006.8 17735.2 18164.4 18243.7 18278.7 19434.3 7734.3 7846.8 8239.1 8246.8 8457.5 4595.9 4786.0 4802.3 4830.2 4931.2 3174.0 3246.2 3247.4 3247.5 3264.1 596.1 600.3 601.4 622.6 631.8 634.2 663.8 748.4 759.8 775.4 8616.9 8997.6 9088.1 9096.2 9327.8 655.0 656.0 657.3 673.4 679.5 4343.1 4350.3 4379.5 4397.2 4491.9 63595.7 64359.7 65448.7 65752.7 65839.3 56139.4 56304.0 56326.7 56327.7 56704.0 52084.5 52396.0 53178.0 53366.0 54505.5 9153.3 9231.0 9233.6 9289.7 9301.5 29217.0 30137.7 30604.1 32152.8 35334.3 43304.8 43306.8 43799.8 44059.6 44248.0 10457.2 10773.5 11218.8 11298.3 11629.6 12643.1 12796.3 12805.7 12901.7 13103.8 12904.2 13019.8 13035.6 13048.8 13540.1 12046.9 12057.3 12353.9 12664.3 13243.4 12514.0 12686.4 12728.6 12729.2 12901.9 10016.5 10256.1 10278.2 10291.7 10357.7 10432.0 10518.6 10527.9 10581.7 10602.9 02:13:40 INFO - PROCESS | 21937 | -------- Summary: end -------- 02:13:40 INFO - PROCESS | 21937 | 02:13:40 INFO - TEST-INFO | 21937: exit 0 02:13:40 INFO - TEST-OK | dromaeo_css | took 1109017ms 02:13:40 INFO - TEST-START | kraken 02:13:40 INFO - operating with platform_type : linux_ 02:13:40 INFO - Initialising browser for kraken test... 02:13:40 INFO - TEST-INFO | started process 22174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLrXlAO/profile http://localhost:41720/getInfo.html) 02:13:44 INFO - PROCESS | 22174 | 02:13:44 INFO - PROCESS | 22174 | (process:22242): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:45 INFO - PROCESS | 22174 | __metrics Screen width/height:1600/1200 02:13:45 INFO - PROCESS | 22174 | colorDepth:24 02:13:45 INFO - PROCESS | 22174 | Browser inner width/height: 1024/697 02:13:45 INFO - PROCESS | 22174 | __metrics 02:13:45 ERROR - PROCESS | 22174 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:13:46 INFO - TEST-INFO | 22174: exit 0 02:13:46 INFO - Browser initialized. 02:13:46 INFO - Running cycle 1/1 for kraken test... 02:13:46 INFO - TEST-INFO | started process 22293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLrXlAO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:48 INFO - PROCESS | 22293 | 02:13:48 INFO - PROCESS | 22293 | (process:22355): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:58 INFO - PROCESS | 22293 | RSS: Main: 163495936 02:13:58 INFO - PROCESS | 22293 | 02:14:01 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41720/tests/kraken/driver.html?testName=audio-beat-detection) 02:14:01 INFO - PROCESS | 22293 | RSS: Main: 168448000 02:14:01 INFO - PROCESS | 22293 | 02:14:04 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41720/tests/kraken/driver.html?testName=audio-dft) 02:14:05 INFO - PROCESS | 22293 | RSS: Main: 171839488 02:14:05 INFO - PROCESS | 22293 | 02:14:08 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41720/tests/kraken/driver.html?testName=audio-fft) 02:14:08 INFO - PROCESS | 22293 | RSS: Main: 163037184 02:14:08 INFO - PROCESS | 22293 | 02:14:10 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41720/tests/kraken/driver.html?testName=audio-oscillator) 02:14:11 INFO - PROCESS | 22293 | RSS: Main: 163450880 02:14:11 INFO - PROCESS | 22293 | 02:14:13 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:14:14 INFO - PROCESS | 22293 | RSS: Main: 164421632 02:14:14 INFO - PROCESS | 22293 | 02:14:17 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41720/tests/kraken/driver.html?testName=imaging-darkroom) 02:14:18 INFO - PROCESS | 22293 | RSS: Main: 164585472 02:14:18 INFO - PROCESS | 22293 | 02:14:21 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41720/tests/kraken/driver.html?testName=imaging-desaturate) 02:14:22 INFO - PROCESS | 22293 | RSS: Main: 163803136 02:14:22 INFO - PROCESS | 22293 | 02:14:25 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41720/tests/kraken/driver.html?testName=json-parse-financial) 02:14:25 INFO - PROCESS | 22293 | RSS: Main: 165150720 02:14:25 INFO - PROCESS | 22293 | 02:14:27 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:14:27 INFO - PROCESS | 22293 | RSS: Main: 165093376 02:14:27 INFO - PROCESS | 22293 | 02:14:29 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:14:30 INFO - PROCESS | 22293 | RSS: Main: 165191680 02:14:30 INFO - PROCESS | 22293 | 02:14:32 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:14:32 INFO - PROCESS | 22293 | RSS: Main: 165502976 02:14:32 INFO - PROCESS | 22293 | 02:14:35 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:14:36 INFO - PROCESS | 22293 | RSS: Main: 165687296 02:14:36 INFO - PROCESS | 22293 | 02:14:39 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:14:39 INFO - PROCESS | 22293 | RSS: Main: 166473728 02:14:39 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | Cycle 1(1): loaded http://localhost:41720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41720/tests/kraken/driver.html?testName=ai-astar) 02:14:41 INFO - PROCESS | 22293 | RSS: Main: 167264256 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | __start_tp_report 02:14:41 INFO - PROCESS | 22293 | _x_x_mozilla_page_load 02:14:41 INFO - PROCESS | 22293 | _x_x_mozilla_page_load_details 02:14:41 INFO - PROCESS | 22293 | |i|pagename|runs| 02:14:41 INFO - PROCESS | 22293 | |0;ai-astar;112;106;111;115;112;123;113;112;112;113 02:14:41 INFO - PROCESS | 22293 | |1;audio-beat-detection;154;129;156;187;130;166;160;131;194;126 02:14:41 INFO - PROCESS | 22293 | |2;audio-dft;163;164;162;164;162;167;190;162;166;164 02:14:41 INFO - PROCESS | 22293 | |3;audio-fft;76;76;76;145;75;73;73;73;96;74 02:14:41 INFO - PROCESS | 22293 | |4;audio-oscillator;94;94;151;92;93;93;151;93;94;153 02:14:41 INFO - PROCESS | 22293 | |5;imaging-gaussian-blur;118;117;117;117;119;117;117;118;118;118 02:14:41 INFO - PROCESS | 22293 | |6;imaging-darkroom;148;147;147;148;148;147;147;147;146;147 02:14:41 INFO - PROCESS | 22293 | |7;imaging-desaturate;96;97;95;95;95;95;95;96;95;95 02:14:41 INFO - PROCESS | 22293 | |8;json-parse-financial;56;57;58;58;58;58;59;75;58;55 02:14:41 INFO - PROCESS | 22293 | |9;json-stringify-tinderbox;59;61;61;60;59;60;59;61;61;61 02:14:41 INFO - PROCESS | 22293 | |10;stanford-crypto-aes;78;84;76;81;79;78;78;77;88;78 02:14:41 INFO - PROCESS | 22293 | |11;stanford-crypto-ccm;128;127;129;129;128;128;130;125;161;143 02:14:41 INFO - PROCESS | 22293 | |12;stanford-crypto-pbkdf2;179;169;171;171;171;176;175;168;170;171 02:14:41 INFO - PROCESS | 22293 | |13;stanford-crypto-sha256-iterative;69;69;69;70;69;67;68;69;70;66 02:14:41 INFO - PROCESS | 22293 | __end_tp_report 02:14:41 INFO - PROCESS | 22293 | __start_cc_report 02:14:41 INFO - PROCESS | 22293 | _x_x_mozilla_cycle_collect,869 02:14:41 INFO - PROCESS | 22293 | __end_cc_report 02:14:41 INFO - PROCESS | 22293 | __startTimestamp1461316481643__endTimestamp 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | ------- Summary: start ------- 02:14:41 INFO - PROCESS | 22293 | Number of tests: 14 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.23 (3.8%) stddev-sans-first:4.47 02:14:41 INFO - PROCESS | 22293 | Values: 112.0 106.0 111.0 115.0 112.0 123.0 113.0 112.0 112.0 113.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:158.00 stddev:24.45 (15.5%) stddev-sans-first:25.94 02:14:41 INFO - PROCESS | 22293 | Values: 154.0 129.0 156.0 187.0 130.0 166.0 160.0 131.0 194.0 126.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#2] audio-dft Cycles:10 Average:166.40 Median:164.00 stddev:8.46 (5.2%) stddev-sans-first:8.89 02:14:41 INFO - PROCESS | 22293 | Values: 163.0 164.0 162.0 164.0 162.0 167.0 190.0 162.0 166.0 164.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#3] audio-fft Cycles:10 Average:83.70 Median:75.50 stddev:22.61 (29.9%) stddev-sans-first:23.81 02:14:41 INFO - PROCESS | 22293 | Values: 76.0 76.0 76.0 145.0 75.0 73.0 73.0 73.0 96.0 74.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:93.00 stddev:28.21 (30.3%) stddev-sans-first:29.26 02:14:41 INFO - PROCESS | 22293 | Values: 94.0 94.0 151.0 92.0 93.0 93.0 151.0 93.0 94.0 153.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:14:41 INFO - PROCESS | 22293 | Values: 118.0 117.0 117.0 117.0 119.0 117.0 117.0 118.0 118.0 118.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:14:41 INFO - PROCESS | 22293 | Values: 148.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 146.0 147.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:14:41 INFO - PROCESS | 22293 | Values: 96.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:5.67 (9.8%) stddev-sans-first:5.90 02:14:41 INFO - PROCESS | 22293 | Values: 56.0 57.0 58.0 58.0 58.0 58.0 59.0 75.0 58.0 55.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 02:14:41 INFO - PROCESS | 22293 | Values: 59.0 61.0 61.0 60.0 59.0 60.0 59.0 61.0 61.0 61.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:78.50 stddev:3.68 (4.7%) stddev-sans-first:3.86 02:14:41 INFO - PROCESS | 22293 | Values: 78.0 84.0 76.0 81.0 79.0 78.0 78.0 77.0 88.0 78.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:129.00 stddev:11.05 (8.6%) stddev-sans-first:11.59 02:14:41 INFO - PROCESS | 22293 | Values: 128.0 127.0 129.0 129.0 128.0 128.0 130.0 125.0 161.0 143.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:171.00 stddev:3.45 (2.0%) stddev-sans-first:2.60 02:14:41 INFO - PROCESS | 22293 | Values: 179.0 169.0 171.0 171.0 171.0 176.0 175.0 168.0 170.0 171.0 02:14:41 INFO - PROCESS | 22293 | 02:14:41 INFO - PROCESS | 22293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.33 02:14:41 INFO - PROCESS | 22293 | Values: 69.0 69.0 69.0 70.0 69.0 67.0 68.0 69.0 70.0 66.0 02:14:41 INFO - PROCESS | 22293 | -------- Summary: end -------- 02:14:41 INFO - PROCESS | 22293 | 02:14:42 INFO - TEST-INFO | 22293: exit 0 02:14:42 INFO - TEST-OK | kraken | took 61919ms 02:14:42 INFO - SUITE-END | took 1170s 02:14:42 INFO - Completed test suite (00:19:31) 02:14:42 INFO - javascript benchmark 02:14:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.8767649294027, 3138.215446138466, 3140.842957852107, 3203.8718451261952, 3208.0856955767613, 5193.246979188016, 5198.610104242182, 5228.73856307185, 5231.738413079341, 5284.471552844713, 5261.605379596526, 5393.541548968343, 5416.891662166754, 5463.726813659321, 5498.0653288940875, 4888.731119788419, 4915.434725006617, 4952.727599981999, 4968.031233909389, 5003.874903127415, 599.2454907296102, 4802.615790736732, 4927.0, 4942.678725882806, 4975.179095449246, 4899.559039686445, 4903.877403064934, 4909.435414927293, 4914.631402644816, 4953.975230123862, 4771.785269662873, 5010.749462526859, 5038.874028149289, 5039.269305950616, 5084.084864724348, 4881.4630390657, 4884.853454396374, 4897.314375987365, 4904.632152588534, 4936.703797772145, 5198.506141916512, 5245.423003469616, 5274.947250527484, 5279.366476022863, 5323.467653234684, 5668.858278543069, 5692.857678558069, 5715.571332150063, 5744.942550574524, 5801.593888427812, 5684.175794509773, 5736.340320863071, 5745.310562732457, 5761.366249712528, 5778.942210577925, 5321.0, 5342.198670199462, 5349.812756553502, 5351.759170837283, 5363.9463605363835, 5678.0, 5917.704114794243, 5927.407259274038, 6004.039353703474, 6013.368596297413, 5652.236948011966, 5654.971725141348, 5694.5159661428415, 5697.886042279131, 5716.514096301861, 5746.511546518509, 5756.366799652035, 5758.337791154071, 5758.654480731169, 5763.538916886639, 5548.278723765965, 5691.800786972519, 5741.425857414225, 5756.683382414008, 5801.564882633819, 5544.528715059185, 5605.663660180402, 5608.887822243532, 5614.550835933115, 5770.711464426762, 4291.6137547620865, 4310.892227694333, 4359.12817436514, 4371.213181627338, 4408.25059739845, 3839.6736277416176, 3897.2595206911164, 3902.70729695274, 3944.6252606002386, 3944.6449819515806, 5455.645383050089, 5480.7533660985355, 5490.945090549043, 5496.835094947158, 5554.86112847174, 5766.625169363978, 5782.537397008229, 5799.5070419014855, 5803.47768700819, 5851.444112809277, 5348.625596208228, 5454.509094181463, 5469.042917489423, 5501.504864562128, 5515.448455154453, 4883.926741098815, 4941.036497882878, 4953.578945789648, 4959.280904268933, 4990.6257030722845, 5839.328477225174, 5911.467967882825, 5913.438223368859, 5937.317208520989, 5942.940570594325, 5660.632058916322, 5681.346645135863, 5745.224394706828, 5746.597738158289, 5820.534357251409, 5799.2750906136735, 5809.8547536311935, 5811.622244554091, 5812.82561523155, 5821.534277257894, 5560.498665360249, 5562.833115006556, 5563.13771365439, 5564.4991950724625, 5575.8884822304135, 5656.717164141859, 5672.2342483765815, 5751.626144300607, 5847.970760146172, 5871.266091738533, 5566.805161819317, 5618.6628802272, 5622.409646987171, 5631.577631677558, 5672.404397538199, 5540.7783688652, 5563.443655634404, 5568.220449137205, 5573.414791447002, 5639.718014099197, 5395.13677811564, 5395.676259424447, 5468.972655136858, 5513.476219759116, 5566.443355664564, 5583.357913839798, 5594.328680558359, 5623.718814059199, 5630.071038278638, 5719.914201286901, 5533.723313834373, 5570.108782594765, 5579.19101730255, 5579.776808927598, 5580.079286917613], "value": 5257.619248716524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.131490653459, 631.0, 644.709880553751, 647.8607099473618, 658.2594581096266, 35782.463263051046, 36244.81877590615, 36529.817350913276, 36585.0, 36590.451143232836, 38173.0, 38598.0, 38684.0, 38879.611203888024, 38970.61029389705, 8410.0, 8550.786230344229, 8595.312375009984, 8602.483850968962, 8624.0, 8405.663773449054, 8469.153084691512, 8477.533735644538, 8646.524441155734, 8684.8697269541, 8748.825023499558, 8836.734897953073, 8842.336824738139, 8844.823103537925, 8897.243734282594, 8695.565221738887, 8760.386772925898, 8776.956115219447, 8835.823283534326, 8841.0, 8686.391952563323, 8797.912020879774, 8798.51608161551, 8805.075467075929, 8806.559672016374, 37672.0, 37835.432468513, 37850.81074594637, 37889.242215155544, 37997.81001094977, 3410.7782994105305, 3516.1912760065075, 3601.963980360189, 3811.104390468238, 3982.6614737747327, 30647.2338191547, 31101.222469438446, 31138.22154446157, 31282.37435251305, 31755.52366714501, 4266.445362102938, 4293.48478182617, 4323.913521729579, 4333.285007973681, 4353.651033086573, 216584.0, 217571.0, 217883.0, 218450.0, 218781.0, 34595.48106778401, 54348.0, 54351.0, 55148.0, 55155.72422137944, 34520.13699657529, 34704.826475867456, 34726.30547389088, 34728.65271347254, 34794.47808282878, 14815.185164815823, 14902.552923412315, 15008.399664013536, 15021.671640895678, 15077.623059423382, 12085.939570302267, 12129.21160124589, 12184.939075304566, 12185.32980686053, 12219.877801221874, 8449.197326253996, 8488.618012189467, 8560.443571167854, 8613.784655383666, 8635.13648635144, 3282.491213861855, 3306.3883181611477, 3335.966640333614, 3356.9496457553155, 3403.302323023774, 1092.9945350273356, 1130.4291332876844, 1132.2300835431986, 1140.361397617337, 1176.4064598292323, 30354.241143971576, 30888.382232355227, 31237.687623123933, 31601.209969750482, 31825.0, 1108.157800071935, 1170.9297442153497, 1177.7055736065984, 1180.3272134883034, 1249.3940438887132, 16355.91822040906, 16559.83440165607, 16939.407120750715, 16950.660986780196, 17010.319587216374, 486019.0, 491738.0, 495737.0, 495740.0, 496078.0, 54921.45078549163, 55622.0, 55930.720346398004, 56219.0, 56242.437575624535, 1405.3465138710753, 1407.8099456573436, 1420.3253454608978, 1433.5341014170435, 1516.0373163041547, 29921.401571968872, 30327.696723032488, 30361.544576831806, 30943.0, 31614.26121563244, 53210.73394633002, 54543.18185227145, 54601.63495912475, 54647.0, 54666.180007299125, 407010.0, 418838.0, 420433.0, 420604.0, 421063.0, 41708.3743743838, 42091.7895410521, 42220.788896055325, 42328.0, 43800.56199437965, 46446.53553464422, 46561.0, 47125.764371177924, 47577.0, 48524.0, 39225.62710305126, 40303.19393612053, 40391.3941290875, 41158.0, 41302.79348603238, 37714.43428348522, 39152.0, 39228.803855980535, 39960.600393995686, 40677.796611016754, 39017.41473877951, 40276.3958540628, 40620.0, 40945.0, 41054.58945410627, 32436.83781581077, 34917.650823492455, 35371.82314088413, 35730.28539429145, 35910.28179436449, 27808.304792380353, 27834.58248126239, 28105.71894281031, 28163.43673126567, 28349.858250708614], "value": 18483.09085392596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.44893597898914, 397.2273927211573, 398.61533620056656, 401.90957034667224, 409.9200655872106, 13226.280583524152, 17926.28294868207, 18277.634447311062, 18775.718364224547, 19001.809981900176, 16916.407925722604, 17608.647827043453, 18127.093645317746, 18516.537086572844, 18611.348602798906, 5104.8979020419565, 5550.27846379971, 5700.9714951425185, 5741.052726300176, 5761.164631128484, 5713.085906255, 5716.771329146829, 5731.742071606767, 5758.136279558058, 5761.4814666679995, 5437.102878025141, 5627.634203776762, 5660.801871934483, 5711.628744131618, 5723.713814309289, 5595.244641973342, 5651.547876169897, 5660.660360378391, 5679.318481782192, 5709.8572535686735, 4824.107540105092, 5021.472745361721, 5046.772895219724, 5073.797048118071, 5075.492450754932, 21093.894530527403, 21769.346919592437, 21979.0, 22132.225372111898, 22159.667604985938, 2426.598873436013, 2448.70615526138, 2531.316544532984, 2551.617257411385, 2797.37059161689, 13788.379522921492, 14261.85738142626, 14306.856931430657, 14438.855611443856, 14492.0, 1759.463363674079, 1829.7804263488467, 1873.8594605404649, 1879.6334714730633, 1904.523993904721, 65913.67043164754, 80223.19776802216, 80725.19274807235, 81157.0, 81220.0, 9688.9031109688, 9953.900460995297, 10431.0, 10545.789084218273, 10701.571937122584, 14219.786703199461, 14222.0, 14339.78490322646, 14348.784768228485, 14353.78469322961, 7893.526388416713, 7911.28798408146, 7978.760637180778, 8016.959915200387, 8046.476978996347, 7723.189065148191, 7723.729669461542, 7727.265909738566, 7733.729319473791, 8174.550399727953, 4594.264917613166, 4630.703403047152, 4659.883502912454, 4682.9531704683195, 4690.718556886598, 1921.5196200949763, 1945.5622484940775, 1968.5275533872054, 1996.7304413904228, 1999.8600097993, 821.4906757810077, 977.941323520591, 1014.0569270578433, 1072.485207100596, 1109.5118148014847, 17952.371666991592, 17953.551161221076, 18171.364002259856, 18343.17455714496, 18632.906835465736, 1001.1590264178126, 1010.2473657125488, 1017.9338343007681, 1029.7477118105962, 1037.7457522906784, 10200.489975501343, 10498.160147188206, 10548.103411209979, 10561.31351462168, 10601.893981060244, 438298.70207787637, 491292.0, 494448.0, 494536.0, 496366.0, 90446.0, 93302.53348733213, 93767.0, 94032.52983735174, 94070.0, 994.8457989011715, 1011.3830563356347, 1012.7569383347943, 1018.0582960761266, 1047.0471870597871, 16261.67476650484, 16313.59216019609, 16333.836661633231, 16369.608583270556, 16380.918095409446, 38145.0, 38588.421173681854, 38745.0, 39321.80339098286, 39590.40614390729, 50258.748706256236, 53180.20229696635, 53532.46467535275, 54112.45887541074, 54128.188077178085, 7834.0599128105, 7966.760997170094, 8016.959915200387, 8071.798205044686, 8247.257746802816, 12772.233665980071, 13019.609411717664, 13108.2135071896, 13186.340682966005, 13355.866441335462, 5798.739056742373, 9904.207663387057, 10810.783784324427, 11578.363190024293, 11857.40712964331, 6661.067450556829, 9679.548067789889, 10263.332883362558, 10565.841512377167, 11231.26996745209, 11724.472398742248, 11906.880931190577, 11986.64040078764, 12066.577669781867, 12317.568885088978, 8314.750557483285, 8356.331493480386, 8508.106648801786, 8519.148085191431, 8563.914360856561, 11691.649250522498, 11989.520419183134, 11991.880081199426, 12082.45628946682, 12235.204711693712], "value": 9002.927075077043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.322566457926, 1535.2784191430028, 1698.5498842806658, 1745.7643218165545, 1825.2425243523937, 7336.779896603097, 8098.0, 8159.184081591838, 8375.790605234864, 8431.409801313903, 8124.187581241873, 8148.592570371473, 8176.91823081769, 8205.425620206588, 8228.958855205716, 2316.455632926261, 2340.5903966805827, 2344.15610380263, 2344.76552344765, 2347.3896786835376, 2273.9886300568555, 2277.874716890579, 2345.812335013203, 2357.3635118518077, 2358.8820558971984, 2256.7630398808137, 2287.6797248385155, 2295.104909085458, 2336.404216924682, 2361.3152185866165, 2247.415671925311, 2254.0532976149975, 2254.5941730488507, 2257.6726374675663, 2257.7064981552294, 2196.2532738868863, 2199.7030400895833, 2220.5336879255374, 2228.0530774420968, 2233.7766223377694, 8347.081820999685, 8445.873311900326, 8473.872891906627, 8474.915250847474, 8482.78793030173, 4971.0, 5121.795128194868, 5131.794728210867, 5135.255387968724, 5166.0, 3059.847007649631, 3254.5769050023346, 3313.718333941618, 3315.2209230830736, 3321.96678033219, 1148.9827652585218, 1171.0572988744057, 1177.7055736065984, 1219.3659297165514, 1225.0934308611652, 11443.828342574869, 11472.885271147265, 11480.82778758311, 11554.422278886022, 11555.422228888521, 4383.60547550722, 4627.514111018295, 4642.582167604932, 4671.11248862715, 4683.039976804746, 9715.12563869241, 9790.706278811647, 9814.705558833246, 9835.213182945346, 9855.11303982645, 5192.428832828386, 5209.739513024334, 5211.478852114758, 5211.609129315317, 5242.76407561653, 3979.3633018716864, 4483.506814250495, 4603.5396460353695, 4657.464391594942, 4675.579197872208, 3729.9556124285245, 3741.345264578688, 3776.8489260429274, 3795.0, 3813.161104556993, 1226.5093962415106, 1288.6907142285784, 1292.3021568353172, 1293.430890408236, 1306.5884246462333, 895.359817730326, 966.9226461883032, 1018.5314755212537, 1026.4046852825343, 1042.1870940666292, 5940.376260492586, 5955.3151387590115, 6039.667818270037, 6053.939460605426, 6181.320054793969, 451.0325352119685, 457.6293202505981, 461.16759249554207, 468.59934755783996, 471.66276112578987, 4127.7936103194725, 4275.935860962088, 4277.272863613193, 4291.6137547620865, 4301.333293339538, 9922.751931201778, 10261.897381026094, 10350.53422595985, 10360.740981475372, 10379.688609341732, 9739.805203895883, 10074.143697785623, 10094.14199793026, 10165.593376265015, 10216.897831021743, 7679.961600191963, 7860.685572577033, 7873.212678732196, 7893.329067029252, 7928.286454219148, 5735.426457354231, 5768.7404066817935, 5806.564507662027, 5878.470937615635, 5991.131285963598, 9010.684626038319, 9122.817543649222, 9188.678396256098, 9188.95405522968, 9273.536323183678, 8962.058983806866, 8977.147171018743, 9153.954230228806, 9182.95408522953, 9380.48407337603, 6377.617342959437, 7239.8552028960175, 7410.333070023724, 7440.069991251094, 7490.812729681584, 7928.682852685828, 7930.60346982637, 7940.682372705258, 7946.32456241226, 7986.920130798618, 6993.580385176906, 7213.639318033972, 7282.0, 7342.853142937218, 7487.3261406473675, 7105.147382313949, 7197.064381630355, 7236.312550307713, 7294.489385742947, 7311.8903216450735, 6774.830629234309, 6822.181338239443, 6843.110395648534, 6843.349881761224, 6889.655517224219, 4973.5523802857915, 5098.1842905135, 5163.922541161961, 5197.0905091608065, 5245.423003469539, 5137.8715532112, 5192.844214673566, 5235.712035838065, 5278.656887302313, 5350.822818979818], "value": 4420.599896698647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8466478422748, 331.4249776637534, 336.08417063501946, 342.64022776085136, 342.6693241022414, 5913.0, 6014.616638173223, 6029.788957386492, 6111.786087486938, 6143.416375444325, 6024.216851809269, 6027.87944241116, 6036.547258955585, 6058.818235452933, 6077.662914158878, 4638.860834174963, 4643.907121857553, 4654.255319148937, 4655.0448811499255, 4660.510646382132, 4309.383981007122, 4533.863984080483, 4546.317862390903, 4572.314152877078, 4646.697964632288, 4516.0967806438675, 4537.706753575232, 4540.545945405466, 4542.727436353829, 4565.1098035883015, 4534.433195850519, 4556.929121656408, 4562.977185114087, 4573.359729637853, 4591.265397536395, 3806.143617686026, 3909.139989202371, 3928.135810121797, 3957.1887763008513, 3962.603739626043, 5730.598858079936, 5754.223179870705, 5769.769209231626, 5769.88460230793, 5802.274715660543, 5192.1432963560965, 5199.298094757197, 5210.557102646279, 5216.217567364888, 5237.47625237477, 5963.224780778471, 6234.781782637586, 6237.407446292595, 6291.62250264981, 6315.842103947392, 4343.913121737579, 4352.781221258053, 4355.607995280408, 4359.12817436514, 4367.781610919473, 6255.343188965184, 6572.507061970371, 6615.404613584752, 6622.73509059637, 6623.867522649568, 4411.1618792429335, 4412.867613971522, 4436.711613745097, 4440.111977604492, 4441.689081764245, 4480.305552639346, 4507.211238033331, 4508.571685689854, 4518.977405112953, 4521.615662668644, 5092.38891333035, 5226.608004399685, 5232.084385232569, 5238.345206849144, 5262.947370526245, 6014.18808460861, 6163.274283200711, 6391.424771770563, 6394.424501794861, 6415.26224484181, 1558.6025563481467, 1563.5465714942538, 1567.42005457979, 1575.314738088935, 1577.4478932373806, 1008.4655132779639, 1018.9592416303414, 1038.631285893512, 1043.436544266103, 1052.4474650808233, 6107.267127944675, 6125.693715314216, 6139.7413530226195, 6159.84600384985, 6161.168242287234, 6577.276499585042, 6578.572392794453, 6603.669816509156, 6605.70274337656, 6632.535722499475, 5887.175795388649, 6115.205023346936, 6130.478909292671, 6150.692465376714, 6153.353897840751, 3519.6656317650295, 3530.046887340404, 3549.3256281306985, 3554.9466757998653, 3561.1809283864854, 6651.46788256948, 6733.427658648971, 6838.521303508706, 6845.657717114124, 6845.8973115403305, 6601.207855057424, 6665.700043498055, 6668.0, 6678.964760462136, 6681.265060843303, 6570.437529363552, 6760.357766012221, 6766.796996090026, 6805.9659701701175, 6877.2091209510545, 6573.474122070318, 6612.768553100618, 6619.66901654925, 6628.171478565179, 6646.501512386687, 6368.96815515938, 6474.158359413246, 6529.575577587441, 6548.0, 6554.967225163844, 6824.692888820115, 6837.247902730596, 6851.280615535297, 6864.759733409506, 6893.75952815327, 4405.735655860659, 4418.955810441855, 4421.09367579639, 4433.534478879671, 4446.9777651111535, 6420.775272865428, 6453.193350831146, 6480.509482819072, 6554.016897465228, 6700.195976482658, 6451.290358060516, 6467.223933128054, 6467.870642587028, 6469.28837827848, 6476.352364763486, 6255.874882502416, 6370.203724534434, 6410.0, 6437.871242575216, 6463.127477790438, 6298.779542715983, 6319.178506794087, 6323.430891219812, 6326.4622507087415, 6334.968325158345, 6467.159269294962, 6474.1583594134345, 6480.416762491398, 6495.253045899782, 6506.219253689398, 6230.943788549677, 6326.0, 6335.4931605472375, 6339.397757213057, 6339.5562310637815], "value": 4778.500271987749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.8263651450625, 675.15942651399, 699.1365663405696, 713.2938390992915, 717.5371885134089, 12124.151309408346, 12166.513339466423, 12226.327551984648, 13105.868941310584, 14989.325480353384, 14112.92943535281, 14200.14799112054, 14210.71578568428, 14210.857891421108, 14245.928770356133, 772.9961350193241, 806.508030101639, 815.7675062607158, 816.4407380944043, 819.9303059239971, 816.8611336072881, 822.5845947796355, 823.5017814222399, 827.0778082438069, 828.8590939540293, 848.3594885861166, 854.3549620036863, 854.3677678517884, 854.8674955381925, 858.716623514242, 843.5149788871362, 848.5460278750869, 853.7054716122959, 854.0264098927228, 858.0175698824842, 618.1809102938579, 620.4447019917194, 622.3341025103141, 622.4957784194817, 622.6855438003824, 14910.850891491164, 15007.474738384104, 15013.924930375388, 15029.624259393602, 15031.248437578077, 13515.932420337835, 13529.864701353057, 13530.86469135306, 13613.183209007491, 13637.908967282692, 10735.62425315118, 10866.130709543218, 10973.067289280421, 11110.666679999613, 11459.0, 3861.555921069085, 3868.477755502999, 3878.728489005771, 3932.292187406266, 3978.8209530570903, 61725.69137154285, 62098.0, 62595.687021565514, 62636.0, 63122.0, 10788.0, 10872.347659140476, 10904.781904362027, 10936.671899843017, 11006.834897476545, 17735.201915913814, 18164.364247251284, 18243.72634410485, 18278.725819112726, 19434.319798807257, 7734.342580880688, 7846.764597062097, 8239.134890836376, 8246.8350632987, 8457.492550446992, 4595.862124136282, 4785.976070119627, 4802.255650374198, 4830.227163653799, 4931.211006238985, 3173.984130079335, 3246.2371342734436, 3247.447933851251, 3247.4641684121857, 3264.1186879542865, 596.0909612840367, 600.3396264109444, 601.3986013986014, 622.5890911998059, 631.782035197856, 634.2199095113036, 663.8174502011985, 748.4311922938606, 759.8062494063978, 775.441681988967, 8616.913830861737, 8997.55012249398, 9088.136627020554, 9096.226820720181, 9327.813443731087, 654.9934500655028, 656.0454538646259, 657.263864471785, 673.3771261583016, 679.5481005131533, 4343.066240758252, 4350.260455722535, 4379.474463064453, 4397.1865204937185, 4491.865244042684, 63595.68202158959, 64359.678201608695, 65448.67275663591, 65752.67123664351, 65839.34160658428, 56139.438605613424, 56304.0, 56326.718366407906, 56327.71836140793, 56704.0, 52084.47915520872, 52395.999999999236, 53178.0, 53366.0, 54505.45494545004, 9153.267738581031, 9230.984591695042, 9233.630654774002, 9289.72130836076, 9301.488418136796, 29217.0, 30137.684854666408, 30604.08187754371, 32152.839235803673, 35334.29331413409, 43304.78347608242, 43306.78346608247, 43799.781001094794, 44059.55940440555, 44248.0, 10457.215708822021, 10773.461326933779, 11218.775624487627, 11298.265612735146, 11629.59296424621, 12643.114981951176, 12796.296203708886, 12805.743885122432, 12901.677458063623, 13103.803442948554, 12904.225746455242, 13019.804702929652, 13035.608931732064, 13048.804267935799, 13540.052196346162, 12046.879531204575, 12057.336846473178, 12353.938230308791, 12664.303463309607, 13243.404046817725, 12514.0, 12686.429110689856, 12728.554500592434, 12729.172603780724, 12901.870981290067, 10016.549255283675, 10256.07695307396, 10278.17774578017, 10291.742706432398, 10357.741056473347, 10432.0, 10518.579256829642, 10527.894721052691, 10581.735456613646, 10602.946985265024], "value": 6676.735062753683, "unit": "score"}], "name": "dromaeo_css", "value": 7055.924717785237, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 115.0, 112.0, 123.0, 113.0, 112.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 156.0, 187.0, 130.0, 166.0, 160.0, 131.0, 194.0, 126.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 164.0, 162.0, 167.0, 190.0, 162.0, 166.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 145.0, 75.0, 73.0, 73.0, 73.0, 96.0, 74.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 151.0, 92.0, 93.0, 93.0, 151.0, 93.0, 94.0, 153.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 75.0, 58.0, 55.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 60.0, 59.0, 60.0, 59.0, 61.0, 61.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 76.0, 81.0, 79.0, 78.0, 78.0, 77.0, 88.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 129.0, 129.0, 128.0, 128.0, 130.0, 125.0, 161.0, 143.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 169.0, 171.0, 171.0, 171.0, 176.0, 175.0, 168.0, 170.0, 171.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 67.0, 68.0, 69.0, 70.0, 66.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1559.8999999999999, "alertThreshold": 2.0}]} 02:14:42 INFO - Return code: 0 02:14:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:14:42 ERROR - # TBPL SUCCESS # 02:14:42 INFO - Running post-action listener: _resource_record_post_action 02:14:42 INFO - Running post-run listener: _resource_record_post_run 02:14:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535072768; Read time: 4; Write time: 507348 02:14:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 227180544; Read time: 0; Write time: 248976 02:14:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290029568; Read time: 4; Write time: 238012 02:14:44 INFO - Running post-run listener: _upload_blobber_files 02:14:44 INFO - Blob upload gear active. 02:14:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:14:44 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 02:14:44 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'] 02:14:44 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 02:14:44 INFO - (blobuploader) - INFO - Open directory for files ... 02:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:45 INFO - (blobuploader) - INFO - Done attempting. 02:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:45 INFO - (blobuploader) - INFO - Done attempting. 02:14:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:14:45 INFO - Return code: 0 02:14:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:14:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:14:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc7ca089991ded69d09795379a845e02180f59d48d66c845fb09fdca2e1eb73ccd8bfb4843b67c93db5f3d636ec570052fe05fc24d553b0ab770f99a76836db5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b438ebfd8ca1e48cff3af9f9a9f8c78bd866651023f1459dc84921a6a2f92fc9e9dfbe89fd448f6c4f97eb6eb37a2bc32ae12a04baf2f1936e6578331b15837"} 02:14:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:14:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:14:45 INFO - Contents: 02:14:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc7ca089991ded69d09795379a845e02180f59d48d66c845fb09fdca2e1eb73ccd8bfb4843b67c93db5f3d636ec570052fe05fc24d553b0ab770f99a76836db5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b438ebfd8ca1e48cff3af9f9a9f8c78bd866651023f1459dc84921a6a2f92fc9e9dfbe89fd448f6c4f97eb6eb37a2bc32ae12a04baf2f1936e6578331b15837"} 02:14:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:14:45 INFO - Copying logs to upload dir... 02:14:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:14:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.379587 ========= master_lag: 266.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 58 secs) (at 2016-04-22 02:19:12.800137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:12.803402) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855 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/bc7ca089991ded69d09795379a845e02180f59d48d66c845fb09fdca2e1eb73ccd8bfb4843b67c93db5f3d636ec570052fe05fc24d553b0ab770f99a76836db5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b438ebfd8ca1e48cff3af9f9a9f8c78bd866651023f1459dc84921a6a2f92fc9e9dfbe89fd448f6c4f97eb6eb37a2bc32ae12a04baf2f1936e6578331b15837"} build_url:https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/C5Sv03OTQwq40EqYeHEd6g/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/bc7ca089991ded69d09795379a845e02180f59d48d66c845fb09fdca2e1eb73ccd8bfb4843b67c93db5f3d636ec570052fe05fc24d553b0ab770f99a76836db5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b438ebfd8ca1e48cff3af9f9a9f8c78bd866651023f1459dc84921a6a2f92fc9e9dfbe89fd448f6c4f97eb6eb37a2bc32ae12a04baf2f1936e6578331b15837"}' ========= master_lag: 0.61 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:13.428302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:13.428667) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461313213.110129-78802855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:13.515312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 02:19:13.515632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 02:19:14.305988) ========= ========= Total master_lag: 267.75 =========