builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1461097035.65 results: success (0) buildid: 20160419123832 builduid: a1783ebad6b546558fb0488a272d61ad revision: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.650570) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.651262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.651669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.668669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.669033) ========= 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=0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 13:17:16-- 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% 30.6M=0s 2016-04-19 13:17:16 (30.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.783028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.783528) ========= 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=0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014403 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.833056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.833406) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 --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 f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 --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=0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 13:17:16,229 truncating revision to first 12 chars 2016-04-19 13:17:16,229 Setting DEBUG logging. 2016-04-19 13:17:16,229 attempt 1/10 2016-04-19 13:17:16,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4ab4fd96f8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 13:17:16,493 unpacking tar archive at: fx-team-f4ab4fd96f8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:16.405874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:16.406218) ========= script_repo_revision: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:16.406621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:16.406901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:16.417851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-19 13:17:16.418450) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:17:16 INFO - MultiFileLogger online at 20160419 13:17:16 in /builds/slave/test 13:17:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:17:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:16 INFO - {'append_to_log': False, 13:17:16 INFO - 'base_work_dir': '/builds/slave/test', 13:17:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:17:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:16 INFO - 'branch': 'Fx-Team-Non-PGO', 13:17:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:16 INFO - 'config_files': ('talos/linux_config.py',), 13:17:16 INFO - 'default_actions': ('clobber', 13:17:16 INFO - 'read-buildbot-config', 13:17:16 INFO - 'download-and-extract', 13:17:16 INFO - 'populate-webroot', 13:17:16 INFO - 'create-virtualenv', 13:17:16 INFO - 'install', 13:17:16 INFO - 'run-tests'), 13:17:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:16 INFO - 'download_minidump_stackwalk': True, 13:17:16 INFO - 'download_symbols': 'ondemand', 13:17:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:16 INFO - 'installer_path': 'installer.exe', 13:17:16 INFO - 'log_level': 'info', 13:17:16 INFO - 'log_name': 'talos', 13:17:16 INFO - 'log_to_console': True, 13:17:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:17:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:17:16 INFO - 'opt_config_files': (), 13:17:16 INFO - 'pip_index': False, 13:17:16 INFO - 'sps_profile': False, 13:17:16 INFO - 'sps_profile_interval': 0, 13:17:16 INFO - 'suite': 'dromaeojs-e10s', 13:17:16 INFO - 'system_bits': '32', 13:17:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:16 INFO - 'title': 'talos-linux64-ix-029', 13:17:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:16 INFO - 'use_talos_json': True, 13:17:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:16 INFO - 'work_dir': 'build'} 13:17:16 INFO - ##### 13:17:16 INFO - ##### Running clobber step. 13:17:16 INFO - ##### 13:17:16 INFO - Running pre-action listener: _resource_record_pre_action 13:17:16 INFO - Running main action method: clobber 13:17:16 INFO - rmtree: /builds/slave/test/build 13:17:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:17 INFO - Running post-action listener: _resource_record_post_action 13:17:17 INFO - ##### 13:17:17 INFO - ##### Running read-buildbot-config step. 13:17:17 INFO - ##### 13:17:17 INFO - Running pre-action listener: _resource_record_pre_action 13:17:17 INFO - Running main action method: read_buildbot_config 13:17:17 INFO - Using buildbot properties: 13:17:17 INFO - { 13:17:17 INFO - "project": "", 13:17:17 INFO - "product": "firefox", 13:17:17 INFO - "script_repo_revision": "production", 13:17:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:17:17 INFO - "repository": "", 13:17:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:17:17 INFO - "buildid": "20160419123832", 13:17:17 INFO - "pgo_build": "False", 13:17:17 INFO - "basedir": "/builds/slave/test", 13:17:17 INFO - "buildnumber": 1164, 13:17:17 INFO - "slavename": "talos-linux64-ix-029", 13:17:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:17:17 INFO - "platform": "ubuntu64_hw", 13:17:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:17:17 INFO - "branch": "fx-team", 13:17:17 INFO - "repo_path": "integration/fx-team", 13:17:17 INFO - "revision": "f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35", 13:17:17 INFO - "stage_platform": "linux64", 13:17:17 INFO - "builduid": "a1783ebad6b546558fb0488a272d61ad", 13:17:17 INFO - "slavebuilddir": "test" 13:17:17 INFO - } 13:17:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:17:17 INFO - Running post-action listener: _resource_record_post_action 13:17:17 INFO - ##### 13:17:17 INFO - ##### Running download-and-extract step. 13:17:17 INFO - ##### 13:17:17 INFO - Running pre-action listener: _resource_record_pre_action 13:17:17 INFO - Running main action method: download_and_extract 13:17:17 INFO - mkdir: /builds/slave/test/build/tests 13:17:17 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')]} 13:17:17 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:19 INFO - Downloaded 1361 bytes. 13:17:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:17:19 INFO - Using the following test package requirements: 13:17:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:17:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:17:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'jsshell-linux-x86_64.zip'], 13:17:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:17:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:17:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:17:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:17:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:17:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:19 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:22 INFO - Downloaded 22267191 bytes. 13:17:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:17:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:17:23 INFO - Return code: 0 13:17:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:23 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:33 INFO - Downloaded 22267191 bytes. 13:17:33 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'] 13:17:33 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 13:17:34 INFO - Return code: 0 13:17: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')]} 13:17:34 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:35 INFO - Downloaded 10845952 bytes. 13:17:35 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'] 13:17:35 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 13:17:35 INFO - Return code: 0 13:17:35 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')]} 13:17:35 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:39 INFO - Downloaded 54505764 bytes. 13:17:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:39 INFO - mkdir: /builds/slave/test/properties 13:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:39 INFO - Contents: 13:17:39 INFO - build_url:https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:40 INFO - Running post-action listener: _resource_record_post_action 13:17:40 INFO - Running post-action listener: set_extra_try_arguments 13:17:40 INFO - ##### 13:17:40 INFO - ##### Running populate-webroot step. 13:17:40 INFO - ##### 13:17:40 INFO - Running pre-action listener: _resource_record_pre_action 13:17:40 INFO - Running main action method: populate_webroot 13:17:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:40 INFO - '--tppagecycles', 13:17:40 INFO - '7'], 13:17:40 INFO - 'tests': ['tsvgm']}}, 13:17:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['damp', 'tps']}, 13:17:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'tests': ['damp', 'tps']}, 13:17:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['dromaeo_dom']}, 13:17:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['a11yr', 13:17:40 INFO - 'ts_paint', 13:17:40 INFO - 'tpaint', 13:17:40 INFO - 'sessionrestore', 13:17:40 INFO - 'sessionrestore_no_auto_restore', 13:17:40 INFO - 'tabpaint']}, 13:17:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:40 INFO - 'ts_paint', 13:17:40 INFO - 'tpaint', 13:17:40 INFO - 'sessionrestore', 13:17:40 INFO - 'sessionrestore_no_auto_restore', 13:17:40 INFO - 'tabpaint']}, 13:17:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:40 INFO - 'ts_paint', 13:17:40 INFO - 'tpaint', 13:17:40 INFO - 'sessionrestore', 13:17:40 INFO - 'sessionrestore_no_auto_restore', 13:17:40 INFO - 'tabpaint']}, 13:17:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:40 INFO - 'ts_paint', 13:17:40 INFO - 'tpaint', 13:17:40 INFO - 'sessionrestore', 13:17:40 INFO - 'sessionrestore_no_auto_restore', 13:17:40 INFO - 'tabpaint']}, 13:17:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['a11yr', 13:17:40 INFO - 'ts_paint', 13:17:40 INFO - 'tpaint', 13:17:40 INFO - 'sessionrestore', 13:17:40 INFO - 'sessionrestore_no_auto_restore', 13:17:40 INFO - 'tabpaint']}, 13:17:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['a11yr', 13:17:40 INFO - 'ts_paint', 13:17:40 INFO - 'tpaint', 13:17:40 INFO - 'sessionrestore', 13:17:40 INFO - 'sessionrestore_no_auto_restore', 13:17:40 INFO - 'tabpaint']}, 13:17:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['tsvgx', 13:17:40 INFO - 'tsvgr_opacity', 13:17:40 INFO - 'tart', 13:17:40 INFO - 'tscrollx', 13:17:40 INFO - 'cart']}, 13:17:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:40 INFO - 'tsvgr_opacity', 13:17:40 INFO - 'tart', 13:17:40 INFO - 'tscrollx', 13:17:40 INFO - 'cart']}, 13:17:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'talos_options': ['--disable-e10s'], 13:17:40 INFO - 'tests': ['tp5o']}, 13:17:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'tests': ['tp5o']}, 13:17:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'talos_options': ['--disable-e10s', 13:17:40 INFO - '--xperf_path', 13:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:40 INFO - 'tests': ['tp5n']}, 13:17:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:40 INFO - 'talos_options': ['--xperf_path', 13:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:40 INFO - 'tests': ['tp5n']}}, 13:17:40 INFO - 'talos.zip': {'path': '', 13:17:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:40 INFO - Running post-action listener: _resource_record_post_action 13:17:40 INFO - ##### 13:17:40 INFO - ##### Running create-virtualenv step. 13:17:40 INFO - ##### 13:17:40 INFO - Running pre-action listener: _resource_record_pre_action 13:17:40 INFO - Running main action method: create_virtualenv 13:17:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:40 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 13:17:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:40 INFO - Using real prefix '/usr' 13:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:43 INFO - Installing pip.................done. 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:17:43 INFO - Using env: {'DISPLAY': ':0', 13:17:43 INFO - 'HOME': '/home/cltbld', 13:17:43 INFO - 'LANG': 'en_US.UTF-8', 13:17:43 INFO - 'LANGUAGE': 'en_US:en', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MAIL': '/var/mail/cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SHLVL': '1', 13:17:43 INFO - 'TERM': 'linux', 13:17:43 INFO - 'TMOUT': '86400', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - '_': '/tools/buildbot/bin/python'} 13:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:43 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 13:17:43 INFO - Cleaning up... 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:17:43 INFO - Using env: {'DISPLAY': ':0', 13:17:43 INFO - 'HOME': '/home/cltbld', 13:17:43 INFO - 'LANG': 'en_US.UTF-8', 13:17:43 INFO - 'LANGUAGE': 'en_US:en', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MAIL': '/var/mail/cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SHLVL': '1', 13:17:43 INFO - 'TERM': 'linux', 13:17:43 INFO - 'TMOUT': '86400', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - '_': '/tools/buildbot/bin/python'} 13:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:43 INFO - Downloading/unpacking psutil>=0.7.1 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:45 INFO - Installing collected packages: psutil 13:17:45 INFO - Running setup.py install for psutil 13:17:45 INFO - building 'psutil._psutil_linux' extension 13:17:45 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 13:17:45 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 13:17:45 INFO - building 'psutil._psutil_posix' extension 13:17:45 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 13:17:45 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 13:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:46 INFO - Successfully installed psutil 13:17:46 INFO - Cleaning up... 13:17:46 INFO - Return code: 0 13:17:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:17:46 INFO - Using env: {'DISPLAY': ':0', 13:17:46 INFO - 'HOME': '/home/cltbld', 13:17:46 INFO - 'LANG': 'en_US.UTF-8', 13:17:46 INFO - 'LANGUAGE': 'en_US:en', 13:17:46 INFO - 'LOGNAME': 'cltbld', 13:17:46 INFO - 'MAIL': '/var/mail/cltbld', 13:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:46 INFO - 'MOZ_NO_REMOTE': '1', 13:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:46 INFO - 'NO_EM_RESTART': '1', 13:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:46 INFO - 'PWD': '/builds/slave/test', 13:17:46 INFO - 'SHELL': '/bin/bash', 13:17:46 INFO - 'SHLVL': '1', 13:17:46 INFO - 'TERM': 'linux', 13:17:46 INFO - 'TMOUT': '86400', 13:17:46 INFO - 'USER': 'cltbld', 13:17:46 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:46 INFO - '_': '/tools/buildbot/bin/python'} 13:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:17:48 INFO - Installing collected packages: mozsystemmonitor 13:17:48 INFO - Running setup.py install for mozsystemmonitor 13:17:48 INFO - Successfully installed mozsystemmonitor 13:17:48 INFO - Cleaning up... 13:17:48 INFO - Return code: 0 13:17:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:48 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')]} 13:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:48 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')]} 13:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:48 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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:48 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 13:17:48 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 13:17:48 INFO - Using env: {'DISPLAY': ':0', 13:17:48 INFO - 'HOME': '/home/cltbld', 13:17:48 INFO - 'LANG': 'en_US.UTF-8', 13:17:48 INFO - 'LANGUAGE': 'en_US:en', 13:17:48 INFO - 'LOGNAME': 'cltbld', 13:17:48 INFO - 'MAIL': '/var/mail/cltbld', 13:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:48 INFO - 'MOZ_NO_REMOTE': '1', 13:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:48 INFO - 'NO_EM_RESTART': '1', 13:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:48 INFO - 'PWD': '/builds/slave/test', 13:17:48 INFO - 'SHELL': '/bin/bash', 13:17:48 INFO - 'SHLVL': '1', 13:17:48 INFO - 'TERM': 'linux', 13:17:48 INFO - 'TMOUT': '86400', 13:17:48 INFO - 'USER': 'cltbld', 13:17:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:48 INFO - '_': '/tools/buildbot/bin/python'} 13:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:51 INFO - Downloading docopt-0.6.1.tar.gz 13:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:51 INFO - Running setup.py install for blobuploader 13:17:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:51 INFO - Running setup.py install for requests 13:17:51 INFO - Running setup.py install for docopt 13:17:51 INFO - Successfully installed blobuploader requests docopt 13:17:51 INFO - Cleaning up... 13:17:51 INFO - Return code: 0 13:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:51 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')]} 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 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')]} 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:51 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 13:17:51 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 13:17:51 INFO - Using env: {'DISPLAY': ':0', 13:17:51 INFO - 'HOME': '/home/cltbld', 13:17:51 INFO - 'LANG': 'en_US.UTF-8', 13:17:51 INFO - 'LANGUAGE': 'en_US:en', 13:17:51 INFO - 'LOGNAME': 'cltbld', 13:17:51 INFO - 'MAIL': '/var/mail/cltbld', 13:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:51 INFO - 'MOZ_NO_REMOTE': '1', 13:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:51 INFO - 'NO_EM_RESTART': '1', 13:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:51 INFO - 'PWD': '/builds/slave/test', 13:17:51 INFO - 'SHELL': '/bin/bash', 13:17:51 INFO - 'SHLVL': '1', 13:17:51 INFO - 'TERM': 'linux', 13:17:51 INFO - 'TMOUT': '86400', 13:17:51 INFO - 'USER': 'cltbld', 13:17:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:51 INFO - '_': '/tools/buildbot/bin/python'} 13:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:52 INFO - Running setup.py (path:/tmp/pip-QHUsEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:52 INFO - Running setup.py (path:/tmp/pip-8D_RYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:52 INFO - Running setup.py (path:/tmp/pip-bVlx2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:52 INFO - Running setup.py (path:/tmp/pip-Rcu_6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:52 INFO - Running setup.py (path:/tmp/pip-QejT72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:52 INFO - Running setup.py (path:/tmp/pip-fbQ3zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:52 INFO - Running setup.py (path:/tmp/pip-HDUTah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:52 INFO - Running setup.py (path:/tmp/pip-D5EmIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:52 INFO - Running setup.py (path:/tmp/pip-VVRlVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:52 INFO - Running setup.py (path:/tmp/pip-aKIxeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:52 INFO - Running setup.py (path:/tmp/pip-qMBMMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:52 INFO - Running setup.py (path:/tmp/pip-bX4KrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:52 INFO - Running setup.py (path:/tmp/pip-pvNz_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:53 INFO - Running setup.py (path:/tmp/pip-shZJnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:53 INFO - Running setup.py (path:/tmp/pip-B6Mggs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:53 INFO - Running setup.py (path:/tmp/pip-ytKk4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:53 INFO - Running setup.py (path:/tmp/pip-bfs9EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:53 INFO - Running setup.py install for manifestparser 13:17:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:53 INFO - Running setup.py install for mozcrash 13:17:53 INFO - Running setup.py install for mozdebug 13:17:53 INFO - Running setup.py install for mozdevice 13:17:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:53 INFO - Running setup.py install for mozfile 13:17:53 INFO - Running setup.py install for mozhttpd 13:17:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:53 INFO - Running setup.py install for mozinfo 13:17:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Running setup.py install for mozInstall 13:17:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Running setup.py install for mozleak 13:17:54 INFO - Running setup.py install for mozlog 13:17:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Running setup.py install for moznetwork 13:17:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Running setup.py install for mozprocess 13:17:54 INFO - Running setup.py install for mozprofile 13:17:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Running setup.py install for mozrunner 13:17:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:54 INFO - Running setup.py install for mozscreenshot 13:17:54 INFO - Running setup.py install for moztest 13:17:55 INFO - Running setup.py install for mozversion 13:17:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:55 INFO - Cleaning up... 13:17:55 INFO - Return code: 0 13:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:55 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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:55 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 13:17:55 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 13:17:55 INFO - Using env: {'DISPLAY': ':0', 13:17:55 INFO - 'HOME': '/home/cltbld', 13:17:55 INFO - 'LANG': 'en_US.UTF-8', 13:17:55 INFO - 'LANGUAGE': 'en_US:en', 13:17:55 INFO - 'LOGNAME': 'cltbld', 13:17:55 INFO - 'MAIL': '/var/mail/cltbld', 13:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:55 INFO - 'MOZ_NO_REMOTE': '1', 13:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:55 INFO - 'NO_EM_RESTART': '1', 13:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:55 INFO - 'PWD': '/builds/slave/test', 13:17:55 INFO - 'SHELL': '/bin/bash', 13:17:55 INFO - 'SHLVL': '1', 13:17:55 INFO - 'TERM': 'linux', 13:17:55 INFO - 'TMOUT': '86400', 13:17:55 INFO - 'USER': 'cltbld', 13:17:55 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:55 INFO - '_': '/tools/buildbot/bin/python'} 13:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:55 INFO - Running setup.py (path:/tmp/pip-gMyPsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:55 INFO - Running setup.py (path:/tmp/pip-p4Z9ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:55 INFO - Running setup.py (path:/tmp/pip-ppDfwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:55 INFO - Running setup.py (path:/tmp/pip-GqXzon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:55 INFO - Running setup.py (path:/tmp/pip-sbPvhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:55 INFO - Running setup.py (path:/tmp/pip-Xvscnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:55 INFO - Running setup.py (path:/tmp/pip-9qXYXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:55 INFO - Running setup.py (path:/tmp/pip-GVv7gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:55 INFO - Running setup.py (path:/tmp/pip-yAfHnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:55 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)) 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:55 INFO - Running setup.py (path:/tmp/pip-HXyJNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:56 INFO - Running setup.py (path:/tmp/pip-nB_L2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:56 INFO - Running setup.py (path:/tmp/pip-1FvAHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:56 INFO - Running setup.py (path:/tmp/pip-QYdmQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:56 INFO - Running setup.py (path:/tmp/pip-Cy_Zn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:56 INFO - Running setup.py (path:/tmp/pip-_1VThJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:56 INFO - Running setup.py (path:/tmp/pip-90vhQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:56 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)) 13:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:56 INFO - Running setup.py (path:/tmp/pip-kRYMCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:56 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)) 13:17:56 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)) 13:17:56 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)) 13:17:56 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)) 13:17:56 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)) 13:17:56 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)) 13:17:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:58 INFO - Downloading blessings-1.6.tar.gz 13:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:58 INFO - Installing collected packages: blessings 13:17:58 INFO - Running setup.py install for blessings 13:17:58 INFO - Successfully installed blessings 13:17:58 INFO - Cleaning up... 13:17:58 INFO - Return code: 0 13:17:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:58 INFO - Reading from file tmpfile_stdout 13:17:58 INFO - Current package versions: 13:17:58 INFO - argparse == 1.2.1 13:17:58 INFO - blessings == 1.6 13:17:58 INFO - blobuploader == 1.2.4 13:17:58 INFO - docopt == 0.6.1 13:17:58 INFO - manifestparser == 1.1 13:17:58 INFO - mozInstall == 1.12 13:17:58 INFO - mozcrash == 0.17 13:17:58 INFO - mozdebug == 0.1 13:17:58 INFO - mozdevice == 0.48 13:17:58 INFO - mozfile == 1.2 13:17:58 INFO - mozhttpd == 0.7 13:17:58 INFO - mozinfo == 0.9 13:17:58 INFO - mozleak == 0.1 13:17:58 INFO - mozlog == 3.1 13:17:58 INFO - moznetwork == 0.27 13:17:58 INFO - mozprocess == 0.22 13:17:58 INFO - mozprofile == 0.28 13:17:58 INFO - mozrunner == 6.11 13:17:58 INFO - mozscreenshot == 0.1 13:17:58 INFO - mozsystemmonitor == 0.0 13:17:58 INFO - moztest == 0.7 13:17:58 INFO - mozversion == 1.4 13:17:58 INFO - psutil == 3.1.1 13:17:58 INFO - requests == 1.2.3 13:17:58 INFO - wsgiref == 0.1.2 13:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:58 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')]} 13:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:58 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')]} 13:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:58 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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:58 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 13:17:58 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 13:17:58 INFO - Using env: {'DISPLAY': ':0', 13:17:58 INFO - 'HOME': '/home/cltbld', 13:17:58 INFO - 'LANG': 'en_US.UTF-8', 13:17:58 INFO - 'LANGUAGE': 'en_US:en', 13:17:58 INFO - 'LOGNAME': 'cltbld', 13:17:58 INFO - 'MAIL': '/var/mail/cltbld', 13:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:58 INFO - 'MOZ_NO_REMOTE': '1', 13:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:58 INFO - 'NO_EM_RESTART': '1', 13:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:58 INFO - 'PWD': '/builds/slave/test', 13:17:58 INFO - 'SHELL': '/bin/bash', 13:17:58 INFO - 'SHLVL': '1', 13:17:58 INFO - 'TERM': 'linux', 13:17:58 INFO - 'TMOUT': '86400', 13:17:58 INFO - 'USER': 'cltbld', 13:17:58 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:58 INFO - '_': '/tools/buildbot/bin/python'} 13:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 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)) 13:17:59 INFO - Cleaning up... 13:17:59 INFO - Return code: 0 13:17:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:17:59 INFO - Using env: {'DISPLAY': ':0', 13:17:59 INFO - 'HOME': '/home/cltbld', 13:17:59 INFO - 'LANG': 'en_US.UTF-8', 13:17:59 INFO - 'LANGUAGE': 'en_US:en', 13:17:59 INFO - 'LOGNAME': 'cltbld', 13:17:59 INFO - 'MAIL': '/var/mail/cltbld', 13:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:59 INFO - 'MOZ_NO_REMOTE': '1', 13:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:59 INFO - 'NO_EM_RESTART': '1', 13:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:59 INFO - 'PWD': '/builds/slave/test', 13:17:59 INFO - 'SHELL': '/bin/bash', 13:17:59 INFO - 'SHLVL': '1', 13:17:59 INFO - 'TERM': 'linux', 13:17:59 INFO - 'TMOUT': '86400', 13:17:59 INFO - 'USER': 'cltbld', 13:17:59 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:59 INFO - '_': '/tools/buildbot/bin/python'} 13:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:59 INFO - Downloading/unpacking jsonschema 13:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:01 INFO - Downloading/unpacking functools32 (from jsonschema) 13:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:01 INFO - warning: no files found matching '*.txt' 13:18:01 INFO - no previously-included directories found matching 'build' 13:18:01 INFO - no previously-included directories found matching 'dist' 13:18:01 INFO - no previously-included directories found matching '.git*' 13:18:01 INFO - Installing collected packages: jsonschema, functools32 13:18:01 INFO - Running setup.py install for functools32 13:18:01 INFO - warning: no files found matching '*.txt' 13:18:01 INFO - no previously-included directories found matching 'build' 13:18:01 INFO - no previously-included directories found matching 'dist' 13:18:01 INFO - no previously-included directories found matching '.git*' 13:18:01 INFO - Successfully installed jsonschema functools32 13:18:01 INFO - Cleaning up... 13:18:01 INFO - Return code: 0 13:18:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:18:01 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')]} 13:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:01 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')]} 13:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:01 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 0x7f78129f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, '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': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', '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 13:18:01 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 13:18:01 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 13:18:01 INFO - Using env: {'DISPLAY': ':0', 13:18:01 INFO - 'HOME': '/home/cltbld', 13:18:01 INFO - 'LANG': 'en_US.UTF-8', 13:18:01 INFO - 'LANGUAGE': 'en_US:en', 13:18:01 INFO - 'LOGNAME': 'cltbld', 13:18:01 INFO - 'MAIL': '/var/mail/cltbld', 13:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:01 INFO - 'MOZ_NO_REMOTE': '1', 13:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:01 INFO - 'NO_EM_RESTART': '1', 13:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:01 INFO - 'PWD': '/builds/slave/test', 13:18:01 INFO - 'SHELL': '/bin/bash', 13:18:01 INFO - 'SHLVL': '1', 13:18:01 INFO - 'TERM': 'linux', 13:18:01 INFO - 'TMOUT': '86400', 13:18:01 INFO - 'USER': 'cltbld', 13:18:01 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:01 INFO - '_': '/tools/buildbot/bin/python'} 13:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:01 INFO - Downloading/unpacking flake8 13:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:18:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:18:03 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 13:18:03 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 13:18:03 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 13:18:03 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 13:18:03 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 13:18:03 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 13:18:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:18:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 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 13:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:04 INFO - no previously-included directories found matching 'docs/_build' 13:18:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:18:04 INFO - Running setup.py install for pep8 13:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:04 INFO - no previously-included directories found matching 'docs/_build' 13:18:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:18:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:18:04 INFO - Cleaning up... 13:18:04 INFO - Return code: 0 13:18:04 INFO - Running post-action listener: _resource_record_post_action 13:18:04 INFO - Running post-action listener: _start_resource_monitoring 13:18:04 INFO - Starting resource monitoring. 13:18:04 INFO - ##### 13:18:04 INFO - ##### Running install step. 13:18:04 INFO - ##### 13:18:04 INFO - Running pre-action listener: _resource_record_pre_action 13:18:04 INFO - Running main action method: install 13:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:05 INFO - Reading from file tmpfile_stdout 13:18:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:05 INFO - Reading from file tmpfile_stdout 13:18:05 INFO - Output received: 13:18:05 INFO - Usage: mozinstall [options] installer 13:18:05 INFO - Options: 13:18:05 INFO - -h, --help show this help message and exit 13:18:05 INFO - -d DEST, --destination=DEST 13:18:05 INFO - Directory to install application into. [default: 13:18:05 INFO - "/builds/slave/test"] 13:18:05 INFO - --app=APP Application being installed. [default: firefox] 13:18:05 INFO - mkdir: /builds/slave/test/build/application 13:18:05 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'] 13:18:05 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 13:18:20 INFO - Reading from file tmpfile_stdout 13:18:20 INFO - Output received: 13:18:20 INFO - /builds/slave/test/build/application/firefox/firefox 13:18:20 INFO - Running post-action listener: _resource_record_post_action 13:18:20 INFO - ##### 13:18:20 INFO - ##### Running run-tests step. 13:18:20 INFO - ##### 13:18:20 INFO - Running pre-action listener: _resource_record_pre_action 13:18:20 INFO - Running main action method: run_tests 13:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:20 INFO - Python 2.7.3 13:18:20 INFO - Return code: 0 13:18:20 INFO - grabbing minidump binary from tooltool 13:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:20 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 0x20b3410>, '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 0x20b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:20 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 13:18:20 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 13:18:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:20 INFO - Return code: 0 13:18:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:18:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:18:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:18:21 INFO - Return code: 0 13:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 13:18:21 INFO - Using env: {'DISPLAY': ':0', 13:18:21 INFO - 'HOME': '/home/cltbld', 13:18:21 INFO - 'LANG': 'en_US.UTF-8', 13:18:21 INFO - 'LANGUAGE': 'en_US:en', 13:18:21 INFO - 'LOGNAME': 'cltbld', 13:18:21 INFO - 'MAIL': '/var/mail/cltbld', 13:18:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:21 INFO - 'MOZ_NO_REMOTE': '1', 13:18:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:21 INFO - 'NO_EM_RESTART': '1', 13:18:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:21 INFO - 'PWD': '/builds/slave/test', 13:18:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:21 INFO - 'SHELL': '/bin/bash', 13:18:21 INFO - 'SHLVL': '1', 13:18:21 INFO - 'TERM': 'linux', 13:18:21 INFO - 'TMOUT': '86400', 13:18:21 INFO - 'USER': 'cltbld', 13:18:21 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577', 13:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:21 INFO - '_': '/tools/buildbot/bin/python'} 13:18:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:18:22 INFO - mozversion application_buildid: 20160419123832 13:18:22 INFO - mozversion application_changeset: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 13:18:22 INFO - mozversion application_display_name: Nightly 13:18:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:22 INFO - mozversion application_name: Firefox 13:18:22 INFO - mozversion application_remotingname: firefox 13:18:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:18:22 INFO - mozversion application_vendor: Mozilla 13:18:22 INFO - mozversion application_version: 48.0a1 13:18:22 INFO - mozversion platform_buildid: 20160419123832 13:18:22 INFO - mozversion platform_changeset: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 13:18:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:18:22 INFO - mozversion platform_version: 48.0a1 13:18:22 INFO - using testdate: 1461097102 13:18:22 INFO - actual date: 1461097102 13:18:22 INFO - starting webserver on 'localhost:37974' 13:18:22 INFO - SUITE-START | Running 2 tests 13:18:22 INFO - TEST-START | dromaeo_css 13:18:22 INFO - operating with platform_type : linux_ 13:18:22 INFO - Initialising browser for dromaeo_css test... 13:18:22 INFO - TEST-INFO | started process 9849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9W_sD/profile http://localhost:37974/getInfo.html) 13:18:25 INFO - PROCESS | 9849 | 13:18:25 INFO - PROCESS | 9849 | (process:9916): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:18:26 INFO - PROCESS | 9849 | __metrics Screen width/height:1600/1200 13:18:26 INFO - PROCESS | 9849 | colorDepth:24 13:18:26 INFO - PROCESS | 9849 | Browser inner width/height: 1024/697 13:18:26 INFO - PROCESS | 9849 | __metrics 13:18:27 ERROR - PROCESS | 9849 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:18:27 INFO - TEST-INFO | 9849: exit 0 13:18:27 INFO - Browser initialized. 13:18:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:27 INFO - TEST-INFO | started process 9967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9W_sD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:29 INFO - PROCESS | 9967 | 13:18:29 INFO - PROCESS | 9967 | (process:10027): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:18:39 INFO - PROCESS | 9967 | RSS: Main: 164605952 13:18:39 INFO - PROCESS | 9967 | 13:19:29 INFO - PROCESS | 9967 | 1461097169536 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] 13:21:41 INFO - PROCESS | 9967 | Cycle 1(1): loaded http://localhost:37974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37974/tests/dromaeo/cssquery-ext.html) 13:21:42 INFO - PROCESS | 9967 | RSS: Main: 168820736 13:21:42 INFO - PROCESS | 9967 | 13:24:44 INFO - PROCESS | 9967 | Cycle 1(1): loaded http://localhost:37974/tests/dromaeo/cssquery-ext.html (next: http://localhost:37974/tests/dromaeo/cssquery-jquery.html) 13:24:45 INFO - PROCESS | 9967 | RSS: Main: 165572608 13:24:45 INFO - PROCESS | 9967 | 13:27:47 INFO - PROCESS | 9967 | Cycle 1(1): loaded http://localhost:37974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37974/tests/dromaeo/cssquery-mootools.html) 13:27:48 INFO - PROCESS | 9967 | RSS: Main: 166899712 13:27:48 INFO - PROCESS | 9967 | 13:30:49 INFO - PROCESS | 9967 | Cycle 1(1): loaded http://localhost:37974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37974/tests/dromaeo/cssquery-prototype.html) 13:30:50 INFO - PROCESS | 9967 | RSS: Main: 164667392 13:30:50 INFO - PROCESS | 9967 | 13:33:53 INFO - PROCESS | 9967 | Cycle 1(1): loaded http://localhost:37974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37974/tests/dromaeo/cssquery-yui.html) 13:33:53 INFO - PROCESS | 9967 | RSS: Main: 165437440 13:33:53 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | Cycle 1(1): loaded http://localhost:37974/tests/dromaeo/cssquery-yui.html (next: http://localhost:37974/tests/dromaeo/cssquery-dojo.html) 13:36:56 INFO - PROCESS | 9967 | RSS: Main: 167800832 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | __start_tp_report 13:36:56 INFO - PROCESS | 9967 | _x_x_mozilla_page_load 13:36:56 INFO - PROCESS | 9967 | _x_x_mozilla_page_load_details 13:36:56 INFO - PROCESS | 9967 | |i|pagename|runs| 13:36:56 INFO - PROCESS | 9967 | |0;dojo.html;2617.4110825064363;2684.2081585932156;2727.481778462093;2737.904173353933;2741.6984131745503;4766.118268120395;4814.855554333371;4826;4845.757712114393;4874.46380898101;4637.536246375361;4741.383620129387;4768.284757286408;4865.48912364202;4873.293372460991;4440.134173836095;4484.753338566377;4537.795799189028;4543.7955292011775;4586.587207151356;4429.202743506184;4547.522510136421;4552.2943943688615;4564.497905230422;4590.449146102455;4310.051788606533;4343.2182207202695;4393.934090988638;4481.1037792441475;4541.45502539694;4387.298032314814;4405.471343438808;4426.114777044604;4436.112777444524;4447.822087116511;4377.321515165155;4438.511763705989;4443.244648409778;4456.22016147173;4458.576435238647;4612.654050946159;4674.509176536482;4716.9292460613115;4718;4718.62251019921;5123.666961647481;5133.204353325241;5157.510036546522;5173.405058418292;5189.091908915924;5188.740562971836;5199;5200.92198617021;5210.843674689765;5213.087709650796;4849.248366503198;4857.951420485821;4858.05267972742;4860.1008813368935;4904.092742842586;5253.737313134328;5279.577633789365;5319.946800532022;5322.148456246982;5356.812511562077;4842.854714358575;5010.073136469765;5058.215976523645;5077.8730531737;5095.363079615048;5142.537171654569;5153.175491921274;5155.458676838878;5164.715940623227;5180.48195180479;4976.402831660152;5069.366329208849;5123.359580052494;5137.51193636604;5173.922391164136;4865.0999565079865;5032.270320803536;5119.667221630582;5120.308758317579;5120.61595380348;4446.666500012448;4453.888652783707;4466.486354069324;4502.077074199847;4503.324501324828;3800.9809950950066;3826.330392181357;3871.903202419962;3887.7084218683713;3902.551206611219;4259.765712885821;4403.427554417969;4437.267850804581;4453.732776033448;4520.61574766142;5148.9485105149215;5151.5363617274625;5164.7417629119145;5168.689878607221;5210.088234559013;4433.800478978454;4446.3330500424545;4446.510883802779;4449.28811390176;4450.354698568754;4531.320301954733;4591.747453890001;4651.3720647712125;4718.457377401574;4728.4562275338085;4783.928241076456;4839.467658557626;4848.781804818792;4865.391826021677;4894.583960363409;5196.272521846869;5206.765695543634;5223.3209682741;5224.843254702365;5261.710605916712;4689.507601701908;4779.283107533759;4799.520047995173;4823.445303790109;4826.831060912851;5079.746012699424;5085.847424577269;5085.923711144262;5109.105906466428;5158.922616160836;4921.655484116221;5173.689578625294;5180.48195180479;5181.766820493011;5182.093133701663;4844.442889067662;4893.7063776173545;4916.483769204182;4919.237518184687;4960.454350021567;4989.326440930428;4993.15116430215;4993.201087825931;5039.697618142924;5042.243663450365;4825.5898248649255;4892.363992680928;4896.583790377716;4905.117078925828;4927.28554359623;4802.567768900815;5013.699178049329;5043.344365232496;5094.261332106749;5152.995165942605;4919.0899683558655;4934.481879402754;4939.110960027086;4942;4988.653063672716 13:36:56 INFO - PROCESS | 9967 | |1;ext.html;583.2796496327036;598.117776279987;608.1425190481422;620.5004970998348;649.2047242128397;33160.83419582905;33948.32103357931;34025.82987085067;34071.65928340719;34190.14524636879;34576.82711586445;35137.64862351382;35242.999999999935;35255.2948941021;35259.82370088153;7538.81152971176;7695.345895598881;7704.576248306369;7709.229077092274;7715.922840771605;7634.923650763477;7853.410994175431;7902.6048697565175;7910.169432209622;7917.049954005527;7862.488938219026;7868.527888326718;7958.4031197660115;7960.283574478296;7965.561894095822;7778.066632004139;7831.6475758591005;7880.724174653888;7889;7930.1276859545405;7760.844783104306;7822.569758663271;7854.332381747558;7867.567283799389;7868.291853733134;29715.554266686016;34538.65461345379;35311.4703279451;35358.292834143176;35386.11534711627;3013.3069394039276;3044.6955304469375;3127.2437175907367;3139.199504126456;3209.630892447375;27454.17637470859;27574.448511029666;27957.86021069902;28736.568951465746;30249.243768905733;3378.4932260160926;3393.592768867727;3424.143964008998;3488.988193423904;3500.492428597839;222946;228493.99999999834;228581;228673;229208;34186.48720269198;35289;57330.426695733346;58351;58400.70799645974;34056.31887362239;34261.314773704886;34438.31123377518;34445.82777086098;34664.65335346614;12320.938395308145;12441.253524788543;12524.373781310898;12556.183848049848;12571.120021598583;9712.077352651488;9754.268429867789;9769.31614786958;9791.216702663769;9821.754456138511;8351.874721879176;8421.621027053798;8442.873356899652;8514.787130321667;8517.95741021291;3277.4428347181038;3350.8994730158133;3379.5944486661756;3419.8461069251944;3430.3996800560303;900.9009009009004;928.7538802217417;937.0395344771528;956.9856452153223;1081.3565928272665;28013.43973120526;28161.43677126446;28245.60176628667;28373.43253134926;28456.71543284582;966.1932286540676;968.3802366485455;971.4414211828228;985.9063388978036;996.2976101848179;12992.285424301754;13423;13453.596392108253;13636.386362613706;13654.249016304;252977;256256;258996;259582;260379;47225.29162062572;47622.5237747625;47801.521984780404;48037.5196248033;48140.759296203294;1202.9218100823418;1253;1263.2041813657338;1272.0459655258555;1279.8848103670714;24352.756472435758;25453.236402907944;25882.482350353264;26030.479390412464;26242;38843.80578097204;39884;40104;40125.39811902765;40272.597274026884;306872;309556;310008;313191;314325;25621.231363059138;25968.740312596634;26084.087056952914;26327.34181645474;26518.867405662848;41378.793106034274;41496.792516037225;41521.79239103785;41590;41904.79047604743;34890.47664285089;35461.1134721634;35503.644963551065;35781.46327805033;35792;34564;34894.65105348914;35005.64994350024;35035.124121897155;35100.64899350974;31065.8446707765;34829.30341393209;34906.47640285347;35755.821220893726;36351.63648363482;27930;27976.160715178576;28322.858385708765;28495.43009139847;28769.712302876702;25253.621195682448;26251.474970500865;27753.306167345978;27873.050670120585;28178 13:36:56 INFO - PROCESS | 9967 | |2;jquery.html;376.9746290090952;390.7245391998641;393.8168751530538;397.4852565927124;402.75633241888676;13217.867821321785;15119.62200944977;16314.265858036388;17363.65272694547;17528.29886804526;16075.517734467956;16346.34614615414;16603;16734.74897876533;16769.24538395772;5037.848864534069;5146.897062058747;5279.973600132013;5294.523492885659;5322.8137015204475;5186.273921650972;5207.3490813648295;5210.270562121306;5220.712860792655;5224.190250511177;5121.052605268019;5126.641135120543;5167.992241512907;5178.8705282368055;5271.472852714717;5084.288199652052;5168.8966220675375;5193.1171700810955;5232.136697444917;5255.947440525603;4446.199684056868;4650.4186976627925;4691.62467002639;4693.7653117344;4726.409198850144;19925.302614408425;20017.399478015537;20046.39860804178;20180;20420.38738837837;2114.270576651053;2121.7984291492285;2282.349530383849;2339.9470238392623;2436.5248776488593;8433.789155271106;13293.268870212134;13393.799093013613;13662;13760.17438953666;1761.7005109131478;1806.5664240582298;1818.4362847517311;1836.5867679772077;1918.4052943587533;64555.35444645587;66981.330186698;67899.66050169767;67919;68421.65789171022;10109.39343639384;10120.443375614412;10175.338602990782;10243.84634230487;10335.379877207391;12288;13000.609981700563;13951.511697090757;13990;14112.647183820487;6943.722251109899;7133.393661538724;7139.32176443237;7209.711611535585;7343.742968996059;6811.216710078305;6891.793246202622;6903.171619405603;6959.130108736408;6974.511784175059;4342.934855977162;4359.520452750195;4376.737395756265;4455.220336441174;4479.641628669699;1832.2029916986153;1909.5226193451638;1911.3788018893638;1920.817522335404;1940.8835469871854;813.3940214540205;888.9911100889037;897.4749771383683;940.2290122099812;1016.974575635615;14771;16186.75719864203;16255.674886502204;16550;16592.419265325898;870.1646419437285;883.6067949762294;894.3515950935649;933.2394098809449;957.6887511558771;8957.686480973265;9361.34470587066;9433.198178154933;9515.666951656658;9628.374155679858;301283;390406;392383;393900;394210;46498.302525462146;74881.62559187278;83177.58411207906;83207.5839620798;84127.5793621028;936.9718908432758;946.7443790176613;964.9614015439445;966.6278482784179;966.7293157915794;15358.616034599225;15363.23183840826;15388.461403850812;15495.84504154944;15980.28088736033;25521.106761263265;30653.693463065083;33519.497207542394;35130;36913.26173476569;42485.362719558616;43002.78498607487;43439;43875;43905.78047109744;7551.282628150317;7610.391168706379;7685.193054729173;7686.846263074819;7702.884456733042;10361.481925903523;11533.711657208636;11604.88395116038;11680.415979200836;11784.351860647404;5040.84877453677;7887.487313324616;8593.667981462882;8698.869516957124;10316.658834351487;10265.897341026794;10337.431441270803;10363.792724145625;10410.68767936963;10660.147188224768;10290.897091028994;10673.89326106729;10806.621768238074;10828.783424331627;10902.127829773757;6917.204521480095;7110.6089165094345;7186.676599553137;7206.963965180141;7224.422046236184;9452.527373631428;10194.43930583825;10202.132818710195;10349.896501034893;10399.32404393712 13:36:56 INFO - PROCESS | 9967 | |3;mootools.html;1441.7621092519735;1485.665725211827;1638.8770842186839;1756.7452719355701;1804.630050839578;6803.115594972659;7387;7650.923490765091;7913.920860791398;7919.406044546653;7455.55266683998;7475.401967842573;7479.5138316009425;7493.662785174666;7508.9624551877305;2217.7782221777857;2242.372135801978;2244.6857439958417;2246.73039235292;2252.3805953362876;2167.7832216778274;2168.6638571021517;2198.736151661795;2199.25225423356;2199.9340019799433;2211.292386436341;2222.3666255117296;2223.866568005925;2238.8992495337748;2244.102359056374;2145.1526646974357;2145.4529095080734;2148.5380643161716;2149.634562124427;2157.3851452336166;2134.5944270588693;2142.85000049995;2149.9462513437134;2158.924437644675;2161.5460753241837;7610.39116870649;7669.9616501917135;7700.345470635003;7712.228777122243;7712.267334603203;4586.54134586542;4664.39362882823;4728.527147285278;4735.763211839429;4744.454387745419;2847.5870998705277;2870.1102658176032;2883.1206482022976;2888.8988885388912;2993.4462124507036;922.5894476957757;932.6689025395955;955.1833182628822;959.5154447004218;970.5147426286857;10547.73630659232;10601.469926503643;10655.52050157737;10687.786244275148;10696.465176741132;4181.665466762652;4307.483102027777;4355.956440435555;4401.559844015573;4411.977940110343;9144.039875813078;9161.404508706913;9189.3108016899;9208.493532855624;9225.169734723908;4706.647001474903;4732.266498692708;4740.1230772307235;4761.190597598416;4762.809487620526;3668.486411902336;4206.47419072616;4313.568643135662;4319.287317592562;4341.088371442032;3762.5673047599876;3826.827792749333;3878.166194268246;3888.922221555553;3916.3146449371816;1212.969675758113;1290.7934730443085;1292.915960462567;1299.8960083193322;1312.527490103562;784.4940013691137;886;898.3127907151035;919.103873723128;924.2744445610164;5549.750261238173;5657.2928383952;5685.289338832646;5742.971285143548;5823.068309070529;886.738412168399;912.7854954085917;926.342296969146;936.4474959773767;969;3579.6241394653707;3752.399616061417;3769.1142581493327;3789.5263092113487;3797.487339209227;9629.903700962901;10049.24630652704;10049.899501005042;10078.395296282246;10115.140213081824;9929.602815887283;9939.353941993892;9944;9945.552450139761;9980.900190997998;7110.253423390573;7390.187079421259;7392.815179620553;7467.701291948261;7484.738034168778;5396.568274538106;5576.721163941867;5687.601867869375;5709.714514274353;5740.68426236561;8618.267447267053;8794.384393092421;8983.281337492854;9059.818803624023;9066.773330666787;9038.728838134866;9082.682106126254;9217.631294748135;9287.814243715224;9301.302402319718;6122.479589234965;6818.62497562619;6935.445164386736;7062.929370706227;7079.68141433647;7707;7712.730054448068;7732.806679833049;7758;7796.9220307796195;6836.5214434989075;7021.087258656342;7080.362767350963;7116.822079448055;7193.496455248082;6990.860182796418;7008.789736307919;7020.333068358498;7056.54132481387;7099.183593886769;6449.806505804833;6467.320931302145;6608.0087986800445;6622.37087476689;6643.634600097041;4459.888502787457;4463.4420697412825;4507.323901414814;4578;4598;4650;4704.129735998714;4745.5966242869745;4768.523147685204;4839.951600484091 13:36:56 INFO - PROCESS | 9967 | |4;prototype.html;308.9938201235975;311.38346074771965;314.6711686287829;321.9179109327121;328.0552010210593;5152.819651312205;5259.658122222053;5306.575473962083;5376.435474275204;5387.676739395634;5305.469453054702;5379.139337705968;5383.67697938124;5385.138377859544;5393.325834270716;4158.875233742985;4180.6237438630515;4182.414461975311;4187.72779769314;4194.119234960662;3914.6868250540033;4121.608447197512;4184.28867092595;4184.874453766377;4197.433346498215;4049.129437171008;4085.428040074377;4100.56944020878;4108.50697916249;4113.670906327487;4085.530164031115;4093.406456063869;4102.712810103294;4112.444819949298;4114.855980040714;3591.838367273479;3597.1007248187952;3599.42409214527;3600.207954250061;3619.2580520993133;5066.113430149746;5076.771545280471;5126.820561280375;5137.893463679873;5138.306328645623;4677.064587082597;4689.155951928651;4693.460252071021;4694.413198350207;4720.150372932871;5578.44215578443;5579.944200558024;5589.776408943678;5599.7480113394995;5629.605927585029;3834.9424758628643;3876.205377897524;3880.2433525462548;3900.1029763154634;3904.2777086239134;5802.332731735863;5865.589408741347;5876.353601103875;5916.378780228057;5945.40545945402;3979.721419500665;4001.4998125234347;4007.6593489553716;4022.1955608878343;4027.060246020363;3937.448757173998;4019.9196016079513;4056.350983842571;4072.3687828386646;4080.8775736727353;4638.8608341749805;4681.485036645966;4686.922007938193;4696.976515117402;4700.835470758576;5324.440933701983;5626.493615574536;5649.576281778883;5651.237082993825;5730.3410107838135;1355.9389827457787;1377.373295150724;1383.018057179414;1385.3142694366152;1390.2701081932066;926.2682480840061;933.3653115881131;949.8480243161061;950.1733491862125;964.3538828984597;4802.543758342952;4807.759612019385;4808.903821923542;4819.156647586658;4823.686460380064;5723.141528770718;5727.4845263926445;5728.427157284238;5744.798932037359;5751.884962300731;4693.225617773098;4811.206150985118;4813.820613949605;4816.735079570587;4817.855464336076;3049.3139043714987;3081.568580398746;3086.768492363082;3088.243380371823;3090.8454577271045;5315.415304316522;5335.5464785492895;5340.332458442695;5357.08929481989;5381.838544843661;5654.953833540808;5835.241418615553;5924.407559244128;5925.992581261196;5965.7613695452565;5325.467453254643;5334.1732031535175;5347.465253474621;5361.946380536223;5366.812161574404;5590.748416321194;5721.6280941740315;5750.568707347049;5764.394738552392;5773.624714393719;5655.953648575027;5671.285308123186;5682.488576028178;5695.544356451391;5715.371309156073;5336.359636843604;5343.78624855017;5362.900605375967;5363.731813409392;5385.542228910586;3914.099757055836;3991.880243592697;4009.8195581198333;4009.9398509021803;4010.6991975601363;5513.531349835309;5680.630759000652;5699.088145896637;5735.741891614971;5737.512311453574;5455.754491047992;5645.491905728504;5660.32076150848;5669.31968163823;5685.147227915846;5534.335879694301;5602.3837377887585;5602.775888964559;5608.158776183605;5613.270274864405;5315.282436870973;5500.964643082085;5540.63985840919;5564;5583.637063590853;5675.7445914933105;5689.573282003784;5698.715064246854;5724.141378793214;5738.942610573841;5470.8085217017215;5567.192757050286;5576.358718747396;5584.832455026356;5593.608447408642 13:36:56 INFO - PROCESS | 9967 | |5;yui.html;606.5991233600231;688.6178171115035;698.9196242432122;701.214639603644;715.252561073678;11100.833487497694;11351.20541562091;11409.54361825528;11489.482973266202;11654.650360489177;11436.71408214793;11517.769644607102;11530.711732206679;11557.248778829371;11562.248453850514;636.462189449914;790.3361176611645;802.5024484819405;816.677412422093;819.610684924662;807.2049031703797;807.6607824713604;810.631162820915;811.5942028985507;812.2040400407604;847.7922908887331;850.306999795168;853.2491407561338;853.8121613245077;854.7222152800333;837.9036410812773;841.8021764885247;842.751388340441;848.4188330993289;851.1403482482675;622.4615707413101;623.663221860195;624.5877720704314;624.8063100438833;625.9280182778994;11996.340201288926;12001.099917506135;12005.579804706793;12007.699807504794;12032.217905836093;12071.939640301742;12260.632181034583;12316.876831231662;12316.876831231662;12353.444095015746;9210.217131543826;9333.113354231336;9352.158305752448;9537.618495260182;9573.28200384967;3156.4476216662224;3186.99609622968;3206.567113439679;3233.7089661930304;3235.627902791162;43423.56576434227;43435;43769.12461750779;44668.553314466764;44903.55096449059;9787.087740977548;9841.360311579725;9928.702138935843;9929.50352482373;10029.398236105857;17735.645287094445;17739.37912173068;17773.111344432727;17811.287548498174;17866.731999020027;6043.969780151071;6093.116498107838;6106.2061931948565;6111.205543279345;6289.591176573508;3343.5486209361425;3382.3573521030926;3383.5939687237196;3384.5600071990484;3413.6415676354122;2681.8524981125834;2728.2633688903884;2732.726727327291;2757.296889293217;2760.930976725598;472.42128392718644;476.16195495927417;486.45031114840714;487.98292059777737;488.53589090364295;527.6728428374432;530.4536327582596;557.3813067495078;563.1861959468611;563.8449426407689;7593.696252149963;7623.428242881695;7784.9610751945875;7854.3716502679645;8017.639206235617;464.6538328944958;564.3622706341889;566.0462121325497;568.9886202275932;570.0992431957498;3515.1036485696495;3569.7858128511853;3643.4899114124046;3669.119411341259;3726.06848287928;47420.5257947423;48021;48063.519364806605;48102.27846582304;48113.278300825514;43147.13705725868;44177.77911110424;44345.334819977725;45565.31652025222;45654.315185272244;40364.79817600952;40446.79776601098;40635.1872962545;40973.385399219034;41296.58703412987;7055.506114571931;7158.677859496231;7193.064901562763;7235.710571577289;7325;28014.439711205254;28044.29889252785;28065.719342807126;28504.144875653765;28568.57147142753;37223.44164837584;37259.44110838285;37288.25423491461;37604.435933460474;37912.81043594764;8669.6098675561;8766.649334026568;8870.73387798367;9206.815863682823;9416.435013899189;9868.309218354647;10247.38515689061;10330.741731456774;10559.472026398804;10627.787444250916;9192.862107068266;9313;9572.521373931415;9600.75998100053;9610.327277090537;8221.79445513867;8377.49735015901;8436.367272454469;8560.529170895661;8681.131886811268;8884.644614215618;9251.491167985825;10813.134949204203;10846.891531084904;10954.507047183055;8530.74407767768;8660.653573856975;8916.777080573038;8973.32700047486;9368.906310936803;8924.464532128093;9186.127317904788;9220.631174753204;9228.538573071453;9300.488473133772 13:36:56 INFO - PROCESS | 9967 | __end_tp_report 13:36:56 INFO - PROCESS | 9967 | __start_cc_report 13:36:56 INFO - PROCESS | 9967 | _x_x_mozilla_cycle_collect,388 13:36:56 INFO - PROCESS | 9967 | __end_cc_report 13:36:56 INFO - PROCESS | 9967 | __startTimestamp1461098216269__endTimestamp 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | ------- Summary: start ------- 13:36:56 INFO - PROCESS | 9967 | Number of tests: 6 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | [#0] dojo.html Cycles:165 Average:4758.65 Median:4860.10 stddev:489.40 (10.1%) stddev-sans-first:461.17 13:36:56 INFO - PROCESS | 9967 | Values: 2617.4 2684.2 2727.5 2737.9 2741.7 4766.1 4814.9 4826.0 4845.8 4874.5 4637.5 4741.4 4768.3 4865.5 4873.3 4440.1 4484.8 4537.8 4543.8 4586.6 4429.2 4547.5 4552.3 4564.5 4590.4 4310.1 4343.2 4393.9 4481.1 4541.5 4387.3 4405.5 4426.1 4436.1 4447.8 4377.3 4438.5 4443.2 4456.2 4458.6 4612.7 4674.5 4716.9 4718.0 4718.6 5123.7 5133.2 5157.5 5173.4 5189.1 5188.7 5199.0 5200.9 5210.8 5213.1 4849.2 4858.0 4858.1 4860.1 4904.1 5253.7 5279.6 5319.9 5322.1 5356.8 4842.9 5010.1 5058.2 5077.9 5095.4 5142.5 5153.2 5155.5 5164.7 5180.5 4976.4 5069.4 5123.4 5137.5 5173.9 4865.1 5032.3 5119.7 5120.3 5120.6 4446.7 4453.9 4466.5 4502.1 4503.3 3801.0 3826.3 3871.9 3887.7 3902.6 4259.8 4403.4 4437.3 4453.7 4520.6 5148.9 5151.5 5164.7 5168.7 5210.1 4433.8 4446.3 4446.5 4449.3 4450.4 4531.3 4591.7 4651.4 4718.5 4728.5 4783.9 4839.5 4848.8 4865.4 4894.6 5196.3 5206.8 5223.3 5224.8 5261.7 4689.5 4779.3 4799.5 4823.4 4826.8 5079.7 5085.8 5085.9 5109.1 5158.9 4921.7 5173.7 5180.5 5181.8 5182.1 4844.4 4893.7 4916.5 4919.2 4960.5 4989.3 4993.2 4993.2 5039.7 5042.2 4825.6 4892.4 4896.6 4905.1 4927.3 4802.6 5013.7 5043.3 5094.3 5153.0 4919.1 4934.5 4939.1 4942.0 4988.7 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | [#1] ext.html Cycles:180 Average:41027.75 Median:19159.15 stddev:70118.00 (366.0%) stddev-sans-first:70248.94 13:36:56 INFO - PROCESS | 9967 | Values: 583.3 598.1 608.1 620.5 649.2 33160.8 33948.3 34025.8 34071.7 34190.1 34576.8 35137.6 35243.0 35255.3 35259.8 7538.8 7695.3 7704.6 7709.2 7715.9 7634.9 7853.4 7902.6 7910.2 7917.0 7862.5 7868.5 7958.4 7960.3 7965.6 7778.1 7831.6 7880.7 7889.0 7930.1 7760.8 7822.6 7854.3 7867.6 7868.3 29715.6 34538.7 35311.5 35358.3 35386.1 3013.3 3044.7 3127.2 3139.2 3209.6 27454.2 27574.4 27957.9 28736.6 30249.2 3378.5 3393.6 3424.1 3489.0 3500.5 222946.0 228494.0 228581.0 228673.0 229208.0 34186.5 35289.0 57330.4 58351.0 58400.7 34056.3 34261.3 34438.3 34445.8 34664.7 12320.9 12441.3 12524.4 12556.2 12571.1 9712.1 9754.3 9769.3 9791.2 9821.8 8351.9 8421.6 8442.9 8514.8 8518.0 3277.4 3350.9 3379.6 3419.8 3430.4 900.9 928.8 937.0 957.0 1081.4 28013.4 28161.4 28245.6 28373.4 28456.7 966.2 968.4 971.4 985.9 996.3 12992.3 13423.0 13453.6 13636.4 13654.2 252977.0 256256.0 258996.0 259582.0 260379.0 47225.3 47622.5 47801.5 48037.5 48140.8 1202.9 1253.0 1263.2 1272.0 1279.9 24352.8 25453.2 25882.5 26030.5 26242.0 38843.8 39884.0 40104.0 40125.4 40272.6 306872.0 309556.0 310008.0 313191.0 314325.0 25621.2 25968.7 26084.1 26327.3 26518.9 41378.8 41496.8 41521.8 41590.0 41904.8 34890.5 35461.1 35503.6 35781.5 35792.0 34564.0 34894.7 35005.6 35035.1 35100.6 31065.8 34829.3 34906.5 35755.8 36351.6 27930.0 27976.2 28322.9 28495.4 28769.7 25253.6 26251.5 27753.3 27873.1 28178.0 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | [#2] jquery.html Cycles:180 Average:23330.26 Median:42744.07 stddev:62086.91 (145.3%) stddev-sans-first:62237.16 13:36:56 INFO - PROCESS | 9967 | Values: 377.0 390.7 393.8 397.5 402.8 13217.9 15119.6 16314.3 17363.7 17528.3 16075.5 16346.3 16603.0 16734.7 16769.2 5037.8 5146.9 5280.0 5294.5 5322.8 5186.3 5207.3 5210.3 5220.7 5224.2 5121.1 5126.6 5168.0 5178.9 5271.5 5084.3 5168.9 5193.1 5232.1 5255.9 4446.2 4650.4 4691.6 4693.8 4726.4 19925.3 20017.4 20046.4 20180.0 20420.4 2114.3 2121.8 2282.3 2339.9 2436.5 8433.8 13293.3 13393.8 13662.0 13760.2 1761.7 1806.6 1818.4 1836.6 1918.4 64555.4 66981.3 67899.7 67919.0 68421.7 10109.4 10120.4 10175.3 10243.8 10335.4 12288.0 13000.6 13951.5 13990.0 14112.6 6943.7 7133.4 7139.3 7209.7 7343.7 6811.2 6891.8 6903.2 6959.1 6974.5 4342.9 4359.5 4376.7 4455.2 4479.6 1832.2 1909.5 1911.4 1920.8 1940.9 813.4 889.0 897.5 940.2 1017.0 14771.0 16186.8 16255.7 16550.0 16592.4 870.2 883.6 894.4 933.2 957.7 8957.7 9361.3 9433.2 9515.7 9628.4 301283.0 390406.0 392383.0 393900.0 394210.0 46498.3 74881.6 83177.6 83207.6 84127.6 937.0 946.7 965.0 966.6 966.7 15358.6 15363.2 15388.5 15495.8 15980.3 25521.1 30653.7 33519.5 35130.0 36913.3 42485.4 43002.8 43439.0 43875.0 43905.8 7551.3 7610.4 7685.2 7686.8 7702.9 10361.5 11533.7 11604.9 11680.4 11784.4 5040.8 7887.5 8593.7 8698.9 10316.7 10265.9 10337.4 10363.8 10410.7 10660.1 10290.9 10673.9 10806.6 10828.8 10902.1 6917.2 7110.6 7186.7 7207.0 7224.4 9452.5 10194.4 10202.1 10349.9 10399.3 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | [#3] mootools.html Cycles:180 Average:5242.24 Median:5563.24 stddev:2900.63 (52.1%) stddev-sans-first:2894.71 13:36:56 INFO - PROCESS | 9967 | Values: 1441.8 1485.7 1638.9 1756.7 1804.6 6803.1 7387.0 7650.9 7913.9 7919.4 7455.6 7475.4 7479.5 7493.7 7509.0 2217.8 2242.4 2244.7 2246.7 2252.4 2167.8 2168.7 2198.7 2199.3 2199.9 2211.3 2222.4 2223.9 2238.9 2244.1 2145.2 2145.5 2148.5 2149.6 2157.4 2134.6 2142.9 2149.9 2158.9 2161.5 7610.4 7670.0 7700.3 7712.2 7712.3 4586.5 4664.4 4728.5 4735.8 4744.5 2847.6 2870.1 2883.1 2888.9 2993.4 922.6 932.7 955.2 959.5 970.5 10547.7 10601.5 10655.5 10687.8 10696.5 4181.7 4307.5 4356.0 4401.6 4412.0 9144.0 9161.4 9189.3 9208.5 9225.2 4706.6 4732.3 4740.1 4761.2 4762.8 3668.5 4206.5 4313.6 4319.3 4341.1 3762.6 3826.8 3878.2 3888.9 3916.3 1213.0 1290.8 1292.9 1299.9 1312.5 784.5 886.0 898.3 919.1 924.3 5549.8 5657.3 5685.3 5743.0 5823.1 886.7 912.8 926.3 936.4 969.0 3579.6 3752.4 3769.1 3789.5 3797.5 9629.9 10049.2 10049.9 10078.4 10115.1 9929.6 9939.4 9944.0 9945.6 9980.9 7110.3 7390.2 7392.8 7467.7 7484.7 5396.6 5576.7 5687.6 5709.7 5740.7 8618.3 8794.4 8983.3 9059.8 9066.8 9038.7 9082.7 9217.6 9287.8 9301.3 6122.5 6818.6 6935.4 7062.9 7079.7 7707.0 7712.7 7732.8 7758.0 7796.9 6836.5 7021.1 7080.4 7116.8 7193.5 6990.9 7008.8 7020.3 7056.5 7099.2 6449.8 6467.3 6608.0 6622.4 6643.6 4459.9 4463.4 4507.3 4578.0 4598.0 4650.0 4704.1 4745.6 4768.5 4840.0 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | [#4] prototype.html Cycles:180 Average:4618.23 Median:5319.93 stddev:1359.35 (25.6%) stddev-sans-first:1324.13 13:36:56 INFO - PROCESS | 9967 | Values: 309.0 311.4 314.7 321.9 328.1 5152.8 5259.7 5306.6 5376.4 5387.7 5305.5 5379.1 5383.7 5385.1 5393.3 4158.9 4180.6 4182.4 4187.7 4194.1 3914.7 4121.6 4184.3 4184.9 4197.4 4049.1 4085.4 4100.6 4108.5 4113.7 4085.5 4093.4 4102.7 4112.4 4114.9 3591.8 3597.1 3599.4 3600.2 3619.3 5066.1 5076.8 5126.8 5137.9 5138.3 4677.1 4689.2 4693.5 4694.4 4720.2 5578.4 5579.9 5589.8 5599.7 5629.6 3834.9 3876.2 3880.2 3900.1 3904.3 5802.3 5865.6 5876.4 5916.4 5945.4 3979.7 4001.5 4007.7 4022.2 4027.1 3937.4 4019.9 4056.4 4072.4 4080.9 4638.9 4681.5 4686.9 4697.0 4700.8 5324.4 5626.5 5649.6 5651.2 5730.3 1355.9 1377.4 1383.0 1385.3 1390.3 926.3 933.4 949.8 950.2 964.4 4802.5 4807.8 4808.9 4819.2 4823.7 5723.1 5727.5 5728.4 5744.8 5751.9 4693.2 4811.2 4813.8 4816.7 4817.9 3049.3 3081.6 3086.8 3088.2 3090.8 5315.4 5335.5 5340.3 5357.1 5381.8 5655.0 5835.2 5924.4 5926.0 5965.8 5325.5 5334.2 5347.5 5361.9 5366.8 5590.7 5721.6 5750.6 5764.4 5773.6 5656.0 5671.3 5682.5 5695.5 5715.4 5336.4 5343.8 5362.9 5363.7 5385.5 3914.1 3991.9 4009.8 4009.9 4010.7 5513.5 5680.6 5699.1 5735.7 5737.5 5455.8 5645.5 5660.3 5669.3 5685.1 5534.3 5602.4 5602.8 5608.2 5613.3 5315.3 5501.0 5540.6 5564.0 5583.6 5675.7 5689.6 5698.7 5724.1 5738.9 5470.8 5567.2 5576.4 5584.8 5593.6 13:36:56 INFO - PROCESS | 9967 | 13:36:56 INFO - PROCESS | 9967 | [#5] yui.html Cycles:180 Average:12025.78 Median:543.92 stddev:13734.82 (2525.2%) stddev-sans-first:13746.58 13:36:56 INFO - PROCESS | 9967 | Values: 606.6 688.6 698.9 701.2 715.3 11100.8 11351.2 11409.5 11489.5 11654.7 11436.7 11517.8 11530.7 11557.2 11562.2 636.5 790.3 802.5 816.7 819.6 807.2 807.7 810.6 811.6 812.2 847.8 850.3 853.2 853.8 854.7 837.9 841.8 842.8 848.4 851.1 622.5 623.7 624.6 624.8 625.9 11996.3 12001.1 12005.6 12007.7 12032.2 12071.9 12260.6 12316.9 12316.9 12353.4 9210.2 9333.1 9352.2 9537.6 9573.3 3156.4 3187.0 3206.6 3233.7 3235.6 43423.6 43435.0 43769.1 44668.6 44903.6 9787.1 9841.4 9928.7 9929.5 10029.4 17735.6 17739.4 17773.1 17811.3 17866.7 6044.0 6093.1 6106.2 6111.2 6289.6 3343.5 3382.4 3383.6 3384.6 3413.6 2681.9 2728.3 2732.7 2757.3 2760.9 472.4 476.2 486.5 488.0 488.5 527.7 530.5 557.4 563.2 563.8 7593.7 7623.4 7785.0 7854.4 8017.6 464.7 564.4 566.0 569.0 570.1 3515.1 3569.8 3643.5 3669.1 3726.1 47420.5 48021.0 48063.5 48102.3 48113.3 43147.1 44177.8 44345.3 45565.3 45654.3 40364.8 40446.8 40635.2 40973.4 41296.6 7055.5 7158.7 7193.1 7235.7 7325.0 28014.4 28044.3 28065.7 28504.1 28568.6 37223.4 37259.4 37288.3 37604.4 37912.8 8669.6 8766.6 8870.7 9206.8 9416.4 9868.3 10247.4 10330.7 10559.5 10627.8 9192.9 9313.0 9572.5 9600.8 9610.3 8221.8 8377.5 8436.4 8560.5 8681.1 8884.6 9251.5 10813.1 10846.9 10954.5 8530.7 8660.7 8916.8 8973.3 9368.9 8924.5 9186.1 9220.6 9228.5 9300.5 13:36:56 INFO - PROCESS | 9967 | -------- Summary: end -------- 13:36:56 INFO - PROCESS | 9967 | 13:36:57 INFO - TEST-INFO | 9967: exit 0 13:36:57 INFO - TEST-OK | dromaeo_css | took 1114911ms 13:36:57 INFO - TEST-START | kraken 13:36:57 INFO - operating with platform_type : linux_ 13:36:57 INFO - Initialising browser for kraken test... 13:36:57 INFO - TEST-INFO | started process 10198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBj_6o_/profile http://localhost:37974/getInfo.html) 13:37:00 INFO - PROCESS | 10198 | 13:37:00 INFO - PROCESS | 10198 | (process:10264): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:37:01 INFO - PROCESS | 10198 | __metrics Screen width/height:1600/1200 13:37:01 INFO - PROCESS | 10198 | colorDepth:24 13:37:01 INFO - PROCESS | 10198 | Browser inner width/height: 1024/697 13:37:01 INFO - PROCESS | 10198 | __metrics 13:37:01 ERROR - PROCESS | 10198 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:37:02 INFO - TEST-INFO | 10198: exit 0 13:37:02 INFO - Browser initialized. 13:37:02 INFO - Running cycle 1/1 for kraken test... 13:37:02 INFO - TEST-INFO | started process 10315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBj_6o_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:04 INFO - PROCESS | 10315 | 13:37:04 INFO - PROCESS | 10315 | (process:10374): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:37:14 INFO - PROCESS | 10315 | RSS: Main: 164798464 13:37:14 INFO - PROCESS | 10315 | 13:37:17 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37974/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:18 INFO - PROCESS | 10315 | RSS: Main: 169414656 13:37:18 INFO - PROCESS | 10315 | 13:37:21 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37974/tests/kraken/driver.html?testName=audio-dft) 13:37:21 INFO - PROCESS | 10315 | RSS: Main: 172597248 13:37:21 INFO - PROCESS | 10315 | 13:37:24 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37974/tests/kraken/driver.html?testName=audio-fft) 13:37:25 INFO - PROCESS | 10315 | RSS: Main: 163393536 13:37:25 INFO - PROCESS | 10315 | 13:37:27 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37974/tests/kraken/driver.html?testName=audio-oscillator) 13:37:27 INFO - PROCESS | 10315 | RSS: Main: 163004416 13:37:27 INFO - PROCESS | 10315 | 13:37:30 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:30 INFO - PROCESS | 10315 | RSS: Main: 164589568 13:37:30 INFO - PROCESS | 10315 | 13:37:33 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37974/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:34 INFO - PROCESS | 10315 | RSS: Main: 164712448 13:37:34 INFO - PROCESS | 10315 | 13:37:38 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37974/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:38 INFO - PROCESS | 10315 | RSS: Main: 164118528 13:37:38 INFO - PROCESS | 10315 | 13:37:41 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37974/tests/kraken/driver.html?testName=json-parse-financial) 13:37:42 INFO - PROCESS | 10315 | RSS: Main: 164864000 13:37:42 INFO - PROCESS | 10315 | 13:37:43 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:44 INFO - PROCESS | 10315 | RSS: Main: 164704256 13:37:44 INFO - PROCESS | 10315 | 13:37:46 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:47 INFO - PROCESS | 10315 | RSS: Main: 165163008 13:37:47 INFO - PROCESS | 10315 | 13:37:49 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:50 INFO - PROCESS | 10315 | RSS: Main: 165441536 13:37:50 INFO - PROCESS | 10315 | 13:37:52 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:53 INFO - PROCESS | 10315 | RSS: Main: 165896192 13:37:53 INFO - PROCESS | 10315 | 13:37:56 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:57 INFO - PROCESS | 10315 | RSS: Main: 165810176 13:37:57 INFO - PROCESS | 10315 | 13:37:58 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:37974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37974/tests/kraken/driver.html?testName=ai-astar) 13:37:59 INFO - PROCESS | 10315 | RSS: Main: 167260160 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | __start_tp_report 13:37:59 INFO - PROCESS | 10315 | _x_x_mozilla_page_load 13:37:59 INFO - PROCESS | 10315 | _x_x_mozilla_page_load_details 13:37:59 INFO - PROCESS | 10315 | |i|pagename|runs| 13:37:59 INFO - PROCESS | 10315 | |0;ai-astar;114;108;113;112;113;124;113;113;112;113 13:37:59 INFO - PROCESS | 10315 | |1;audio-beat-detection;156;134;157;180;135;166;159;135;189;141 13:37:59 INFO - PROCESS | 10315 | |2;audio-dft;161;161;162;166;168;163;162;163;166;162 13:37:59 INFO - PROCESS | 10315 | |3;audio-fft;74;77;75;160;76;75;74;76;154;79 13:37:59 INFO - PROCESS | 10315 | |4;audio-oscillator;94;94;138;95;95;94;141;93;95;135 13:37:59 INFO - PROCESS | 10315 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;118;120;118 13:37:59 INFO - PROCESS | 10315 | |6;imaging-darkroom;147;147;147;146;146;148;147;146;146;147 13:37:59 INFO - PROCESS | 10315 | |7;imaging-desaturate;95;96;96;95;96;95;95;96;96;95 13:37:59 INFO - PROCESS | 10315 | |8;json-parse-financial;65;66;66;72;69;65;66;67;65;70 13:37:59 INFO - PROCESS | 10315 | |9;json-stringify-tinderbox;65;64;65;65;64;66;69;65;64;64 13:37:59 INFO - PROCESS | 10315 | |10;stanford-crypto-aes;80;79;90;79;80;81;81;80;122;89 13:37:59 INFO - PROCESS | 10315 | |11;stanford-crypto-ccm;140;142;136;137;135;141;145;141;139;136 13:37:59 INFO - PROCESS | 10315 | |12;stanford-crypto-pbkdf2;176;176;183;173;180;176;175;174;176;177 13:37:59 INFO - PROCESS | 10315 | |13;stanford-crypto-sha256-iterative;74;74;74;75;74;72;73;74;78;72 13:37:59 INFO - PROCESS | 10315 | __end_tp_report 13:37:59 INFO - PROCESS | 10315 | __start_cc_report 13:37:59 INFO - PROCESS | 10315 | _x_x_mozilla_cycle_collect,917 13:37:59 INFO - PROCESS | 10315 | __end_cc_report 13:37:59 INFO - PROCESS | 10315 | __startTimestamp1461098279072__endTimestamp 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | ------- Summary: start ------- 13:37:59 INFO - PROCESS | 10315 | Number of tests: 14 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.03 (3.6%) stddev-sans-first:4.28 13:37:59 INFO - PROCESS | 10315 | Values: 114.0 108.0 113.0 112.0 113.0 124.0 113.0 113.0 112.0 113.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:158.00 stddev:19.32 (12.2%) stddev-sans-first:20.49 13:37:59 INFO - PROCESS | 10315 | Values: 156.0 134.0 157.0 180.0 135.0 166.0 159.0 135.0 189.0 141.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.41 (1.5%) stddev-sans-first:2.40 13:37:59 INFO - PROCESS | 10315 | Values: 161.0 161.0 162.0 166.0 168.0 163.0 162.0 163.0 166.0 162.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:34.32 (45.5%) stddev-sans-first:35.78 13:37:59 INFO - PROCESS | 10315 | Values: 74.0 77.0 75.0 160.0 76.0 75.0 74.0 76.0 154.0 79.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.17 (22.5%) stddev-sans-first:21.89 13:37:59 INFO - PROCESS | 10315 | Values: 94.0 94.0 138.0 95.0 95.0 94.0 141.0 93.0 95.0 135.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 13:37:59 INFO - PROCESS | 10315 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 120.0 118.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:37:59 INFO - PROCESS | 10315 | Values: 147.0 147.0 147.0 146.0 146.0 148.0 147.0 146.0 146.0 147.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:37:59 INFO - PROCESS | 10315 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.50 stddev:2.42 (3.6%) stddev-sans-first:2.45 13:37:59 INFO - PROCESS | 10315 | Values: 65.0 66.0 66.0 72.0 69.0 65.0 66.0 67.0 65.0 70.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 13:37:59 INFO - PROCESS | 10315 | Values: 65.0 64.0 65.0 65.0 64.0 66.0 69.0 65.0 64.0 64.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:80.50 stddev:13.24 (16.4%) stddev-sans-first:13.85 13:37:59 INFO - PROCESS | 10315 | Values: 80.0 79.0 90.0 79.0 80.0 81.0 81.0 80.0 122.0 89.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:140.50 stddev:3.19 (2.3%) stddev-sans-first:3.37 13:37:59 INFO - PROCESS | 10315 | Values: 140.0 142.0 136.0 137.0 135.0 141.0 145.0 141.0 139.0 136.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:176.00 stddev:2.91 (1.7%) stddev-sans-first:3.08 13:37:59 INFO - PROCESS | 10315 | Values: 176.0 176.0 183.0 173.0 180.0 176.0 175.0 174.0 176.0 177.0 13:37:59 INFO - PROCESS | 10315 | 13:37:59 INFO - PROCESS | 10315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:1.70 (2.3%) stddev-sans-first:1.80 13:37:59 INFO - PROCESS | 10315 | Values: 74.0 74.0 74.0 75.0 74.0 72.0 73.0 74.0 78.0 72.0 13:37:59 INFO - PROCESS | 10315 | -------- Summary: end -------- 13:37:59 INFO - PROCESS | 10315 | 13:38:00 INFO - TEST-INFO | 10315: exit 0 13:38:00 INFO - TEST-OK | kraken | took 63054ms 13:38:00 INFO - SUITE-END | took 1177s 13:38:00 INFO - Completed test suite (00:19:38) 13:38:00 INFO - javascript benchmark 13:38:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.4110825064363, 2684.2081585932156, 2727.481778462093, 2737.904173353933, 2741.6984131745503, 4766.118268120395, 4814.855554333371, 4826.0, 4845.757712114393, 4874.46380898101, 4637.536246375361, 4741.383620129387, 4768.284757286408, 4865.48912364202, 4873.293372460991, 4440.134173836095, 4484.753338566377, 4537.795799189028, 4543.7955292011775, 4586.587207151356, 4429.202743506184, 4547.522510136421, 4552.2943943688615, 4564.497905230422, 4590.449146102455, 4310.051788606533, 4343.2182207202695, 4393.934090988638, 4481.1037792441475, 4541.45502539694, 4387.298032314814, 4405.471343438808, 4426.114777044604, 4436.112777444524, 4447.822087116511, 4377.321515165155, 4438.511763705989, 4443.244648409778, 4456.22016147173, 4458.576435238647, 4612.654050946159, 4674.509176536482, 4716.9292460613115, 4718.0, 4718.62251019921, 5123.666961647481, 5133.204353325241, 5157.510036546522, 5173.405058418292, 5189.091908915924, 5188.740562971836, 5199.0, 5200.92198617021, 5210.843674689765, 5213.087709650796, 4849.248366503198, 4857.951420485821, 4858.05267972742, 4860.1008813368935, 4904.092742842586, 5253.737313134328, 5279.577633789365, 5319.946800532022, 5322.148456246982, 5356.812511562077, 4842.854714358575, 5010.073136469765, 5058.215976523645, 5077.8730531737, 5095.363079615048, 5142.537171654569, 5153.175491921274, 5155.458676838878, 5164.715940623227, 5180.48195180479, 4976.402831660152, 5069.366329208849, 5123.359580052494, 5137.51193636604, 5173.922391164136, 4865.0999565079865, 5032.270320803536, 5119.667221630582, 5120.308758317579, 5120.61595380348, 4446.666500012448, 4453.888652783707, 4466.486354069324, 4502.077074199847, 4503.324501324828, 3800.9809950950066, 3826.330392181357, 3871.903202419962, 3887.7084218683713, 3902.551206611219, 4259.765712885821, 4403.427554417969, 4437.267850804581, 4453.732776033448, 4520.61574766142, 5148.9485105149215, 5151.5363617274625, 5164.7417629119145, 5168.689878607221, 5210.088234559013, 4433.800478978454, 4446.3330500424545, 4446.510883802779, 4449.28811390176, 4450.354698568754, 4531.320301954733, 4591.747453890001, 4651.3720647712125, 4718.457377401574, 4728.4562275338085, 4783.928241076456, 4839.467658557626, 4848.781804818792, 4865.391826021677, 4894.583960363409, 5196.272521846869, 5206.765695543634, 5223.3209682741, 5224.843254702365, 5261.710605916712, 4689.507601701908, 4779.283107533759, 4799.520047995173, 4823.445303790109, 4826.831060912851, 5079.746012699424, 5085.847424577269, 5085.923711144262, 5109.105906466428, 5158.922616160836, 4921.655484116221, 5173.689578625294, 5180.48195180479, 5181.766820493011, 5182.093133701663, 4844.442889067662, 4893.7063776173545, 4916.483769204182, 4919.237518184687, 4960.454350021567, 4989.326440930428, 4993.15116430215, 4993.201087825931, 5039.697618142924, 5042.243663450365, 4825.5898248649255, 4892.363992680928, 4896.583790377716, 4905.117078925828, 4927.28554359623, 4802.567768900815, 5013.699178049329, 5043.344365232496, 5094.261332106749, 5152.995165942605, 4919.0899683558655, 4934.481879402754, 4939.110960027086, 4942.0, 4988.653063672716], "value": 4728.070898187274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2796496327036, 598.117776279987, 608.1425190481422, 620.5004970998348, 649.2047242128397, 33160.83419582905, 33948.32103357931, 34025.82987085067, 34071.65928340719, 34190.14524636879, 34576.82711586445, 35137.64862351382, 35242.999999999935, 35255.2948941021, 35259.82370088153, 7538.81152971176, 7695.345895598881, 7704.576248306369, 7709.229077092274, 7715.922840771605, 7634.923650763477, 7853.410994175431, 7902.6048697565175, 7910.169432209622, 7917.049954005527, 7862.488938219026, 7868.527888326718, 7958.4031197660115, 7960.283574478296, 7965.561894095822, 7778.066632004139, 7831.6475758591005, 7880.724174653888, 7889.0, 7930.1276859545405, 7760.844783104306, 7822.569758663271, 7854.332381747558, 7867.567283799389, 7868.291853733134, 29715.554266686016, 34538.65461345379, 35311.4703279451, 35358.292834143176, 35386.11534711627, 3013.3069394039276, 3044.6955304469375, 3127.2437175907367, 3139.199504126456, 3209.630892447375, 27454.17637470859, 27574.448511029666, 27957.86021069902, 28736.568951465746, 30249.243768905733, 3378.4932260160926, 3393.592768867727, 3424.143964008998, 3488.988193423904, 3500.492428597839, 222946.0, 228493.99999999834, 228581.0, 228673.0, 229208.0, 34186.48720269198, 35289.0, 57330.426695733346, 58351.0, 58400.70799645974, 34056.31887362239, 34261.314773704886, 34438.31123377518, 34445.82777086098, 34664.65335346614, 12320.938395308145, 12441.253524788543, 12524.373781310898, 12556.183848049848, 12571.120021598583, 9712.077352651488, 9754.268429867789, 9769.31614786958, 9791.216702663769, 9821.754456138511, 8351.874721879176, 8421.621027053798, 8442.873356899652, 8514.787130321667, 8517.95741021291, 3277.4428347181038, 3350.8994730158133, 3379.5944486661756, 3419.8461069251944, 3430.3996800560303, 900.9009009009004, 928.7538802217417, 937.0395344771528, 956.9856452153223, 1081.3565928272665, 28013.43973120526, 28161.43677126446, 28245.60176628667, 28373.43253134926, 28456.71543284582, 966.1932286540676, 968.3802366485455, 971.4414211828228, 985.9063388978036, 996.2976101848179, 12992.285424301754, 13423.0, 13453.596392108253, 13636.386362613706, 13654.249016304, 252977.0, 256256.0, 258996.0, 259582.0, 260379.0, 47225.29162062572, 47622.5237747625, 47801.521984780404, 48037.5196248033, 48140.759296203294, 1202.9218100823418, 1253.0, 1263.2041813657338, 1272.0459655258555, 1279.8848103670714, 24352.756472435758, 25453.236402907944, 25882.482350353264, 26030.479390412464, 26242.0, 38843.80578097204, 39884.0, 40104.0, 40125.39811902765, 40272.597274026884, 306872.0, 309556.0, 310008.0, 313191.0, 314325.0, 25621.231363059138, 25968.740312596634, 26084.087056952914, 26327.34181645474, 26518.867405662848, 41378.793106034274, 41496.792516037225, 41521.79239103785, 41590.0, 41904.79047604743, 34890.47664285089, 35461.1134721634, 35503.644963551065, 35781.46327805033, 35792.0, 34564.0, 34894.65105348914, 35005.64994350024, 35035.124121897155, 35100.64899350974, 31065.8446707765, 34829.30341393209, 34906.47640285347, 35755.821220893726, 36351.63648363482, 27930.0, 27976.160715178576, 28322.858385708765, 28495.43009139847, 28769.712302876702, 25253.621195682448, 26251.474970500865, 27753.306167345978, 27873.050670120585, 28178.0], "value": 15910.73571091383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9746290090952, 390.7245391998641, 393.8168751530538, 397.4852565927124, 402.75633241888676, 13217.867821321785, 15119.62200944977, 16314.265858036388, 17363.65272694547, 17528.29886804526, 16075.517734467956, 16346.34614615414, 16603.0, 16734.74897876533, 16769.24538395772, 5037.848864534069, 5146.897062058747, 5279.973600132013, 5294.523492885659, 5322.8137015204475, 5186.273921650972, 5207.3490813648295, 5210.270562121306, 5220.712860792655, 5224.190250511177, 5121.052605268019, 5126.641135120543, 5167.992241512907, 5178.8705282368055, 5271.472852714717, 5084.288199652052, 5168.8966220675375, 5193.1171700810955, 5232.136697444917, 5255.947440525603, 4446.199684056868, 4650.4186976627925, 4691.62467002639, 4693.7653117344, 4726.409198850144, 19925.302614408425, 20017.399478015537, 20046.39860804178, 20180.0, 20420.38738837837, 2114.270576651053, 2121.7984291492285, 2282.349530383849, 2339.9470238392623, 2436.5248776488593, 8433.789155271106, 13293.268870212134, 13393.799093013613, 13662.0, 13760.17438953666, 1761.7005109131478, 1806.5664240582298, 1818.4362847517311, 1836.5867679772077, 1918.4052943587533, 64555.35444645587, 66981.330186698, 67899.66050169767, 67919.0, 68421.65789171022, 10109.39343639384, 10120.443375614412, 10175.338602990782, 10243.84634230487, 10335.379877207391, 12288.0, 13000.609981700563, 13951.511697090757, 13990.0, 14112.647183820487, 6943.722251109899, 7133.393661538724, 7139.32176443237, 7209.711611535585, 7343.742968996059, 6811.216710078305, 6891.793246202622, 6903.171619405603, 6959.130108736408, 6974.511784175059, 4342.934855977162, 4359.520452750195, 4376.737395756265, 4455.220336441174, 4479.641628669699, 1832.2029916986153, 1909.5226193451638, 1911.3788018893638, 1920.817522335404, 1940.8835469871854, 813.3940214540205, 888.9911100889037, 897.4749771383683, 940.2290122099812, 1016.974575635615, 14771.0, 16186.75719864203, 16255.674886502204, 16550.0, 16592.419265325898, 870.1646419437285, 883.6067949762294, 894.3515950935649, 933.2394098809449, 957.6887511558771, 8957.686480973265, 9361.34470587066, 9433.198178154933, 9515.666951656658, 9628.374155679858, 301283.0, 390406.0, 392383.0, 393900.0, 394210.0, 46498.302525462146, 74881.62559187278, 83177.58411207906, 83207.5839620798, 84127.5793621028, 936.9718908432758, 946.7443790176613, 964.9614015439445, 966.6278482784179, 966.7293157915794, 15358.616034599225, 15363.23183840826, 15388.461403850812, 15495.84504154944, 15980.28088736033, 25521.106761263265, 30653.693463065083, 33519.497207542394, 35130.0, 36913.26173476569, 42485.362719558616, 43002.78498607487, 43439.0, 43875.0, 43905.78047109744, 7551.282628150317, 7610.391168706379, 7685.193054729173, 7686.846263074819, 7702.884456733042, 10361.481925903523, 11533.711657208636, 11604.88395116038, 11680.415979200836, 11784.351860647404, 5040.84877453677, 7887.487313324616, 8593.667981462882, 8698.869516957124, 10316.658834351487, 10265.897341026794, 10337.431441270803, 10363.792724145625, 10410.68767936963, 10660.147188224768, 10290.897091028994, 10673.89326106729, 10806.621768238074, 10828.783424331627, 10902.127829773757, 6917.204521480095, 7110.6089165094345, 7186.676599553137, 7206.963965180141, 7224.422046236184, 9452.527373631428, 10194.43930583825, 10202.132818710195, 10349.896501034893, 10399.32404393712], "value": 8126.573009314434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.7621092519735, 1485.665725211827, 1638.8770842186839, 1756.7452719355701, 1804.630050839578, 6803.115594972659, 7387.0, 7650.923490765091, 7913.920860791398, 7919.406044546653, 7455.55266683998, 7475.401967842573, 7479.5138316009425, 7493.662785174666, 7508.9624551877305, 2217.7782221777857, 2242.372135801978, 2244.6857439958417, 2246.73039235292, 2252.3805953362876, 2167.7832216778274, 2168.6638571021517, 2198.736151661795, 2199.25225423356, 2199.9340019799433, 2211.292386436341, 2222.3666255117296, 2223.866568005925, 2238.8992495337748, 2244.102359056374, 2145.1526646974357, 2145.4529095080734, 2148.5380643161716, 2149.634562124427, 2157.3851452336166, 2134.5944270588693, 2142.85000049995, 2149.9462513437134, 2158.924437644675, 2161.5460753241837, 7610.39116870649, 7669.9616501917135, 7700.345470635003, 7712.228777122243, 7712.267334603203, 4586.54134586542, 4664.39362882823, 4728.527147285278, 4735.763211839429, 4744.454387745419, 2847.5870998705277, 2870.1102658176032, 2883.1206482022976, 2888.8988885388912, 2993.4462124507036, 922.5894476957757, 932.6689025395955, 955.1833182628822, 959.5154447004218, 970.5147426286857, 10547.73630659232, 10601.469926503643, 10655.52050157737, 10687.786244275148, 10696.465176741132, 4181.665466762652, 4307.483102027777, 4355.956440435555, 4401.559844015573, 4411.977940110343, 9144.039875813078, 9161.404508706913, 9189.3108016899, 9208.493532855624, 9225.169734723908, 4706.647001474903, 4732.266498692708, 4740.1230772307235, 4761.190597598416, 4762.809487620526, 3668.486411902336, 4206.47419072616, 4313.568643135662, 4319.287317592562, 4341.088371442032, 3762.5673047599876, 3826.827792749333, 3878.166194268246, 3888.922221555553, 3916.3146449371816, 1212.969675758113, 1290.7934730443085, 1292.915960462567, 1299.8960083193322, 1312.527490103562, 784.4940013691137, 886.0, 898.3127907151035, 919.103873723128, 924.2744445610164, 5549.750261238173, 5657.2928383952, 5685.289338832646, 5742.971285143548, 5823.068309070529, 886.738412168399, 912.7854954085917, 926.342296969146, 936.4474959773767, 969.0, 3579.6241394653707, 3752.399616061417, 3769.1142581493327, 3789.5263092113487, 3797.487339209227, 9629.903700962901, 10049.24630652704, 10049.899501005042, 10078.395296282246, 10115.140213081824, 9929.602815887283, 9939.353941993892, 9944.0, 9945.552450139761, 9980.900190997998, 7110.253423390573, 7390.187079421259, 7392.815179620553, 7467.701291948261, 7484.738034168778, 5396.568274538106, 5576.721163941867, 5687.601867869375, 5709.714514274353, 5740.68426236561, 8618.267447267053, 8794.384393092421, 8983.281337492854, 9059.818803624023, 9066.773330666787, 9038.728838134866, 9082.682106126254, 9217.631294748135, 9287.814243715224, 9301.302402319718, 6122.479589234965, 6818.62497562619, 6935.445164386736, 7062.929370706227, 7079.68141433647, 7707.0, 7712.730054448068, 7732.806679833049, 7758.0, 7796.9220307796195, 6836.5214434989075, 7021.087258656342, 7080.362767350963, 7116.822079448055, 7193.496455248082, 6990.860182796418, 7008.789736307919, 7020.333068358498, 7056.54132481387, 7099.183593886769, 6449.806505804833, 6467.320931302145, 6608.0087986800445, 6622.37087476689, 6643.634600097041, 4459.888502787457, 4463.4420697412825, 4507.323901414814, 4578.0, 4598.0, 4650.0, 4704.129735998714, 4745.5966242869745, 4768.523147685204, 4839.951600484091], "value": 4246.854641633726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.9938201235975, 311.38346074771965, 314.6711686287829, 321.9179109327121, 328.0552010210593, 5152.819651312205, 5259.658122222053, 5306.575473962083, 5376.435474275204, 5387.676739395634, 5305.469453054702, 5379.139337705968, 5383.67697938124, 5385.138377859544, 5393.325834270716, 4158.875233742985, 4180.6237438630515, 4182.414461975311, 4187.72779769314, 4194.119234960662, 3914.6868250540033, 4121.608447197512, 4184.28867092595, 4184.874453766377, 4197.433346498215, 4049.129437171008, 4085.428040074377, 4100.56944020878, 4108.50697916249, 4113.670906327487, 4085.530164031115, 4093.406456063869, 4102.712810103294, 4112.444819949298, 4114.855980040714, 3591.838367273479, 3597.1007248187952, 3599.42409214527, 3600.207954250061, 3619.2580520993133, 5066.113430149746, 5076.771545280471, 5126.820561280375, 5137.893463679873, 5138.306328645623, 4677.064587082597, 4689.155951928651, 4693.460252071021, 4694.413198350207, 4720.150372932871, 5578.44215578443, 5579.944200558024, 5589.776408943678, 5599.7480113394995, 5629.605927585029, 3834.9424758628643, 3876.205377897524, 3880.2433525462548, 3900.1029763154634, 3904.2777086239134, 5802.332731735863, 5865.589408741347, 5876.353601103875, 5916.378780228057, 5945.40545945402, 3979.721419500665, 4001.4998125234347, 4007.6593489553716, 4022.1955608878343, 4027.060246020363, 3937.448757173998, 4019.9196016079513, 4056.350983842571, 4072.3687828386646, 4080.8775736727353, 4638.8608341749805, 4681.485036645966, 4686.922007938193, 4696.976515117402, 4700.835470758576, 5324.440933701983, 5626.493615574536, 5649.576281778883, 5651.237082993825, 5730.3410107838135, 1355.9389827457787, 1377.373295150724, 1383.018057179414, 1385.3142694366152, 1390.2701081932066, 926.2682480840061, 933.3653115881131, 949.8480243161061, 950.1733491862125, 964.3538828984597, 4802.543758342952, 4807.759612019385, 4808.903821923542, 4819.156647586658, 4823.686460380064, 5723.141528770718, 5727.4845263926445, 5728.427157284238, 5744.798932037359, 5751.884962300731, 4693.225617773098, 4811.206150985118, 4813.820613949605, 4816.735079570587, 4817.855464336076, 3049.3139043714987, 3081.568580398746, 3086.768492363082, 3088.243380371823, 3090.8454577271045, 5315.415304316522, 5335.5464785492895, 5340.332458442695, 5357.08929481989, 5381.838544843661, 5654.953833540808, 5835.241418615553, 5924.407559244128, 5925.992581261196, 5965.7613695452565, 5325.467453254643, 5334.1732031535175, 5347.465253474621, 5361.946380536223, 5366.812161574404, 5590.748416321194, 5721.6280941740315, 5750.568707347049, 5764.394738552392, 5773.624714393719, 5655.953648575027, 5671.285308123186, 5682.488576028178, 5695.544356451391, 5715.371309156073, 5336.359636843604, 5343.78624855017, 5362.900605375967, 5363.731813409392, 5385.542228910586, 3914.099757055836, 3991.880243592697, 4009.8195581198333, 4009.9398509021803, 4010.6991975601363, 5513.531349835309, 5680.630759000652, 5699.088145896637, 5735.741891614971, 5737.512311453574, 5455.754491047992, 5645.491905728504, 5660.32076150848, 5669.31968163823, 5685.147227915846, 5534.335879694301, 5602.3837377887585, 5602.775888964559, 5608.158776183605, 5613.270274864405, 5315.282436870973, 5500.964643082085, 5540.63985840919, 5564.0, 5583.637063590853, 5675.7445914933105, 5689.573282003784, 5698.715064246854, 5724.141378793214, 5738.942610573841, 5470.8085217017215, 5567.192757050286, 5576.358718747396, 5584.832455026356, 5593.608447408642], "value": 4182.10946571069, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.5991233600231, 688.6178171115035, 698.9196242432122, 701.214639603644, 715.252561073678, 11100.833487497694, 11351.20541562091, 11409.54361825528, 11489.482973266202, 11654.650360489177, 11436.71408214793, 11517.769644607102, 11530.711732206679, 11557.248778829371, 11562.248453850514, 636.462189449914, 790.3361176611645, 802.5024484819405, 816.677412422093, 819.610684924662, 807.2049031703797, 807.6607824713604, 810.631162820915, 811.5942028985507, 812.2040400407604, 847.7922908887331, 850.306999795168, 853.2491407561338, 853.8121613245077, 854.7222152800333, 837.9036410812773, 841.8021764885247, 842.751388340441, 848.4188330993289, 851.1403482482675, 622.4615707413101, 623.663221860195, 624.5877720704314, 624.8063100438833, 625.9280182778994, 11996.340201288926, 12001.099917506135, 12005.579804706793, 12007.699807504794, 12032.217905836093, 12071.939640301742, 12260.632181034583, 12316.876831231662, 12316.876831231662, 12353.444095015746, 9210.217131543826, 9333.113354231336, 9352.158305752448, 9537.618495260182, 9573.28200384967, 3156.4476216662224, 3186.99609622968, 3206.567113439679, 3233.7089661930304, 3235.627902791162, 43423.56576434227, 43435.0, 43769.12461750779, 44668.553314466764, 44903.55096449059, 9787.087740977548, 9841.360311579725, 9928.702138935843, 9929.50352482373, 10029.398236105857, 17735.645287094445, 17739.37912173068, 17773.111344432727, 17811.287548498174, 17866.731999020027, 6043.969780151071, 6093.116498107838, 6106.2061931948565, 6111.205543279345, 6289.591176573508, 3343.5486209361425, 3382.3573521030926, 3383.5939687237196, 3384.5600071990484, 3413.6415676354122, 2681.8524981125834, 2728.2633688903884, 2732.726727327291, 2757.296889293217, 2760.930976725598, 472.42128392718644, 476.16195495927417, 486.45031114840714, 487.98292059777737, 488.53589090364295, 527.6728428374432, 530.4536327582596, 557.3813067495078, 563.1861959468611, 563.8449426407689, 7593.696252149963, 7623.428242881695, 7784.9610751945875, 7854.3716502679645, 8017.639206235617, 464.6538328944958, 564.3622706341889, 566.0462121325497, 568.9886202275932, 570.0992431957498, 3515.1036485696495, 3569.7858128511853, 3643.4899114124046, 3669.119411341259, 3726.06848287928, 47420.5257947423, 48021.0, 48063.519364806605, 48102.27846582304, 48113.278300825514, 43147.13705725868, 44177.77911110424, 44345.334819977725, 45565.31652025222, 45654.315185272244, 40364.79817600952, 40446.79776601098, 40635.1872962545, 40973.385399219034, 41296.58703412987, 7055.506114571931, 7158.677859496231, 7193.064901562763, 7235.710571577289, 7325.0, 28014.439711205254, 28044.29889252785, 28065.719342807126, 28504.144875653765, 28568.57147142753, 37223.44164837584, 37259.44110838285, 37288.25423491461, 37604.435933460474, 37912.81043594764, 8669.6098675561, 8766.649334026568, 8870.73387798367, 9206.815863682823, 9416.435013899189, 9868.309218354647, 10247.38515689061, 10330.741731456774, 10559.472026398804, 10627.787444250916, 9192.862107068266, 9313.0, 9572.521373931415, 9600.75998100053, 9610.327277090537, 8221.79445513867, 8377.49735015901, 8436.367272454469, 8560.529170895661, 8681.131886811268, 8884.644614215618, 9251.491167985825, 10813.134949204203, 10846.891531084904, 10954.507047183055, 8530.74407767768, 8660.653573856975, 8916.777080573038, 8973.32700047486, 9368.906310936803, 8924.464532128093, 9186.127317904788, 9220.631174753204, 9228.538573071453, 9300.488473133772], "value": 5593.067773588666, "unit": "score"}], "name": "dromaeo_css", "value": 6269.591030473064, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 112.0, 113.0, 124.0, 113.0, 113.0, 112.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 157.0, 180.0, 135.0, 166.0, 159.0, 135.0, 189.0, 141.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 166.0, 168.0, 163.0, 162.0, 163.0, 166.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 160.0, 76.0, 75.0, 74.0, 76.0, 154.0, 79.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 138.0, 95.0, 95.0, 94.0, 141.0, 93.0, 95.0, 135.0], "value": 107.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 120.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 72.0, 69.0, 65.0, 66.0, 67.0, 65.0, 70.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 64.0, 66.0, 69.0, 65.0, 64.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 90.0, 79.0, 80.0, 81.0, 81.0, 80.0, 122.0, 89.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 136.0, 137.0, 135.0, 141.0, 145.0, 141.0, 139.0, 136.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 183.0, 173.0, 180.0, 176.0, 175.0, 174.0, 176.0, 177.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 74.0, 72.0, 73.0, 74.0, 78.0, 72.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1599.5999999999997, "alertThreshold": 2.0}]} 13:38:00 INFO - Return code: 0 13:38:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:38:00 ERROR - # TBPL SUCCESS # 13:38:00 INFO - Running post-action listener: _resource_record_post_action 13:38:00 INFO - Running post-run listener: _resource_record_post_run 13:38:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520155136; Read time: 4; Write time: 644040 13:38:01 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240373760; Read time: 0; Write time: 353460 13:38:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279781376; Read time: 4; Write time: 290580 13:38:01 INFO - Running post-run listener: _upload_blobber_files 13:38:01 INFO - Blob upload gear active. 13:38:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:01 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 13:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:38:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:02 INFO - (blobuploader) - INFO - Done attempting. 13:38:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:38:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:03 INFO - (blobuploader) - INFO - Done attempting. 13:38:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:03 INFO - Return code: 0 13:38:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3598008ae5d03875cca6644db195849b06cc658d1620bf06cfa7d92822c92fb8031aec4197dcd226db932187b7760ef9a7c1d743e24b4a2f89bd51c924165018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82208b13cc47de43caef2b9c73f44ed212e1f6012f499c285070826e41a46688e434a25b1d2ecfb004bdd6c6987b0fc0eca3a7b4be9fc806f9a3316ea24db00"} 13:38:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:03 INFO - Contents: 13:38:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3598008ae5d03875cca6644db195849b06cc658d1620bf06cfa7d92822c92fb8031aec4197dcd226db932187b7760ef9a7c1d743e24b4a2f89bd51c924165018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82208b13cc47de43caef2b9c73f44ed212e1f6012f499c285070826e41a46688e434a25b1d2ecfb004bdd6c6987b0fc0eca3a7b4be9fc806f9a3316ea24db00"} 13:38:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:03 INFO - Copying logs to upload dir... 13:38:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.883228 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-19 13:38:03.315206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 13:38:03.318456) ========= 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=0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3598008ae5d03875cca6644db195849b06cc658d1620bf06cfa7d92822c92fb8031aec4197dcd226db932187b7760ef9a7c1d743e24b4a2f89bd51c924165018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82208b13cc47de43caef2b9c73f44ed212e1f6012f499c285070826e41a46688e434a25b1d2ecfb004bdd6c6987b0fc0eca3a7b4be9fc806f9a3316ea24db00"} build_url:https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3598008ae5d03875cca6644db195849b06cc658d1620bf06cfa7d92822c92fb8031aec4197dcd226db932187b7760ef9a7c1d743e24b4a2f89bd51c924165018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82208b13cc47de43caef2b9c73f44ed212e1f6012f499c285070826e41a46688e434a25b1d2ecfb004bdd6c6987b0fc0eca3a7b4be9fc806f9a3316ea24db00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 13:38:03.344030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:38:03.344376) ========= 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=0274524eba3bdaad075c2247000001d4-1461093244.881980-1233620577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:38:03.427199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 13:38:03.427520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 13:38:03.427832) ========= ========= Total master_lag: 0.17 =========