builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1461242536.15 results: success (0) buildid: 20160421052308 builduid: f5f51b766ae14f9c864c3b7b0f8042a9 revision: a850056f05279162055f782757d4577df9ca8b85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.150946) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.151494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.151771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.169495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.169759) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 05:42: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% 112M=0s 2016-04-21 05:42:16 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.307295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.307621) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015484 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.360016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.360562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a850056f05279162055f782757d4577df9ca8b85 --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 a850056f05279162055f782757d4577df9ca8b85 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 05:42:16,627 truncating revision to first 12 chars 2016-04-21 05:42:16,627 Setting DEBUG logging. 2016-04-21 05:42:16,627 attempt 1/10 2016-04-21 05:42:16,628 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a850056f0527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 05:42:16,872 unpacking tar archive at: fx-team-a850056f0527/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.889009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.889325) ========= script_repo_revision: a850056f05279162055f782757d4577df9ca8b85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.889722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.889999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.896949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-21 05:42:16.897501) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:17 INFO - MultiFileLogger online at 20160421 05:42:17 in /builds/slave/test 05:42:17 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 05:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:17 INFO - {'append_to_log': False, 05:42:17 INFO - 'base_work_dir': '/builds/slave/test', 05:42:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:17 INFO - 'branch': 'Fx-Team-Non-PGO', 05:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:17 INFO - 'config_files': ('talos/linux_config.py',), 05:42:17 INFO - 'default_actions': ('clobber', 05:42:17 INFO - 'read-buildbot-config', 05:42:17 INFO - 'download-and-extract', 05:42:17 INFO - 'populate-webroot', 05:42:17 INFO - 'create-virtualenv', 05:42:17 INFO - 'install', 05:42:17 INFO - 'run-tests'), 05:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:17 INFO - 'download_minidump_stackwalk': True, 05:42:17 INFO - 'download_symbols': 'ondemand', 05:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:17 INFO - 'installer_path': 'installer.exe', 05:42:17 INFO - 'log_level': 'info', 05:42:17 INFO - 'log_name': 'talos', 05:42:17 INFO - 'log_to_console': True, 05:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:17 INFO - 'opt_config_files': (), 05:42:17 INFO - 'pip_index': False, 05:42:17 INFO - 'sps_profile': False, 05:42:17 INFO - 'sps_profile_interval': 0, 05:42:17 INFO - 'suite': 'dromaeojs-e10s', 05:42:17 INFO - 'system_bits': '32', 05:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:17 INFO - 'title': 'talos-linux64-ix-041', 05:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:17 INFO - 'use_talos_json': True, 05:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:17 INFO - 'work_dir': 'build'} 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running clobber step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: clobber 05:42:17 INFO - rmtree: /builds/slave/test/build 05:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:17 INFO - Running post-action listener: _resource_record_post_action 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running read-buildbot-config step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: read_buildbot_config 05:42:17 INFO - Using buildbot properties: 05:42:17 INFO - { 05:42:17 INFO - "project": "", 05:42:17 INFO - "product": "firefox", 05:42:17 INFO - "script_repo_revision": "production", 05:42:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:42:17 INFO - "repository": "", 05:42:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:42:17 INFO - "buildid": "20160421052308", 05:42:17 INFO - "pgo_build": "False", 05:42:17 INFO - "basedir": "/builds/slave/test", 05:42:17 INFO - "buildnumber": 1174, 05:42:17 INFO - "slavename": "talos-linux64-ix-041", 05:42:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:42:17 INFO - "platform": "ubuntu64_hw", 05:42:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:42:17 INFO - "branch": "fx-team", 05:42:17 INFO - "repo_path": "integration/fx-team", 05:42:17 INFO - "revision": "a850056f05279162055f782757d4577df9ca8b85", 05:42:17 INFO - "stage_platform": "linux64", 05:42:17 INFO - "builduid": "f5f51b766ae14f9c864c3b7b0f8042a9", 05:42:17 INFO - "slavebuilddir": "test" 05:42:17 INFO - } 05:42:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:42:17 INFO - Running post-action listener: _resource_record_post_action 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running download-and-extract step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: download_and_extract 05:42:17 INFO - mkdir: /builds/slave/test/build/tests 05:42: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')]} 05:42:17 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:19 INFO - Downloaded 1361 bytes. 05:42:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:19 INFO - Using the following test package requirements: 05:42:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:42:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:42:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'jsshell-linux-x86_64.zip'], 05:42:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:42:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:42:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:42:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:42:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:42:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:42: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')]} 05:42:19 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:20 INFO - Downloaded 22275943 bytes. 05:42:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:42:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:42:21 INFO - Return code: 0 05:42:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:21 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:24 INFO - Downloaded 22275943 bytes. 05:42:24 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'] 05:42:24 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 05:42:25 INFO - Return code: 0 05:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:25 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:27 INFO - Downloaded 10845952 bytes. 05:42:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:42:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:42:27 INFO - Return code: 0 05:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:27 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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 05:42:31 INFO - Downloaded 54669050 bytes. 05:42:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:31 INFO - mkdir: /builds/slave/test/properties 05:42:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:42:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:42:31 INFO - Contents: 05:42:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:31 INFO - Running post-action listener: _resource_record_post_action 05:42:31 INFO - Running post-action listener: set_extra_try_arguments 05:42:31 INFO - ##### 05:42:31 INFO - ##### Running populate-webroot step. 05:42:31 INFO - ##### 05:42:31 INFO - Running pre-action listener: _resource_record_pre_action 05:42:31 INFO - Running main action method: populate_webroot 05:42:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:31 INFO - '--tppagecycles', 05:42:31 INFO - '7'], 05:42:31 INFO - 'tests': ['tsvgm']}}, 05:42:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:42:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:42:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:42:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['damp', 'tps']}, 05:42:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'tests': ['damp', 'tps']}, 05:42:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['dromaeo_dom']}, 05:42:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['a11yr', 05:42:31 INFO - 'ts_paint', 05:42:31 INFO - 'tpaint', 05:42:31 INFO - 'sessionrestore', 05:42:31 INFO - 'sessionrestore_no_auto_restore', 05:42:31 INFO - 'tabpaint']}, 05:42:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:42:31 INFO - 'ts_paint', 05:42:31 INFO - 'tpaint', 05:42:31 INFO - 'sessionrestore', 05:42:31 INFO - 'sessionrestore_no_auto_restore', 05:42:31 INFO - 'tabpaint']}, 05:42:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:42:31 INFO - 'ts_paint', 05:42:31 INFO - 'tpaint', 05:42:31 INFO - 'sessionrestore', 05:42:31 INFO - 'sessionrestore_no_auto_restore', 05:42:31 INFO - 'tabpaint']}, 05:42:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:42:31 INFO - 'ts_paint', 05:42:31 INFO - 'tpaint', 05:42:31 INFO - 'sessionrestore', 05:42:31 INFO - 'sessionrestore_no_auto_restore', 05:42:31 INFO - 'tabpaint']}, 05:42:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['a11yr', 05:42:31 INFO - 'ts_paint', 05:42:31 INFO - 'tpaint', 05:42:31 INFO - 'sessionrestore', 05:42:31 INFO - 'sessionrestore_no_auto_restore', 05:42:31 INFO - 'tabpaint']}, 05:42:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['a11yr', 05:42:31 INFO - 'ts_paint', 05:42:31 INFO - 'tpaint', 05:42:31 INFO - 'sessionrestore', 05:42:31 INFO - 'sessionrestore_no_auto_restore', 05:42:31 INFO - 'tabpaint']}, 05:42:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['tsvgx', 05:42:31 INFO - 'tsvgr_opacity', 05:42:31 INFO - 'tart', 05:42:31 INFO - 'tscrollx', 05:42:31 INFO - 'cart']}, 05:42:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:42:31 INFO - 'tsvgr_opacity', 05:42:31 INFO - 'tart', 05:42:31 INFO - 'tscrollx', 05:42:31 INFO - 'cart']}, 05:42:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'talos_options': ['--disable-e10s'], 05:42:31 INFO - 'tests': ['tp5o']}, 05:42:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'tests': ['tp5o']}, 05:42:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'talos_options': ['--disable-e10s', 05:42:31 INFO - '--xperf_path', 05:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:31 INFO - 'tests': ['tp5n']}, 05:42:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:31 INFO - 'talos_options': ['--xperf_path', 05:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:31 INFO - 'tests': ['tp5n']}}, 05:42:31 INFO - 'talos.zip': {'path': '', 05:42:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:31 INFO - Running post-action listener: _resource_record_post_action 05:42:31 INFO - ##### 05:42:31 INFO - ##### Running create-virtualenv step. 05:42:31 INFO - ##### 05:42:31 INFO - Running pre-action listener: _resource_record_pre_action 05:42:31 INFO - Running main action method: create_virtualenv 05:42:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:42:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:42:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:42:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:31 INFO - Using real prefix '/usr' 05:42:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:42:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:42:34 INFO - Installing pip.................done. 05:42:34 INFO - Return code: 0 05:42:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:42:34 INFO - Using env: {'DISPLAY': ':0', 05:42:34 INFO - 'HOME': '/home/cltbld', 05:42:34 INFO - 'LANG': 'en_US.UTF-8', 05:42:34 INFO - 'LANGUAGE': 'en_US:en', 05:42:34 INFO - 'LOGNAME': 'cltbld', 05:42:34 INFO - 'MAIL': '/var/mail/cltbld', 05:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:34 INFO - 'MOZ_NO_REMOTE': '1', 05:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:34 INFO - 'NO_EM_RESTART': '1', 05:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:34 INFO - 'PWD': '/builds/slave/test', 05:42:34 INFO - 'SHELL': '/bin/bash', 05:42:34 INFO - 'SHLVL': '1', 05:42:34 INFO - 'TERM': 'linux', 05:42:34 INFO - 'TMOUT': '86400', 05:42:34 INFO - 'USER': 'cltbld', 05:42:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:34 INFO - '_': '/tools/buildbot/bin/python'} 05:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:42:34 INFO - Cleaning up... 05:42:34 INFO - Return code: 0 05:42:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:42:34 INFO - Using env: {'DISPLAY': ':0', 05:42:34 INFO - 'HOME': '/home/cltbld', 05:42:34 INFO - 'LANG': 'en_US.UTF-8', 05:42:34 INFO - 'LANGUAGE': 'en_US:en', 05:42:34 INFO - 'LOGNAME': 'cltbld', 05:42:34 INFO - 'MAIL': '/var/mail/cltbld', 05:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:34 INFO - 'MOZ_NO_REMOTE': '1', 05:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:34 INFO - 'NO_EM_RESTART': '1', 05:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:34 INFO - 'PWD': '/builds/slave/test', 05:42:34 INFO - 'SHELL': '/bin/bash', 05:42:34 INFO - 'SHLVL': '1', 05:42:34 INFO - 'TERM': 'linux', 05:42:34 INFO - 'TMOUT': '86400', 05:42:34 INFO - 'USER': 'cltbld', 05:42:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:34 INFO - '_': '/tools/buildbot/bin/python'} 05:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:34 INFO - Downloading/unpacking psutil>=0.7.1 05:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:42:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:36 INFO - Installing collected packages: psutil 05:42:36 INFO - Running setup.py install for psutil 05:42:36 INFO - building 'psutil._psutil_linux' extension 05:42:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:42:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:42:37 INFO - building 'psutil._psutil_posix' extension 05:42:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:42:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:37 INFO - Successfully installed psutil 05:42:37 INFO - Cleaning up... 05:42:37 INFO - Return code: 0 05:42:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:42:37 INFO - Using env: {'DISPLAY': ':0', 05:42:37 INFO - 'HOME': '/home/cltbld', 05:42:37 INFO - 'LANG': 'en_US.UTF-8', 05:42:37 INFO - 'LANGUAGE': 'en_US:en', 05:42:37 INFO - 'LOGNAME': 'cltbld', 05:42:37 INFO - 'MAIL': '/var/mail/cltbld', 05:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:37 INFO - 'MOZ_NO_REMOTE': '1', 05:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:37 INFO - 'NO_EM_RESTART': '1', 05:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:37 INFO - 'PWD': '/builds/slave/test', 05:42:37 INFO - 'SHELL': '/bin/bash', 05:42:37 INFO - 'SHLVL': '1', 05:42:37 INFO - 'TERM': 'linux', 05:42:37 INFO - 'TMOUT': '86400', 05:42:37 INFO - 'USER': 'cltbld', 05:42:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:37 INFO - '_': '/tools/buildbot/bin/python'} 05:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:42:39 INFO - Installing collected packages: mozsystemmonitor 05:42:39 INFO - Running setup.py install for mozsystemmonitor 05:42:39 INFO - Successfully installed mozsystemmonitor 05:42:39 INFO - Cleaning up... 05:42:39 INFO - Return code: 0 05:42:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:39 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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:42:39 INFO - Using env: {'DISPLAY': ':0', 05:42:39 INFO - 'HOME': '/home/cltbld', 05:42:39 INFO - 'LANG': 'en_US.UTF-8', 05:42:39 INFO - 'LANGUAGE': 'en_US:en', 05:42:39 INFO - 'LOGNAME': 'cltbld', 05:42:39 INFO - 'MAIL': '/var/mail/cltbld', 05:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:39 INFO - 'MOZ_NO_REMOTE': '1', 05:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:39 INFO - 'NO_EM_RESTART': '1', 05:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:39 INFO - 'PWD': '/builds/slave/test', 05:42:39 INFO - 'SHELL': '/bin/bash', 05:42:39 INFO - 'SHLVL': '1', 05:42:39 INFO - 'TERM': 'linux', 05:42:39 INFO - 'TMOUT': '86400', 05:42:39 INFO - 'USER': 'cltbld', 05:42:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:39 INFO - '_': '/tools/buildbot/bin/python'} 05:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:42:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:43 INFO - Downloading docopt-0.6.1.tar.gz 05:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:43 INFO - Running setup.py install for blobuploader 05:42:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:42:43 INFO - Running setup.py install for requests 05:42:44 INFO - Running setup.py install for docopt 05:42:44 INFO - Successfully installed blobuploader requests docopt 05:42:44 INFO - Cleaning up... 05:42:44 INFO - Return code: 0 05:42:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:44 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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:44 INFO - Using env: {'DISPLAY': ':0', 05:42:44 INFO - 'HOME': '/home/cltbld', 05:42:44 INFO - 'LANG': 'en_US.UTF-8', 05:42:44 INFO - 'LANGUAGE': 'en_US:en', 05:42:44 INFO - 'LOGNAME': 'cltbld', 05:42:44 INFO - 'MAIL': '/var/mail/cltbld', 05:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:44 INFO - 'MOZ_NO_REMOTE': '1', 05:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:44 INFO - 'NO_EM_RESTART': '1', 05:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:44 INFO - 'PWD': '/builds/slave/test', 05:42:44 INFO - 'SHELL': '/bin/bash', 05:42:44 INFO - 'SHLVL': '1', 05:42:44 INFO - 'TERM': 'linux', 05:42:44 INFO - 'TMOUT': '86400', 05:42:44 INFO - 'USER': 'cltbld', 05:42:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:44 INFO - '_': '/tools/buildbot/bin/python'} 05:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:44 INFO - Running setup.py (path:/tmp/pip-gR4RxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:44 INFO - Running setup.py (path:/tmp/pip-F5Tlb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:44 INFO - Running setup.py (path:/tmp/pip-jwOhBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:44 INFO - Running setup.py (path:/tmp/pip-zgqiiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:44 INFO - Running setup.py (path:/tmp/pip-Xs1saf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:44 INFO - Running setup.py (path:/tmp/pip-yJObyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:44 INFO - Running setup.py (path:/tmp/pip-rWuO7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:44 INFO - Running setup.py (path:/tmp/pip-1BqbsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:44 INFO - Running setup.py (path:/tmp/pip-jn3DnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:45 INFO - Running setup.py (path:/tmp/pip-dTWnsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:45 INFO - Running setup.py (path:/tmp/pip-0Ry5dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:45 INFO - Running setup.py (path:/tmp/pip-6IyoXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:45 INFO - Running setup.py (path:/tmp/pip-Cy5npL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:45 INFO - Running setup.py (path:/tmp/pip-zFJ8qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:45 INFO - Running setup.py (path:/tmp/pip-WQPpxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:45 INFO - Running setup.py (path:/tmp/pip-8X5OSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:45 INFO - Running setup.py (path:/tmp/pip-FGPGou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:45 INFO - Running setup.py install for manifestparser 05:42:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:45 INFO - Running setup.py install for mozcrash 05:42:45 INFO - Running setup.py install for mozdebug 05:42:45 INFO - Running setup.py install for mozdevice 05:42:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for mozfile 05:42:46 INFO - Running setup.py install for mozhttpd 05:42:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for mozinfo 05:42:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for mozInstall 05:42:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for mozleak 05:42:46 INFO - Running setup.py install for mozlog 05:42:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for moznetwork 05:42:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for mozprocess 05:42:46 INFO - Running setup.py install for mozprofile 05:42:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:46 INFO - Running setup.py install for mozrunner 05:42:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:47 INFO - Running setup.py install for mozscreenshot 05:42:47 INFO - Running setup.py install for moztest 05:42:47 INFO - Running setup.py install for mozversion 05:42:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:47 INFO - Cleaning up... 05:42:47 INFO - Return code: 0 05:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:47 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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:47 INFO - Using env: {'DISPLAY': ':0', 05:42:47 INFO - 'HOME': '/home/cltbld', 05:42:47 INFO - 'LANG': 'en_US.UTF-8', 05:42:47 INFO - 'LANGUAGE': 'en_US:en', 05:42:47 INFO - 'LOGNAME': 'cltbld', 05:42:47 INFO - 'MAIL': '/var/mail/cltbld', 05:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:47 INFO - 'MOZ_NO_REMOTE': '1', 05:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:47 INFO - 'NO_EM_RESTART': '1', 05:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:47 INFO - 'PWD': '/builds/slave/test', 05:42:47 INFO - 'SHELL': '/bin/bash', 05:42:47 INFO - 'SHLVL': '1', 05:42:47 INFO - 'TERM': 'linux', 05:42:47 INFO - 'TMOUT': '86400', 05:42:47 INFO - 'USER': 'cltbld', 05:42:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:47 INFO - '_': '/tools/buildbot/bin/python'} 05:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:47 INFO - Running setup.py (path:/tmp/pip-62RUcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:47 INFO - Running setup.py (path:/tmp/pip-stvYA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:47 INFO - Running setup.py (path:/tmp/pip-kll35a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:47 INFO - Running setup.py (path:/tmp/pip-TcfcZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:47 INFO - Running setup.py (path:/tmp/pip-BsDFyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:47 INFO - Running setup.py (path:/tmp/pip-4dN1oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:48 INFO - Running setup.py (path:/tmp/pip-LtmQzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:48 INFO - Running setup.py (path:/tmp/pip-7zT9Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:48 INFO - Running setup.py (path:/tmp/pip-N3ZHd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:48 INFO - Running setup.py (path:/tmp/pip-fxTczu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:48 INFO - Running setup.py (path:/tmp/pip-brYurQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:48 INFO - Running setup.py (path:/tmp/pip-khX1e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:48 INFO - Running setup.py (path:/tmp/pip-Q54Y9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:48 INFO - Running setup.py (path:/tmp/pip-_3nM4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:48 INFO - Running setup.py (path:/tmp/pip-PTIzqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:48 INFO - Running setup.py (path:/tmp/pip-lFUwnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:48 INFO - Running setup.py (path:/tmp/pip-mITaid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:50 INFO - Downloading blessings-1.6.tar.gz 05:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:50 INFO - Installing collected packages: blessings 05:42:50 INFO - Running setup.py install for blessings 05:42:50 INFO - Successfully installed blessings 05:42:50 INFO - Cleaning up... 05:42:50 INFO - Return code: 0 05:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:51 INFO - Reading from file tmpfile_stdout 05:42:51 INFO - Current package versions: 05:42:51 INFO - argparse == 1.2.1 05:42:51 INFO - blessings == 1.6 05:42:51 INFO - blobuploader == 1.2.4 05:42:51 INFO - docopt == 0.6.1 05:42:51 INFO - manifestparser == 1.1 05:42:51 INFO - mozInstall == 1.12 05:42:51 INFO - mozcrash == 0.17 05:42:51 INFO - mozdebug == 0.1 05:42:51 INFO - mozdevice == 0.48 05:42:51 INFO - mozfile == 1.2 05:42:51 INFO - mozhttpd == 0.7 05:42:51 INFO - mozinfo == 0.9 05:42:51 INFO - mozleak == 0.1 05:42:51 INFO - mozlog == 3.1 05:42:51 INFO - moznetwork == 0.27 05:42:51 INFO - mozprocess == 0.22 05:42:51 INFO - mozprofile == 0.28 05:42:51 INFO - mozrunner == 6.11 05:42:51 INFO - mozscreenshot == 0.1 05:42:51 INFO - mozsystemmonitor == 0.0 05:42:51 INFO - moztest == 0.7 05:42:51 INFO - mozversion == 1.4 05:42:51 INFO - psutil == 3.1.1 05:42:51 INFO - requests == 1.2.3 05:42:51 INFO - wsgiref == 0.1.2 05:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:51 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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:51 INFO - Using env: {'DISPLAY': ':0', 05:42:51 INFO - 'HOME': '/home/cltbld', 05:42:51 INFO - 'LANG': 'en_US.UTF-8', 05:42:51 INFO - 'LANGUAGE': 'en_US:en', 05:42:51 INFO - 'LOGNAME': 'cltbld', 05:42:51 INFO - 'MAIL': '/var/mail/cltbld', 05:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:51 INFO - 'MOZ_NO_REMOTE': '1', 05:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:51 INFO - 'NO_EM_RESTART': '1', 05:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:51 INFO - 'PWD': '/builds/slave/test', 05:42:51 INFO - 'SHELL': '/bin/bash', 05:42:51 INFO - 'SHLVL': '1', 05:42:51 INFO - 'TERM': 'linux', 05:42:51 INFO - 'TMOUT': '86400', 05:42:51 INFO - 'USER': 'cltbld', 05:42:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:51 INFO - '_': '/tools/buildbot/bin/python'} 05:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:42:51 INFO - Cleaning up... 05:42:51 INFO - Return code: 0 05:42:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:51 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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:42:51 INFO - Using env: {'DISPLAY': ':0', 05:42:51 INFO - 'HOME': '/home/cltbld', 05:42:51 INFO - 'LANG': 'en_US.UTF-8', 05:42:51 INFO - 'LANGUAGE': 'en_US:en', 05:42:51 INFO - 'LOGNAME': 'cltbld', 05:42:51 INFO - 'MAIL': '/var/mail/cltbld', 05:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:51 INFO - 'MOZ_NO_REMOTE': '1', 05:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:51 INFO - 'NO_EM_RESTART': '1', 05:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:51 INFO - 'PWD': '/builds/slave/test', 05:42:51 INFO - 'SHELL': '/bin/bash', 05:42:51 INFO - 'SHLVL': '1', 05:42:51 INFO - 'TERM': 'linux', 05:42:51 INFO - 'TMOUT': '86400', 05:42:51 INFO - 'USER': 'cltbld', 05:42:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:51 INFO - '_': '/tools/buildbot/bin/python'} 05:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:51 INFO - Downloading/unpacking jsonschema 05:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:42:53 INFO - Downloading/unpacking functools32 (from jsonschema) 05:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:42:54 INFO - warning: no files found matching '*.txt' 05:42:54 INFO - no previously-included directories found matching 'build' 05:42:54 INFO - no previously-included directories found matching 'dist' 05:42:54 INFO - no previously-included directories found matching '.git*' 05:42:54 INFO - Installing collected packages: jsonschema, functools32 05:42:54 INFO - Running setup.py install for functools32 05:42:54 INFO - warning: no files found matching '*.txt' 05:42:54 INFO - no previously-included directories found matching 'build' 05:42:54 INFO - no previously-included directories found matching 'dist' 05:42:54 INFO - no previously-included directories found matching '.git*' 05:42:54 INFO - Successfully installed jsonschema functools32 05:42:54 INFO - Cleaning up... 05:42:54 INFO - Return code: 0 05:42:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:54 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 0x7f0ff6ff1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:42:54 INFO - Using env: {'DISPLAY': ':0', 05:42:54 INFO - 'HOME': '/home/cltbld', 05:42:54 INFO - 'LANG': 'en_US.UTF-8', 05:42:54 INFO - 'LANGUAGE': 'en_US:en', 05:42:54 INFO - 'LOGNAME': 'cltbld', 05:42:54 INFO - 'MAIL': '/var/mail/cltbld', 05:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:54 INFO - 'MOZ_NO_REMOTE': '1', 05:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:54 INFO - 'NO_EM_RESTART': '1', 05:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:54 INFO - 'PWD': '/builds/slave/test', 05:42:54 INFO - 'SHELL': '/bin/bash', 05:42:54 INFO - 'SHLVL': '1', 05:42:54 INFO - 'TERM': 'linux', 05:42:54 INFO - 'TMOUT': '86400', 05:42:54 INFO - 'USER': 'cltbld', 05:42:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:54 INFO - '_': '/tools/buildbot/bin/python'} 05:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:54 INFO - Downloading/unpacking flake8 05:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:42:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:42:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:42:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:57 INFO - no previously-included directories found matching 'docs/_build' 05:42:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:42:57 INFO - Running setup.py install for pep8 05:42:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:57 INFO - no previously-included directories found matching 'docs/_build' 05:42:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:42:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:42:57 INFO - Cleaning up... 05:42:57 INFO - Return code: 0 05:42:57 INFO - Running post-action listener: _resource_record_post_action 05:42:57 INFO - Running post-action listener: _start_resource_monitoring 05:42:57 INFO - Starting resource monitoring. 05:42:57 INFO - ##### 05:42:57 INFO - ##### Running install step. 05:42:57 INFO - ##### 05:42:57 INFO - Running pre-action listener: _resource_record_pre_action 05:42:57 INFO - Running main action method: install 05:42:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:57 INFO - Reading from file tmpfile_stdout 05:42:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:57 INFO - Reading from file tmpfile_stdout 05:42:57 INFO - Output received: 05:42:57 INFO - Usage: mozinstall [options] installer 05:42:57 INFO - Options: 05:42:57 INFO - -h, --help show this help message and exit 05:42:57 INFO - -d DEST, --destination=DEST 05:42:57 INFO - Directory to install application into. [default: 05:42:57 INFO - "/builds/slave/test"] 05:42:57 INFO - --app=APP Application being installed. [default: firefox] 05:42:57 INFO - mkdir: /builds/slave/test/build/application 05:42:57 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'] 05:42:57 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 05:43:13 INFO - Reading from file tmpfile_stdout 05:43:13 INFO - Output received: 05:43:13 INFO - /builds/slave/test/build/application/firefox/firefox 05:43:13 INFO - Running post-action listener: _resource_record_post_action 05:43:13 INFO - ##### 05:43:13 INFO - ##### Running run-tests step. 05:43:13 INFO - ##### 05:43:13 INFO - Running pre-action listener: _resource_record_pre_action 05:43:13 INFO - Running main action method: run_tests 05:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:43:13 INFO - Python 2.7.3 05:43:13 INFO - Return code: 0 05:43:13 INFO - grabbing minidump binary from tooltool 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 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 0x2d33410>, '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 0x2d34310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d347a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:43:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:43:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:43:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:13 INFO - Return code: 0 05:43:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:43:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:43:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:43:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:43:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:43:14 INFO - Return code: 0 05:43:14 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/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 05:43:14 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/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 05:43:14 INFO - Using env: {'DISPLAY': ':0', 05:43:14 INFO - 'HOME': '/home/cltbld', 05:43:14 INFO - 'LANG': 'en_US.UTF-8', 05:43:14 INFO - 'LANGUAGE': 'en_US:en', 05:43:14 INFO - 'LOGNAME': 'cltbld', 05:43:14 INFO - 'MAIL': '/var/mail/cltbld', 05:43:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:14 INFO - 'MOZ_NO_REMOTE': '1', 05:43:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:14 INFO - 'NO_EM_RESTART': '1', 05:43:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:14 INFO - 'PWD': '/builds/slave/test', 05:43:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:14 INFO - 'SHELL': '/bin/bash', 05:43:14 INFO - 'SHLVL': '1', 05:43:14 INFO - 'TERM': 'linux', 05:43:14 INFO - 'TMOUT': '86400', 05:43:14 INFO - 'USER': 'cltbld', 05:43:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570', 05:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:14 INFO - '_': '/tools/buildbot/bin/python'} 05:43:14 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/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 05:43:14 INFO - mozversion application_buildid: 20160421052308 05:43:14 INFO - mozversion application_changeset: a850056f05279162055f782757d4577df9ca8b85 05:43:14 INFO - mozversion application_display_name: Nightly 05:43:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:14 INFO - mozversion application_name: Firefox 05:43:14 INFO - mozversion application_remotingname: firefox 05:43:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:43:14 INFO - mozversion application_vendor: Mozilla 05:43:14 INFO - mozversion application_version: 48.0a1 05:43:14 INFO - mozversion platform_buildid: 20160421052308 05:43:14 INFO - mozversion platform_changeset: a850056f05279162055f782757d4577df9ca8b85 05:43:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:43:14 INFO - mozversion platform_version: 48.0a1 05:43:14 INFO - using testdate: 1461242594 05:43:14 INFO - actual date: 1461242594 05:43:14 INFO - starting webserver on 'localhost:43952' 05:43:14 INFO - SUITE-START | Running 2 tests 05:43:14 INFO - TEST-START | dromaeo_css 05:43:14 INFO - operating with platform_type : linux_ 05:43:14 INFO - Initialising browser for dromaeo_css test... 05:43:14 INFO - TEST-INFO | started process 23624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR0RQPI/profile http://localhost:43952/getInfo.html) 05:43:19 INFO - PROCESS | 23624 | 05:43:19 INFO - PROCESS | 23624 | (process:23692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:19 INFO - PROCESS | 23624 | __metrics Screen width/height:1600/1200 05:43:19 INFO - PROCESS | 23624 | colorDepth:24 05:43:19 INFO - PROCESS | 23624 | Browser inner width/height: 1024/697 05:43:19 INFO - PROCESS | 23624 | __metrics 05:43:20 ERROR - PROCESS | 23624 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:43:21 INFO - TEST-INFO | 23624: exit 0 05:43:21 INFO - Browser initialized. 05:43:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:43:21 INFO - TEST-INFO | started process 23743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR0RQPI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:23 INFO - PROCESS | 23743 | 05:43:23 INFO - PROCESS | 23743 | (process:23804): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:33 INFO - PROCESS | 23743 | RSS: Main: 164843520 05:43:33 INFO - PROCESS | 23743 | 05:44:23 INFO - PROCESS | 23743 | 1461242663223 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:46:34 INFO - PROCESS | 23743 | Cycle 1(1): loaded http://localhost:43952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43952/tests/dromaeo/cssquery-ext.html) 05:46:36 INFO - PROCESS | 23743 | RSS: Main: 168894464 05:46:36 INFO - PROCESS | 23743 | 05:49:38 INFO - PROCESS | 23743 | Cycle 1(1): loaded http://localhost:43952/tests/dromaeo/cssquery-ext.html (next: http://localhost:43952/tests/dromaeo/cssquery-jquery.html) 05:49:38 INFO - PROCESS | 23743 | RSS: Main: 165761024 05:49:38 INFO - PROCESS | 23743 | 05:52:40 INFO - PROCESS | 23743 | Cycle 1(1): loaded http://localhost:43952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43952/tests/dromaeo/cssquery-mootools.html) 05:52:41 INFO - PROCESS | 23743 | RSS: Main: 166686720 05:52:41 INFO - PROCESS | 23743 | 05:55:43 INFO - PROCESS | 23743 | Cycle 1(1): loaded http://localhost:43952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43952/tests/dromaeo/cssquery-prototype.html) 05:55:43 INFO - PROCESS | 23743 | RSS: Main: 164700160 05:55:43 INFO - PROCESS | 23743 | 05:58:46 INFO - PROCESS | 23743 | Cycle 1(1): loaded http://localhost:43952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43952/tests/dromaeo/cssquery-yui.html) 05:58:47 INFO - PROCESS | 23743 | RSS: Main: 166260736 05:58:47 INFO - PROCESS | 23743 | 06:01:49 INFO - PROCESS | 23743 | Cycle 1(1): loaded http://localhost:43952/tests/dromaeo/cssquery-yui.html (next: http://localhost:43952/tests/dromaeo/cssquery-dojo.html) 06:01:50 INFO - PROCESS | 23743 | RSS: Main: 168116224 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | __start_tp_report 06:01:50 INFO - PROCESS | 23743 | _x_x_mozilla_page_load 06:01:50 INFO - PROCESS | 23743 | _x_x_mozilla_page_load_details 06:01:50 INFO - PROCESS | 23743 | |i|pagename|runs| 06:01:50 INFO - PROCESS | 23743 | |0;dojo.html;2599.194249782567;2675.906343277986;2698.0287096645193;2701.405690748036;2702.405470796424;4700.247960326348;4709.57613814757;4734.597559207472;4734.73958932259;4769;4674.08855273221;4746.881327966803;4772.761361931907;4811.711297322163;4815.157347464197;4335.761533115685;4437.977810110945;4464.799084041226;4469.195544801951;4469.418975533176;579.4089130778212;4235.428217190686;4341.066670665807;4370.6503479721705;4389.846355377563;4406.405135306724;4407.955920440802;4415.028693687384;4419.447569053868;4437.134758722051;4256.106217694288;4422.7346359218545;4445.355423463612;4469.888252793674;4471.7987690554;4254.106637606106;4288.849890253858;4292.399064130993;4308.978455107705;4344.869653910388;4583;4595.448546174447;4643.582077612998;4653.720776753372;4713.293006049086;5016.3980322361185;5043.62172837035;5074.797008119671;5099.617528685327;5194.246834209019;4971.527704868032;4985.152524070917;5001.44984051754;5019.0463811875625;5056.064628043824;4631.120087183424;4674.252119660872;4675.95324046762;4694.906101877943;4726.409198850144;5050.6464547482055;5154.046501397253;5256.316678831728;5325.680459172462;5336.573074154058;4912.754362281871;4920.803167873245;4940.481249468826;4948.777305021211;4984.875378115504;4988.6757360771435;4994.80020799164;5000.74996250186;5003.449620541737;5050.974745126325;4857.53853383928;5047.066292735855;5081.568066714371;5129.589632829365;5137.357830271216;4844.733539655353;5086.847394578169;5087.592992560586;5091;5136.512031357015;4142.668586513072;4181.310083836193;4203.306454434984;4219.831206751757;4224.366345048267;3631.963680363215;3688.5389326334207;3746.325661380923;3747.306748251582;3784.148566572554;4452.799624016927;4466.665000125004;4478.888027799331;4506.684532082722;4507.8196872124745;4989.825356112518;5095.617828662791;5103.106956282636;5112.642115051911;5113.974430127825;4402.84590039347;4448.266036104006;4450.3991961085485;4471.865844024619;4483.484399294058;4536.251518499411;4554.362389265505;4565.931511027337;4579.610733087658;4597.931031034537;4673.275642275453;4851.320815085962;4852.102361063215;4853.39332583427;4858.3441235432765;5086.338775959101;5118.104331742004;5124;5126.7949282029795;5166.819161329336;4830.565249127595;4847.200211964986;4855.490173531728;4873.366462359871;4917.28699338601;4892.90214195707;4915.901681966412;4943.975280123576;5038.647294689336;5107.208382700687;5072.264521644267;5100.897982040413;5102.540771330598;5110.386753589444;5149.459306772885;4920.6801557898625;4947.356843610308;4959.603231741524;4967.956729086933;5003.849884503471;4756.16767065769;4919.220387424613;4970.428400733962;5041.924371134362;5064.290999260033;4642.953570464388;4881.609471242363;4901.3383193268455;4914.92627610579;5010.448850626355;4994.5754610858485;5021.372328458942;5022.799088036438;5025.522575355335;5047.2429135629945;4719.1977363847545;4819.518048195152;4901;4915.7542122893;4925.950740492549 06:01:50 INFO - PROCESS | 23743 | |1;ext.html;557.1998967044757;582.551435394746;587.441930166342;601.9255628702766;628.3057221769941;33477.33045339095;34920.82539587305;34978.475322870174;35039.124021899464;35111.12222194443;35753.64246357536;36344.2731145377;36376.09059773507;36464.453033204525;36490.27019459616;7525.736599219014;7754.457187996843;7776.105747838986;7792.064952205743;7807.375409967218;7619.1238007629;7965.761027169166;7969.920300796975;7980.680772769082;7982.042154941415;7953.681852725884;8003.679852805881;8012.719554815582;8028;8032.518048917054;7885.921140788605;7947.642356093989;7967.402444816662;7987.640556174986;8002.799930001738;7771.883421748678;7842.686292548291;7851.842963140763;7868.960655196687;7898;28205.576916346272;35853.64146358529;36298.63701362979;36344;36364.81817590895;2979.0467050543834;3019.8545958973605;3175.8094514329214;3301.8018918864705;3529.5764508258917;27133.86433067822;27306.31734206641;27442.862785686142;27628.171154865388;27738.861305693343;3410.2497450560836;3499.475078738184;3585.8386372613295;3591.7665351752053;3634.254977729559;186781;190675.04662476736;190675.04662476736;191242;191528;33750.32499349999;52970.20544691833;53018.20472692913;53138;53398.19902701463;34174.82912585421;34460.31079378448;34481.31037379238;34627.30745385078;34679;12696;12926.547570834975;13029.283389413484;13031.08782385243;13046;10555.788884222273;10661.307015043998;10662.626808061681;10670.30643008202;10674.679759607225;8086.959565202136;8198.467099638505;8297.8340433191;8331.750047498463;8388.412811103286;3275.901722948315;3287.506873968876;3293.374258890803;3310.6854848789326;3352.1619595101224;879.4679219072497;884.6815146547237;937.9812403752023;954.6515521834481;994.3636072913341;27111.1866644001;28429.431411371657;29146.271343216165;29177.270568235963;29181.854090729412;988.3990026426994;1031.8039572481205;1052.1740433759462;1076.3649446826253;1081.6863109698256;14860.70278594422;15167.255143151608;15470.071795692294;15575.922120389325;15583.688326233412;357782;362127;364971;365773;365909;48718.512814872105;49720.50279497231;49768.50231497711;49924.50075499271;50084.749576252616;1184.3841202574786;1212.6543934978488;1223.088798844884;1234.4259919137464;1246.9127161098636;27251;28302.85848570744;28546.714532854407;28591.714082858904;28909;44113.11773764571;44630.107397851214;44799;45026;45201.773991129834;298620;299574;302069;302191;302532;25986.61020084738;26221.73778262193;26382.340441489116;26527.469450611265;26650;42412.15175696531;42750.78624606857;43141.13717725565;43281.134377312905;43486.13027739364;35907.28185436224;37032.444513331786;37281;37572.060698482754;38108.80945595254;36279.81860090682;36319.45520817137;36534.45198321974;37150.814245928595;37644.247115057;36086.819565902006;36423.635763643084;36665.26669466649;37134;37355.252894942496;32369.838150809097;33003;33049;33484.83257583697;33682.66317336795;25494;25543.36141596475;25614.743852561234;25631;25964.740352596233 06:01:50 INFO - PROCESS | 23743 | |2;jquery.html;369.9297133544627;370.6367759595596;374.47386422076977;374.6833925333094;385.79167249685173;15722;15819.604509887258;16009.439669611565;16105.27526261318;16268.43060492883;15661.843381566181;16720.83279167208;17078.573035674115;17083;17097.059661718602;4887.511248875102;5155.5360017598405;5189;5211.088059589576;5211.661242019257;3609.8375573099274;5129.9230511542355;5507.146392309179;5774.1050137228585;5802.448767367094;5712.1431785232135;5725.026745453262;5730.484256416921;5732.570057245724;5778.42215778423;5629.127485239795;5727.427257274281;5786.739596718157;5789.768409263625;5801.477866991949;4896.167651499253;4986.052649996489;5056.342675452204;5056.898862022776;5067.695938243717;19755.901220493804;19845.70231446515;20020.399388018384;20045.298414555567;20061.79938200614;1839.0712690091552;1868.588910439701;1874.2128306111329;1908.895010774407;1957.2562426277923;12643.114981951267;12845.67885802853;12880.420381082873;13556.86443135566;13760.65598360039;1722.3110755697821;1808.7467754514378;1846.0861873372633;1890.5557194059386;1920.9231630734753;62804.68597657028;63149.68425157891;64434;64611.353886461475;65440.3455965439;9067.637294508279;9079.137481939206;9288.396254243453;9445.433274003582;9458.52707364629;12622.368881555885;12729.83592789228;12733.681657958625;12737.681557961125;12786.296753678636;6967;7186.568805871664;7263.405255287273;7315.817104572322;7316.268373162748;6890.586564806128;7007.369336759614;7040.5071644984355;7054.470914681419;7114.92885071153;5950.2264705587995;5997.880042399128;6007.27912650476;6035.124906888476;6107.633541987495;1539.6766678997312;1629.5681644364254;1671.7910261217348;1699.4731633193503;1714.1686282153146;887.5606574745542;909.7862002429424;935.5509355509394;951.3673407184283;1004.4224570871631;16361.509154725378;16651.250693718568;16785.24466399015;17174.22715977784;17191;890.9955450222708;903.6656437118309;918.3846822628722;922.285228947571;951.6669165791917;9533.332666713264;9605.13553780163;9667.371620844622;9767.462789546644;9831.262655300738;276395;284747;385111;388486;390516;77992;80397;81303.5934820334;83880;84373.15626843653;995.5072239241622;1003.2876657573205;1046.9895301046893;1050.2648146297622;1050.9527071281811;13929.23389213603;15034.248287585795;15052;15130.924345378202;15252.542423726862;31707.682923171396;32912.506312404854;33222.667773321955;33846;34171.4874276891;44994.77502612466;46070.53929460797;46074;46103;46208.53791462177;7588.778338284866;7631;7870.645820938186;7877.645505952131;7897.210278972057;7778.688852445839;11036.337819730841;11376.488058037574;11378.772424551627;11392.430378480876;10139.493025348851;10255.384676919408;10272.640457583948;10307.587696492057;10622.787544248917;10030.097291243532;10055.29612927088;10173.186145108522;10221.795564088825;10286.948565257126;10440.060394564525;10446.843297350393;10491.422971736323;10611.151107911503;10647.254692171473;7329.267073292628;7710.267524585155;7837.882431763642;7889.487183333065;8010.319122874621;10320.380777153396;10605.098566621924;10656.094231990368;10907.29102608328;11004.669859904216 06:01:50 INFO - PROCESS | 23743 | |3;mootools.html;1432.0190669391463;1440.1215258692196;1570.8664763495103;1715.7169067103928;1743.5118166913269;6883.655817209132;7427.554346739199;7446.925530744697;7678.692852285909;7750.108737495189;7428.7028518859315;7433.219511951248;7468.327850493454;7478.813029674261;7494.81262968426;2215.213599172299;2247.9775202248015;2261.1407665087245;2264.852784569006;2266.3654176830432;2192.6491761318193;2233.776622337761;2237.3847192022163;2242.5627002734473;2247.910083596654;2227.2204728345114;2228.454028762955;2245.65192395179;2262.3778460923213;2264.784845439681;2156.439325775294;2156.9784302156936;2163.7619861815265;2166.144372972675;2168.3386567097027;2166.696662467256;2177.031221106608;2182.19258874216;2182.618041842671;2190.605690975624;7481.513701609432;7595.658195381221;7605.923940760632;7623.466357354987;7633.007708997795;4474.261746811805;4577.153226653079;4590.609798167126;4641.76791160444;4647.883802904955;2814.690384057752;2913.03869722993;2916.854157292148;2927.970720292791;2935.368895687416;954.9809003819954;963.9036096390375;978.8972157923387;985.3595163143942;987.2694206287367;10512.106470949979;10529.36823790575;10565.9471702641;10606.310589811637;10634.361938283728;4177.561356057631;4212.094399704079;4379.0585024219945;4389.582989615981;4433;8999.82000359989;9004.189622933967;9045.547722613843;9068.183863452321;9069.18377346042;4621.930671039937;4634.443866736014;4647.209974304376;4658.627309815207;4663.044075964419;3649.489071529988;4078.7960601969785;4199.538050814408;4203.222403855297;4236.08924081324;3670.1742108025483;3686.2627474505207;3786.7917264550715;3793.5447746270625;3820.3696390095324;1178.5933852820763;1209.6975756060986;1211.42457332768;1215.3133479584008;1240.3240234072452;836.1304243586602;838.6813011055759;855.6021450025768;877.1491653096487;884.3190743127756;5428.75570599324;5453.672779633234;5511.063119269734;5518.365387980433;5569.805056822992;428.54146063712153;431.2474731593327;431.2926800047924;435.7189612699791;439.4572702712148;3802.4866643002842;3806.1245913440066;3912.9630647878334;3914.72596918213;3914.980425097913;9111.726648200565;9548.761280968032;9588.76028099303;9596.616135354647;9646.083622055894;8868.379213455126;9279.211267042241;9466.715998520056;9551.665691700757;9580.56887440053;6874.312568743086;6924.099867017357;6992.440604751608;7054.576725396492;7080.964595177094;5350.117230656898;5494.890102197854;5556.555475561864;5702.8289151325525;5712.285964254468;8242.793930151794;8463.53450560225;8523.82952340962;8553.74338769838;8598.355123365898;8319.792005199919;8599.656013759379;8617.353698472514;8718.302535796995;8895.510746908982;6163.3528479509005;6598.60408375499;6811.523193376416;6815.556988795713;6923.861522769415;7428.331450169295;7448.590327531821;7465.664045117874;7476.439267054884;7484.70061197546;6590.868182636416;6697.665116744241;6712.697928593323;6820.31796820314;6879.89680154788;6662;6668.166479190101;6696.4977626679165;6725.9663701681175;6794.524383293122;6192.442680158807;6205.131281620667;6231.53263505248;6298.559100862895;6298.748050077946;4838.637102217277;4849.224124140121;4889.3888263967;4945.455999840086;5017.623678224075;4784.425868895755;4805.918668299604;4842.104210721028;4846.80612775485;4859.246816743411 06:01:50 INFO - PROCESS | 23743 | |4;prototype.html;295.1617406565354;303.9240189952512;309.2531536339739;312.0653642341187;312.9170769746016;5323.3878104018;5396.163594642827;5403.081476149055;5403.594730395226;5408.810691625789;5312.654677445963;5322.973385133069;5328.653637513559;5332.440093790155;5334.946650533493;3889.988602963229;3983.40248962655;4098.446709694183;4103.138340948404;4129.710920235585;4081.979590102045;4086.223617512663;4092.263392589333;4092.4679791627045;4100.097978444737;4063.6545893599077;4069.2268468990947;4077.5514693383852;4078.6940979426513;4090.550039495653;3793.2792769374005;4014.3376342903384;4022.577629348935;4053.918921621566;4101.056756945889;3487.1630808606005;3491.4413693809124;3501.2997400519744;3502.737294702882;3507.2108775525558;5039.546440820307;5040.36995375578;5049.1164046292115;5061.468545802674;5067.518585734386;4406.317020861771;4637.86086417408;4640.027988105042;4641.976790116028;4643.605293550052;5563.887222555464;5594.272744543224;5595.524380427669;5600.1599760035915;5603.971980140114;3856.4986551748093;3859;3864.536255649312;3865.4781604483314;3865.8646947356706;5752.395998420147;5799.623024503394;5832.125181222808;5854.795082172103;5857.6778277194735;3864.7294689371474;3912.628300311466;3923.43110249018;3935.8819235422984;3935.9016024599614;3963.1677347757295;3980.606787624366;3981.22366138606;3992.920141597152;3998.300297447935;4540.250858608359;4579.9084018319445;4601.401817763736;4602.217623004098;4612.907741845144;5415.187721841677;5530.281063461724;5565.582581306418;5586.078297081018;5587.994161050969;1375.9656008599866;1380.6617378742071;1390.4160252693894;1395.9022868399115;1401.7126489069717;848.6435697007272;884.4825776920574;887.658251573149;913.4701872913694;919.2599957034652;4856.891589382798;4925.335079764258;4932.482089380635;4934.950650493521;4955.975220123876;5668.319801623749;5672.5745569081655;5673.290838645169;5681.659100453986;5683.374828768832;4736.123817093849;4870.172070747982;4902.534259245366;4924.679895806761;4995.350604421402;3063.1270088025253;3090.5673205751214;3104.301532155292;3106.1923899785766;3111.4131792785843;5489.149181876815;5505.146702261156;5505.201745746845;5516.586256030814;5529.060059789846;5828.5337173026055;5917.970410147922;5927.081302398135;5962.809896705242;5968.343482216953;5452.345718513804;5489.917651235235;5489.945100548944;5498.862528436741;5527.336719593513;5569.192467092168;5735.655860648374;5751.971240143773;5753.884922301614;5766.308043034863;5593.888122237451;5618.2415373924;5669.518090962314;5669.914951275651;5684.289463817023;5440.591955603267;5442.782288708566;5450.836474905759;5457.5633949283165;5478.972605136949;3700.7489254763614;3822.636849499293;3836.681270700768;3839.2897313997;3865.7873816940337;5733.499203125526;5739.397363276963;5750.654960702372;5754.971225144015;5767.509761670305;5529.203009022003;5557.44425557441;5572.972135139461;5592.496675299242;5638.9286035653095;5317.096093664164;5565.909056843298;5638.154276858504;5645.294338207724;5664.122061080539;5214.217867319932;5523.226748255328;5523.972380138234;5533.529649979797;5552.083906155439;5503.642263252876;5623.184638227516;5626.521745651666;5641.12562552805;5642.322921249476;5488.231647569263;5515.310586176728;5537.667739935617;5543.6396634218645;5555.416681248573 06:01:50 INFO - PROCESS | 23743 | |5;yui.html;628.852219728364;674.27852198148;683.8974153876915;689.2142957028987;755.792157156782;11247.55009799607;11299.49152288147;11474.541018359267;11488.36813975231;12039.51841926323;12816;12907.870921290783;12980.415881285342;12986;12987.415566299516;638.141699414287;797.4736673795296;815.804206990324;815.8123631564744;816.5304949653943;778.5523324088643;803.1887793328722;805.6012273924416;806.2662976691212;806.3589446390105;850.9446885952424;852.0584753847003;852.2968550945463;853.4921721575683;857.1642648417806;848.8429640516524;849.6049337058298;850.4982060584254;851.2083762101244;853.6670698427619;628.1645411602603;629.2166253015025;631.1416473595906;632.3265722006049;633.1294470103608;12137.635870923887;12231.69420764479;12236.082293827998;12243.632691019284;12256.08079394049;12630.557930472482;12846.871531284662;12916.677083072904;12983.480660773557;13023.088383813138;10057.497125143713;10126.443045632488;10285.897141028569;10362.948185259025;10420.739481513023;3253.886113986023;3351.463765797485;3407.6762707542744;3415.573053368329;3502.159481724393;44851.32723009158;45127.09745805065;45223.321650175276;45480;45674.543254567696;10140.797184056277;10210.948945255375;10261.794764104676;10388.37669739818;10630.30902991303;17476.388326408516;18086.095695215186;18227.270909163486;18259.45221643353;18284.268629254948;7108.725207933515;7121.821954451077;7221.675024623904;7296.7810965671115;7307.086614173229;3849.8075096245075;3897.4543563901075;3927.096767743435;3944.6055394460323;3965.4250133730447;2791.511485490031;2861.570764385359;2866.1831378057154;2875.856207189632;2880.5391137417914;500.1921896137784;501.24812780828756;511.15659162381627;512.1319363678529;514.0977584339461;543.7199842081332;565.6690835861067;622.6419808610067;664.5281849886538;672.559473544829;7444.813879653052;7506.3244308012545;7646.9617651911385;7674.53952762836;7726.922730772732;506.8200788720025;566.1649067625302;596.1058412381428;611.6635850282416;641.4227195523972;3343.9665603343656;3505.053635518396;3969.955487777681;4132.73137246078;4237.512686041083;47373.289400659014;49029;49705;50088.74955625198;50626.49373506218;46020.3096953546;46217.537824622;46341.768291158325;46441.30338044932;47292.29061564079;41083.38374924379;41272.174556508704;41324.1735165301;41991.7900410496;42292.788536057735;8381.622826972924;8439.535825529654;8488.448250863674;8530.701425450328;8660.263877570476;28313.150605481867;28424.289392765346;28686.856565717037;29179.7082029177;29429.26426839346;34886.30227395387;36639.816800915825;37499;38062.80968595139;38387.42418863775;10915.890841091488;10964.945175274073;11044.613438529614;11058.612948547085;11065.170112241452;12003.579874704343;12247.632571022883;12285.508579656713;12996.090273680751;13092.672683182996;11093.611723589636;11178;11300.547978080785;11709.238899471507;11747.060235181336;11850.644480665595;12076.879231207928;12080.154389192672;12116.15186936906;12161.270323780602;9497.810043799223;10395.58417663285;10532;10793.460326983777;11352.659420217407;9746.415215087118;9768.706938791847;9785.461799601091;9833.459159746282;10417.9479102604;9517.571709272961;9873.555689993824;9874.55564499585;9915.405075695482;9998.900010999796 06:01:50 INFO - PROCESS | 23743 | __end_tp_report 06:01:50 INFO - PROCESS | 23743 | __start_cc_report 06:01:50 INFO - PROCESS | 23743 | _x_x_mozilla_cycle_collect,389 06:01:50 INFO - PROCESS | 23743 | __end_cc_report 06:01:50 INFO - PROCESS | 23743 | __startTimestamp1461243710024__endTimestamp 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | ------- Summary: start ------- 06:01:50 INFO - PROCESS | 23743 | Number of tests: 6 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | [#0] dojo.html Cycles:165 Average:4668.22 Median:4851.32 stddev:585.55 (12.1%) stddev-sans-first:564.40 06:01:50 INFO - PROCESS | 23743 | Values: 2599.2 2675.9 2698.0 2701.4 2702.4 4700.2 4709.6 4734.6 4734.7 4769.0 4674.1 4746.9 4772.8 4811.7 4815.2 4335.8 4438.0 4464.8 4469.2 4469.4 579.4 4235.4 4341.1 4370.7 4389.8 4406.4 4408.0 4415.0 4419.4 4437.1 4256.1 4422.7 4445.4 4469.9 4471.8 4254.1 4288.8 4292.4 4309.0 4344.9 4583.0 4595.4 4643.6 4653.7 4713.3 5016.4 5043.6 5074.8 5099.6 5194.2 4971.5 4985.2 5001.4 5019.0 5056.1 4631.1 4674.3 4676.0 4694.9 4726.4 5050.6 5154.0 5256.3 5325.7 5336.6 4912.8 4920.8 4940.5 4948.8 4984.9 4988.7 4994.8 5000.7 5003.4 5051.0 4857.5 5047.1 5081.6 5129.6 5137.4 4844.7 5086.8 5087.6 5091.0 5136.5 4142.7 4181.3 4203.3 4219.8 4224.4 3632.0 3688.5 3746.3 3747.3 3784.1 4452.8 4466.7 4478.9 4506.7 4507.8 4989.8 5095.6 5103.1 5112.6 5114.0 4402.8 4448.3 4450.4 4471.9 4483.5 4536.3 4554.4 4565.9 4579.6 4597.9 4673.3 4851.3 4852.1 4853.4 4858.3 5086.3 5118.1 5124.0 5126.8 5166.8 4830.6 4847.2 4855.5 4873.4 4917.3 4892.9 4915.9 4944.0 5038.6 5107.2 5072.3 5100.9 5102.5 5110.4 5149.5 4920.7 4947.4 4959.6 4968.0 5003.8 4756.2 4919.2 4970.4 5041.9 5064.3 4643.0 4881.6 4901.3 4914.9 5010.4 4994.6 5021.4 5022.8 5025.5 5047.2 4719.2 4819.5 4901.0 4915.8 4926.0 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | [#1] ext.html Cycles:180 Average:43386.42 Median:19719.74 stddev:77420.01 (392.6%) stddev-sans-first:77570.41 06:01:50 INFO - PROCESS | 23743 | Values: 557.2 582.6 587.4 601.9 628.3 33477.3 34920.8 34978.5 35039.1 35111.1 35753.6 36344.3 36376.1 36464.5 36490.3 7525.7 7754.5 7776.1 7792.1 7807.4 7619.1 7965.8 7969.9 7980.7 7982.0 7953.7 8003.7 8012.7 8028.0 8032.5 7885.9 7947.6 7967.4 7987.6 8002.8 7771.9 7842.7 7851.8 7869.0 7898.0 28205.6 35853.6 36298.6 36344.0 36364.8 2979.0 3019.9 3175.8 3301.8 3529.6 27133.9 27306.3 27442.9 27628.2 27738.9 3410.2 3499.5 3585.8 3591.8 3634.3 186781.0 190675.0 190675.0 191242.0 191528.0 33750.3 52970.2 53018.2 53138.0 53398.2 34174.8 34460.3 34481.3 34627.3 34679.0 12696.0 12926.5 13029.3 13031.1 13046.0 10555.8 10661.3 10662.6 10670.3 10674.7 8087.0 8198.5 8297.8 8331.8 8388.4 3275.9 3287.5 3293.4 3310.7 3352.2 879.5 884.7 938.0 954.7 994.4 27111.2 28429.4 29146.3 29177.3 29181.9 988.4 1031.8 1052.2 1076.4 1081.7 14860.7 15167.3 15470.1 15575.9 15583.7 357782.0 362127.0 364971.0 365773.0 365909.0 48718.5 49720.5 49768.5 49924.5 50084.7 1184.4 1212.7 1223.1 1234.4 1246.9 27251.0 28302.9 28546.7 28591.7 28909.0 44113.1 44630.1 44799.0 45026.0 45201.8 298620.0 299574.0 302069.0 302191.0 302532.0 25986.6 26221.7 26382.3 26527.5 26650.0 42412.2 42750.8 43141.1 43281.1 43486.1 35907.3 37032.4 37281.0 37572.1 38108.8 36279.8 36319.5 36534.5 37150.8 37644.2 36086.8 36423.6 36665.3 37134.0 37355.3 32369.8 33003.0 33049.0 33484.8 33682.7 25494.0 25543.4 25614.7 25631.0 25964.7 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | [#2] jquery.html Cycles:180 Average:22846.39 Median:380.24 stddev:57883.24 (15222.9%) stddev-sans-first:58021.02 06:01:50 INFO - PROCESS | 23743 | Values: 369.9 370.6 374.5 374.7 385.8 15722.0 15819.6 16009.4 16105.3 16268.4 15661.8 16720.8 17078.6 17083.0 17097.1 4887.5 5155.5 5189.0 5211.1 5211.7 3609.8 5129.9 5507.1 5774.1 5802.4 5712.1 5725.0 5730.5 5732.6 5778.4 5629.1 5727.4 5786.7 5789.8 5801.5 4896.2 4986.1 5056.3 5056.9 5067.7 19755.9 19845.7 20020.4 20045.3 20061.8 1839.1 1868.6 1874.2 1908.9 1957.3 12643.1 12845.7 12880.4 13556.9 13760.7 1722.3 1808.7 1846.1 1890.6 1920.9 62804.7 63149.7 64434.0 64611.4 65440.3 9067.6 9079.1 9288.4 9445.4 9458.5 12622.4 12729.8 12733.7 12737.7 12786.3 6967.0 7186.6 7263.4 7315.8 7316.3 6890.6 7007.4 7040.5 7054.5 7114.9 5950.2 5997.9 6007.3 6035.1 6107.6 1539.7 1629.6 1671.8 1699.5 1714.2 887.6 909.8 935.6 951.4 1004.4 16361.5 16651.3 16785.2 17174.2 17191.0 891.0 903.7 918.4 922.3 951.7 9533.3 9605.1 9667.4 9767.5 9831.3 276395.0 284747.0 385111.0 388486.0 390516.0 77992.0 80397.0 81303.6 83880.0 84373.2 995.5 1003.3 1047.0 1050.3 1051.0 13929.2 15034.2 15052.0 15130.9 15252.5 31707.7 32912.5 33222.7 33846.0 34171.5 44994.8 46070.5 46074.0 46103.0 46208.5 7588.8 7631.0 7870.6 7877.6 7897.2 7778.7 11036.3 11376.5 11378.8 11392.4 10139.5 10255.4 10272.6 10307.6 10622.8 10030.1 10055.3 10173.2 10221.8 10286.9 10440.1 10446.8 10491.4 10611.2 10647.3 7329.3 7710.3 7837.9 7889.5 8010.3 10320.4 10605.1 10656.1 10907.3 11004.7 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | [#3] mootools.html Cycles:180 Average:5108.88 Median:5389.44 stddev:2793.03 (51.8%) stddev-sans-first:2787.20 06:01:50 INFO - PROCESS | 23743 | Values: 1432.0 1440.1 1570.9 1715.7 1743.5 6883.7 7427.6 7446.9 7678.7 7750.1 7428.7 7433.2 7468.3 7478.8 7494.8 2215.2 2248.0 2261.1 2264.9 2266.4 2192.6 2233.8 2237.4 2242.6 2247.9 2227.2 2228.5 2245.7 2262.4 2264.8 2156.4 2157.0 2163.8 2166.1 2168.3 2166.7 2177.0 2182.2 2182.6 2190.6 7481.5 7595.7 7605.9 7623.5 7633.0 4474.3 4577.2 4590.6 4641.8 4647.9 2814.7 2913.0 2916.9 2928.0 2935.4 955.0 963.9 978.9 985.4 987.3 10512.1 10529.4 10565.9 10606.3 10634.4 4177.6 4212.1 4379.1 4389.6 4433.0 8999.8 9004.2 9045.5 9068.2 9069.2 4621.9 4634.4 4647.2 4658.6 4663.0 3649.5 4078.8 4199.5 4203.2 4236.1 3670.2 3686.3 3786.8 3793.5 3820.4 1178.6 1209.7 1211.4 1215.3 1240.3 836.1 838.7 855.6 877.1 884.3 5428.8 5453.7 5511.1 5518.4 5569.8 428.5 431.2 431.3 435.7 439.5 3802.5 3806.1 3913.0 3914.7 3915.0 9111.7 9548.8 9588.8 9596.6 9646.1 8868.4 9279.2 9466.7 9551.7 9580.6 6874.3 6924.1 6992.4 7054.6 7081.0 5350.1 5494.9 5556.6 5702.8 5712.3 8242.8 8463.5 8523.8 8553.7 8598.4 8319.8 8599.7 8617.4 8718.3 8895.5 6163.4 6598.6 6811.5 6815.6 6923.9 7428.3 7448.6 7465.7 7476.4 7484.7 6590.9 6697.7 6712.7 6820.3 6879.9 6662.0 6668.2 6696.5 6726.0 6794.5 6192.4 6205.1 6231.5 6298.6 6298.7 4838.6 4849.2 4889.4 4945.5 5017.6 4784.4 4805.9 4842.1 4846.8 4859.2 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | [#4] prototype.html Cycles:180 Average:4599.18 Median:5330.55 stddev:1374.39 (25.8%) stddev-sans-first:1339.74 06:01:50 INFO - PROCESS | 23743 | Values: 295.2 303.9 309.3 312.1 312.9 5323.4 5396.2 5403.1 5403.6 5408.8 5312.7 5323.0 5328.7 5332.4 5334.9 3890.0 3983.4 4098.4 4103.1 4129.7 4082.0 4086.2 4092.3 4092.5 4100.1 4063.7 4069.2 4077.6 4078.7 4090.6 3793.3 4014.3 4022.6 4053.9 4101.1 3487.2 3491.4 3501.3 3502.7 3507.2 5039.5 5040.4 5049.1 5061.5 5067.5 4406.3 4637.9 4640.0 4642.0 4643.6 5563.9 5594.3 5595.5 5600.2 5604.0 3856.5 3859.0 3864.5 3865.5 3865.9 5752.4 5799.6 5832.1 5854.8 5857.7 3864.7 3912.6 3923.4 3935.9 3935.9 3963.2 3980.6 3981.2 3992.9 3998.3 4540.3 4579.9 4601.4 4602.2 4612.9 5415.2 5530.3 5565.6 5586.1 5588.0 1376.0 1380.7 1390.4 1395.9 1401.7 848.6 884.5 887.7 913.5 919.3 4856.9 4925.3 4932.5 4935.0 4956.0 5668.3 5672.6 5673.3 5681.7 5683.4 4736.1 4870.2 4902.5 4924.7 4995.4 3063.1 3090.6 3104.3 3106.2 3111.4 5489.1 5505.1 5505.2 5516.6 5529.1 5828.5 5918.0 5927.1 5962.8 5968.3 5452.3 5489.9 5489.9 5498.9 5527.3 5569.2 5735.7 5752.0 5753.9 5766.3 5593.9 5618.2 5669.5 5669.9 5684.3 5440.6 5442.8 5450.8 5457.6 5479.0 3700.7 3822.6 3836.7 3839.3 3865.8 5733.5 5739.4 5750.7 5755.0 5767.5 5529.2 5557.4 5573.0 5592.5 5638.9 5317.1 5565.9 5638.2 5645.3 5664.1 5214.2 5523.2 5524.0 5533.5 5552.1 5503.6 5623.2 5626.5 5641.1 5642.3 5488.2 5515.3 5537.7 5543.6 5555.4 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - PROCESS | 23743 | [#5] yui.html Cycles:180 Average:12712.58 Median:22728.45 stddev:13999.35 (61.6%) stddev-sans-first:14009.21 06:01:50 INFO - PROCESS | 23743 | Values: 628.9 674.3 683.9 689.2 755.8 11247.6 11299.5 11474.5 11488.4 12039.5 12816.0 12907.9 12980.4 12986.0 12987.4 638.1 797.5 815.8 815.8 816.5 778.6 803.2 805.6 806.3 806.4 850.9 852.1 852.3 853.5 857.2 848.8 849.6 850.5 851.2 853.7 628.2 629.2 631.1 632.3 633.1 12137.6 12231.7 12236.1 12243.6 12256.1 12630.6 12846.9 12916.7 12983.5 13023.1 10057.5 10126.4 10285.9 10362.9 10420.7 3253.9 3351.5 3407.7 3415.6 3502.2 44851.3 45127.1 45223.3 45480.0 45674.5 10140.8 10210.9 10261.8 10388.4 10630.3 17476.4 18086.1 18227.3 18259.5 18284.3 7108.7 7121.8 7221.7 7296.8 7307.1 3849.8 3897.5 3927.1 3944.6 3965.4 2791.5 2861.6 2866.2 2875.9 2880.5 500.2 501.2 511.2 512.1 514.1 543.7 565.7 622.6 664.5 672.6 7444.8 7506.3 7647.0 7674.5 7726.9 506.8 566.2 596.1 611.7 641.4 3344.0 3505.1 3970.0 4132.7 4237.5 47373.3 49029.0 49705.0 50088.7 50626.5 46020.3 46217.5 46341.8 46441.3 47292.3 41083.4 41272.2 41324.2 41991.8 42292.8 8381.6 8439.5 8488.4 8530.7 8660.3 28313.2 28424.3 28686.9 29179.7 29429.3 34886.3 36639.8 37499.0 38062.8 38387.4 10915.9 10964.9 11044.6 11058.6 11065.2 12003.6 12247.6 12285.5 12996.1 13092.7 11093.6 11178.0 11300.5 11709.2 11747.1 11850.6 12076.9 12080.2 12116.2 12161.3 9497.8 10395.6 10532.0 10793.5 11352.7 9746.4 9768.7 9785.5 9833.5 10417.9 9517.6 9873.6 9874.6 9915.4 9998.9 06:01:50 INFO - PROCESS | 23743 | -------- Summary: end -------- 06:01:50 INFO - PROCESS | 23743 | 06:01:50 INFO - TEST-INFO | 23743: exit 0 06:01:50 INFO - TEST-OK | dromaeo_css | took 1115837ms 06:01:50 INFO - TEST-START | kraken 06:01:50 INFO - operating with platform_type : linux_ 06:01:50 INFO - Initialising browser for kraken test... 06:01:50 INFO - TEST-INFO | started process 23971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqSvKX4/profile http://localhost:43952/getInfo.html) 06:01:54 INFO - PROCESS | 23971 | 06:01:54 INFO - PROCESS | 23971 | (process:24039): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:01:55 INFO - PROCESS | 23971 | __metrics Screen width/height:1600/1200 06:01:55 INFO - PROCESS | 23971 | colorDepth:24 06:01:55 INFO - PROCESS | 23971 | Browser inner width/height: 1024/697 06:01:55 INFO - PROCESS | 23971 | __metrics 06:01:56 ERROR - PROCESS | 23971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:01:57 INFO - TEST-INFO | 23971: exit 0 06:01:57 INFO - Browser initialized. 06:01:57 INFO - Running cycle 1/1 for kraken test... 06:01:57 INFO - TEST-INFO | started process 24090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqSvKX4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:59 INFO - PROCESS | 24090 | 06:01:59 INFO - PROCESS | 24090 | (process:24149): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:09 INFO - PROCESS | 24090 | RSS: Main: 164900864 06:02:09 INFO - PROCESS | 24090 | 06:02:11 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43952/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:12 INFO - PROCESS | 24090 | RSS: Main: 169283584 06:02:12 INFO - PROCESS | 24090 | 06:02:15 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43952/tests/kraken/driver.html?testName=audio-dft) 06:02:16 INFO - PROCESS | 24090 | RSS: Main: 172875776 06:02:16 INFO - PROCESS | 24090 | 06:02:19 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43952/tests/kraken/driver.html?testName=audio-fft) 06:02:19 INFO - PROCESS | 24090 | RSS: Main: 163373056 06:02:19 INFO - PROCESS | 24090 | 06:02:22 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43952/tests/kraken/driver.html?testName=audio-oscillator) 06:02:22 INFO - PROCESS | 24090 | RSS: Main: 164139008 06:02:22 INFO - PROCESS | 24090 | 06:02:24 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:25 INFO - PROCESS | 24090 | RSS: Main: 164679680 06:02:25 INFO - PROCESS | 24090 | 06:02:28 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43952/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:29 INFO - PROCESS | 24090 | RSS: Main: 165515264 06:02:29 INFO - PROCESS | 24090 | 06:02:32 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43952/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:33 INFO - PROCESS | 24090 | RSS: Main: 165163008 06:02:33 INFO - PROCESS | 24090 | 06:02:36 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43952/tests/kraken/driver.html?testName=json-parse-financial) 06:02:37 INFO - PROCESS | 24090 | RSS: Main: 165728256 06:02:37 INFO - PROCESS | 24090 | 06:02:38 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:39 INFO - PROCESS | 24090 | RSS: Main: 165974016 06:02:39 INFO - PROCESS | 24090 | 06:02:41 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:41 INFO - PROCESS | 24090 | RSS: Main: 165847040 06:02:41 INFO - PROCESS | 24090 | 06:02:43 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:44 INFO - PROCESS | 24090 | RSS: Main: 166346752 06:02:44 INFO - PROCESS | 24090 | 06:02:47 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:48 INFO - PROCESS | 24090 | RSS: Main: 166547456 06:02:48 INFO - PROCESS | 24090 | 06:02:51 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:51 INFO - PROCESS | 24090 | RSS: Main: 166182912 06:02:51 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | Cycle 1(1): loaded http://localhost:43952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43952/tests/kraken/driver.html?testName=ai-astar) 06:02:53 INFO - PROCESS | 24090 | RSS: Main: 167755776 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | __start_tp_report 06:02:53 INFO - PROCESS | 24090 | _x_x_mozilla_page_load 06:02:53 INFO - PROCESS | 24090 | _x_x_mozilla_page_load_details 06:02:53 INFO - PROCESS | 24090 | |i|pagename|runs| 06:02:53 INFO - PROCESS | 24090 | |0;ai-astar;114;109;113;116;115;128;114;118;114;112 06:02:53 INFO - PROCESS | 24090 | |1;audio-beat-detection;164;131;153;183;148;154;154;133;185;133 06:02:53 INFO - PROCESS | 24090 | |2;audio-dft;163;165;163;169;167;161;162;163;163;163 06:02:53 INFO - PROCESS | 24090 | |3;audio-fft;78;76;73;150;77;74;78;74;151;75 06:02:53 INFO - PROCESS | 24090 | |4;audio-oscillator;94;95;146;94;96;95;145;95;93;145 06:02:53 INFO - PROCESS | 24090 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;118;118;117 06:02:53 INFO - PROCESS | 24090 | |6;imaging-darkroom;148;147;148;147;148;147;148;147;147;147 06:02:53 INFO - PROCESS | 24090 | |7;imaging-desaturate;95;96;95;95;96;96;96;96;96;95 06:02:53 INFO - PROCESS | 24090 | |8;json-parse-financial;65;64;65;65;66;64;67;81;63;64 06:02:53 INFO - PROCESS | 24090 | |9;json-stringify-tinderbox;65;65;65;65;65;64;64;71;64;65 06:02:53 INFO - PROCESS | 24090 | |10;stanford-crypto-aes;81;80;81;81;81;81;81;81;81;81 06:02:53 INFO - PROCESS | 24090 | |11;stanford-crypto-ccm;138;137;134;138;144;131;143;146;169;138 06:02:53 INFO - PROCESS | 24090 | |12;stanford-crypto-pbkdf2;182;183;182;182;186;177;177;178;182;179 06:02:53 INFO - PROCESS | 24090 | |13;stanford-crypto-sha256-iterative;73;79;77;73;73;73;73;73;72;75 06:02:53 INFO - PROCESS | 24090 | __end_tp_report 06:02:53 INFO - PROCESS | 24090 | __start_cc_report 06:02:53 INFO - PROCESS | 24090 | _x_x_mozilla_cycle_collect,909 06:02:53 INFO - PROCESS | 24090 | __end_cc_report 06:02:53 INFO - PROCESS | 24090 | __startTimestamp1461243773815__endTimestamp 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | ------- Summary: start ------- 06:02:53 INFO - PROCESS | 24090 | Number of tests: 14 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.50 stddev:5.06 (4.4%) stddev-sans-first:5.34 06:02:53 INFO - PROCESS | 24090 | Values: 114.0 109.0 113.0 116.0 115.0 128.0 114.0 118.0 114.0 112.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:154.00 stddev:19.29 (12.5%) stddev-sans-first:20.11 06:02:53 INFO - PROCESS | 24090 | Values: 164.0 131.0 153.0 183.0 148.0 154.0 154.0 133.0 185.0 133.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.42 (1.5%) stddev-sans-first:2.55 06:02:53 INFO - PROCESS | 24090 | Values: 163.0 165.0 163.0 169.0 167.0 161.0 162.0 163.0 163.0 163.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#3] audio-fft Cycles:10 Average:90.60 Median:75.50 stddev:31.62 (41.9%) stddev-sans-first:33.20 06:02:53 INFO - PROCESS | 24090 | Values: 78.0 76.0 73.0 150.0 77.0 74.0 78.0 74.0 151.0 75.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.50 stddev:24.53 (26.0%) stddev-sans-first:25.35 06:02:53 INFO - PROCESS | 24090 | Values: 94.0 95.0 146.0 94.0 96.0 95.0 145.0 95.0 93.0 145.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:02:53 INFO - PROCESS | 24090 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:02:53 INFO - PROCESS | 24090 | Values: 148.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:02:53 INFO - PROCESS | 24090 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.00 stddev:5.25 (8.1%) stddev-sans-first:5.55 06:02:53 INFO - PROCESS | 24090 | Values: 65.0 64.0 65.0 65.0 66.0 64.0 67.0 81.0 63.0 64.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:2.06 (3.2%) stddev-sans-first:2.18 06:02:53 INFO - PROCESS | 24090 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 64.0 71.0 64.0 65.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 06:02:53 INFO - PROCESS | 24090 | Values: 81.0 80.0 81.0 81.0 81.0 81.0 81.0 81.0 81.0 81.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:140.50 stddev:10.58 (7.5%) stddev-sans-first:11.13 06:02:53 INFO - PROCESS | 24090 | Values: 138.0 137.0 134.0 138.0 144.0 131.0 143.0 146.0 169.0 138.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:182.00 stddev:2.94 (1.6%) stddev-sans-first:3.08 06:02:53 INFO - PROCESS | 24090 | Values: 182.0 183.0 182.0 182.0 186.0 177.0 177.0 178.0 182.0 179.0 06:02:53 INFO - PROCESS | 24090 | 06:02:53 INFO - PROCESS | 24090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:73.00 stddev:2.23 (3.1%) stddev-sans-first:2.33 06:02:53 INFO - PROCESS | 24090 | Values: 73.0 79.0 77.0 73.0 73.0 73.0 73.0 73.0 72.0 75.0 06:02:53 INFO - PROCESS | 24090 | -------- Summary: end -------- 06:02:53 INFO - PROCESS | 24090 | 06:02:54 INFO - TEST-INFO | 24090: exit 0 06:02:54 INFO - TEST-OK | kraken | took 64095ms 06:02:54 INFO - SUITE-END | took 1179s 06:02:54 INFO - Completed test suite (00:19:40) 06:02:54 INFO - javascript benchmark 06:02:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.194249782567, 2675.906343277986, 2698.0287096645193, 2701.405690748036, 2702.405470796424, 4700.247960326348, 4709.57613814757, 4734.597559207472, 4734.73958932259, 4769.0, 4674.08855273221, 4746.881327966803, 4772.761361931907, 4811.711297322163, 4815.157347464197, 4335.761533115685, 4437.977810110945, 4464.799084041226, 4469.195544801951, 4469.418975533176, 579.4089130778212, 4235.428217190686, 4341.066670665807, 4370.6503479721705, 4389.846355377563, 4406.405135306724, 4407.955920440802, 4415.028693687384, 4419.447569053868, 4437.134758722051, 4256.106217694288, 4422.7346359218545, 4445.355423463612, 4469.888252793674, 4471.7987690554, 4254.106637606106, 4288.849890253858, 4292.399064130993, 4308.978455107705, 4344.869653910388, 4583.0, 4595.448546174447, 4643.582077612998, 4653.720776753372, 4713.293006049086, 5016.3980322361185, 5043.62172837035, 5074.797008119671, 5099.617528685327, 5194.246834209019, 4971.527704868032, 4985.152524070917, 5001.44984051754, 5019.0463811875625, 5056.064628043824, 4631.120087183424, 4674.252119660872, 4675.95324046762, 4694.906101877943, 4726.409198850144, 5050.6464547482055, 5154.046501397253, 5256.316678831728, 5325.680459172462, 5336.573074154058, 4912.754362281871, 4920.803167873245, 4940.481249468826, 4948.777305021211, 4984.875378115504, 4988.6757360771435, 4994.80020799164, 5000.74996250186, 5003.449620541737, 5050.974745126325, 4857.53853383928, 5047.066292735855, 5081.568066714371, 5129.589632829365, 5137.357830271216, 4844.733539655353, 5086.847394578169, 5087.592992560586, 5091.0, 5136.512031357015, 4142.668586513072, 4181.310083836193, 4203.306454434984, 4219.831206751757, 4224.366345048267, 3631.963680363215, 3688.5389326334207, 3746.325661380923, 3747.306748251582, 3784.148566572554, 4452.799624016927, 4466.665000125004, 4478.888027799331, 4506.684532082722, 4507.8196872124745, 4989.825356112518, 5095.617828662791, 5103.106956282636, 5112.642115051911, 5113.974430127825, 4402.84590039347, 4448.266036104006, 4450.3991961085485, 4471.865844024619, 4483.484399294058, 4536.251518499411, 4554.362389265505, 4565.931511027337, 4579.610733087658, 4597.931031034537, 4673.275642275453, 4851.320815085962, 4852.102361063215, 4853.39332583427, 4858.3441235432765, 5086.338775959101, 5118.104331742004, 5124.0, 5126.7949282029795, 5166.819161329336, 4830.565249127595, 4847.200211964986, 4855.490173531728, 4873.366462359871, 4917.28699338601, 4892.90214195707, 4915.901681966412, 4943.975280123576, 5038.647294689336, 5107.208382700687, 5072.264521644267, 5100.897982040413, 5102.540771330598, 5110.386753589444, 5149.459306772885, 4920.6801557898625, 4947.356843610308, 4959.603231741524, 4967.956729086933, 5003.849884503471, 4756.16767065769, 4919.220387424613, 4970.428400733962, 5041.924371134362, 5064.290999260033, 4642.953570464388, 4881.609471242363, 4901.3383193268455, 4914.92627610579, 5010.448850626355, 4994.5754610858485, 5021.372328458942, 5022.799088036438, 5025.522575355335, 5047.2429135629945, 4719.1977363847545, 4819.518048195152, 4901.0, 4915.7542122893, 4925.950740492549], "value": 4633.162087415185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1998967044757, 582.551435394746, 587.441930166342, 601.9255628702766, 628.3057221769941, 33477.33045339095, 34920.82539587305, 34978.475322870174, 35039.124021899464, 35111.12222194443, 35753.64246357536, 36344.2731145377, 36376.09059773507, 36464.453033204525, 36490.27019459616, 7525.736599219014, 7754.457187996843, 7776.105747838986, 7792.064952205743, 7807.375409967218, 7619.1238007629, 7965.761027169166, 7969.920300796975, 7980.680772769082, 7982.042154941415, 7953.681852725884, 8003.679852805881, 8012.719554815582, 8028.0, 8032.518048917054, 7885.921140788605, 7947.642356093989, 7967.402444816662, 7987.640556174986, 8002.799930001738, 7771.883421748678, 7842.686292548291, 7851.842963140763, 7868.960655196687, 7898.0, 28205.576916346272, 35853.64146358529, 36298.63701362979, 36344.0, 36364.81817590895, 2979.0467050543834, 3019.8545958973605, 3175.8094514329214, 3301.8018918864705, 3529.5764508258917, 27133.86433067822, 27306.31734206641, 27442.862785686142, 27628.171154865388, 27738.861305693343, 3410.2497450560836, 3499.475078738184, 3585.8386372613295, 3591.7665351752053, 3634.254977729559, 186781.0, 190675.04662476736, 190675.04662476736, 191242.0, 191528.0, 33750.32499349999, 52970.20544691833, 53018.20472692913, 53138.0, 53398.19902701463, 34174.82912585421, 34460.31079378448, 34481.31037379238, 34627.30745385078, 34679.0, 12696.0, 12926.547570834975, 13029.283389413484, 13031.08782385243, 13046.0, 10555.788884222273, 10661.307015043998, 10662.626808061681, 10670.30643008202, 10674.679759607225, 8086.959565202136, 8198.467099638505, 8297.8340433191, 8331.750047498463, 8388.412811103286, 3275.901722948315, 3287.506873968876, 3293.374258890803, 3310.6854848789326, 3352.1619595101224, 879.4679219072497, 884.6815146547237, 937.9812403752023, 954.6515521834481, 994.3636072913341, 27111.1866644001, 28429.431411371657, 29146.271343216165, 29177.270568235963, 29181.854090729412, 988.3990026426994, 1031.8039572481205, 1052.1740433759462, 1076.3649446826253, 1081.6863109698256, 14860.70278594422, 15167.255143151608, 15470.071795692294, 15575.922120389325, 15583.688326233412, 357782.0, 362127.0, 364971.0, 365773.0, 365909.0, 48718.512814872105, 49720.50279497231, 49768.50231497711, 49924.50075499271, 50084.749576252616, 1184.3841202574786, 1212.6543934978488, 1223.088798844884, 1234.4259919137464, 1246.9127161098636, 27251.0, 28302.85848570744, 28546.714532854407, 28591.714082858904, 28909.0, 44113.11773764571, 44630.107397851214, 44799.0, 45026.0, 45201.773991129834, 298620.0, 299574.0, 302069.0, 302191.0, 302532.0, 25986.61020084738, 26221.73778262193, 26382.340441489116, 26527.469450611265, 26650.0, 42412.15175696531, 42750.78624606857, 43141.13717725565, 43281.134377312905, 43486.13027739364, 35907.28185436224, 37032.444513331786, 37281.0, 37572.060698482754, 38108.80945595254, 36279.81860090682, 36319.45520817137, 36534.45198321974, 37150.814245928595, 37644.247115057, 36086.819565902006, 36423.635763643084, 36665.26669466649, 37134.0, 37355.252894942496, 32369.838150809097, 33003.0, 33049.0, 33484.83257583697, 33682.66317336795, 25494.0, 25543.36141596475, 25614.743852561234, 25631.0, 25964.740352596233], "value": 16380.005844513316, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9297133544627, 370.6367759595596, 374.47386422076977, 374.6833925333094, 385.79167249685173, 15722.0, 15819.604509887258, 16009.439669611565, 16105.27526261318, 16268.43060492883, 15661.843381566181, 16720.83279167208, 17078.573035674115, 17083.0, 17097.059661718602, 4887.511248875102, 5155.5360017598405, 5189.0, 5211.088059589576, 5211.661242019257, 3609.8375573099274, 5129.9230511542355, 5507.146392309179, 5774.1050137228585, 5802.448767367094, 5712.1431785232135, 5725.026745453262, 5730.484256416921, 5732.570057245724, 5778.42215778423, 5629.127485239795, 5727.427257274281, 5786.739596718157, 5789.768409263625, 5801.477866991949, 4896.167651499253, 4986.052649996489, 5056.342675452204, 5056.898862022776, 5067.695938243717, 19755.901220493804, 19845.70231446515, 20020.399388018384, 20045.298414555567, 20061.79938200614, 1839.0712690091552, 1868.588910439701, 1874.2128306111329, 1908.895010774407, 1957.2562426277923, 12643.114981951267, 12845.67885802853, 12880.420381082873, 13556.86443135566, 13760.65598360039, 1722.3110755697821, 1808.7467754514378, 1846.0861873372633, 1890.5557194059386, 1920.9231630734753, 62804.68597657028, 63149.68425157891, 64434.0, 64611.353886461475, 65440.3455965439, 9067.637294508279, 9079.137481939206, 9288.396254243453, 9445.433274003582, 9458.52707364629, 12622.368881555885, 12729.83592789228, 12733.681657958625, 12737.681557961125, 12786.296753678636, 6967.0, 7186.568805871664, 7263.405255287273, 7315.817104572322, 7316.268373162748, 6890.586564806128, 7007.369336759614, 7040.5071644984355, 7054.470914681419, 7114.92885071153, 5950.2264705587995, 5997.880042399128, 6007.27912650476, 6035.124906888476, 6107.633541987495, 1539.6766678997312, 1629.5681644364254, 1671.7910261217348, 1699.4731633193503, 1714.1686282153146, 887.5606574745542, 909.7862002429424, 935.5509355509394, 951.3673407184283, 1004.4224570871631, 16361.509154725378, 16651.250693718568, 16785.24466399015, 17174.22715977784, 17191.0, 890.9955450222708, 903.6656437118309, 918.3846822628722, 922.285228947571, 951.6669165791917, 9533.332666713264, 9605.13553780163, 9667.371620844622, 9767.462789546644, 9831.262655300738, 276395.0, 284747.0, 385111.0, 388486.0, 390516.0, 77992.0, 80397.0, 81303.5934820334, 83880.0, 84373.15626843653, 995.5072239241622, 1003.2876657573205, 1046.9895301046893, 1050.2648146297622, 1050.9527071281811, 13929.23389213603, 15034.248287585795, 15052.0, 15130.924345378202, 15252.542423726862, 31707.682923171396, 32912.506312404854, 33222.667773321955, 33846.0, 34171.4874276891, 44994.77502612466, 46070.53929460797, 46074.0, 46103.0, 46208.53791462177, 7588.778338284866, 7631.0, 7870.645820938186, 7877.645505952131, 7897.210278972057, 7778.688852445839, 11036.337819730841, 11376.488058037574, 11378.772424551627, 11392.430378480876, 10139.493025348851, 10255.384676919408, 10272.640457583948, 10307.587696492057, 10622.787544248917, 10030.097291243532, 10055.29612927088, 10173.186145108522, 10221.795564088825, 10286.948565257126, 10440.060394564525, 10446.843297350393, 10491.422971736323, 10611.151107911503, 10647.254692171473, 7329.267073292628, 7710.267524585155, 7837.882431763642, 7889.487183333065, 8010.319122874621, 10320.380777153396, 10605.098566621924, 10656.094231990368, 10907.29102608328, 11004.669859904216], "value": 8267.379059585466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.0190669391463, 1440.1215258692196, 1570.8664763495103, 1715.7169067103928, 1743.5118166913269, 6883.655817209132, 7427.554346739199, 7446.925530744697, 7678.692852285909, 7750.108737495189, 7428.7028518859315, 7433.219511951248, 7468.327850493454, 7478.813029674261, 7494.81262968426, 2215.213599172299, 2247.9775202248015, 2261.1407665087245, 2264.852784569006, 2266.3654176830432, 2192.6491761318193, 2233.776622337761, 2237.3847192022163, 2242.5627002734473, 2247.910083596654, 2227.2204728345114, 2228.454028762955, 2245.65192395179, 2262.3778460923213, 2264.784845439681, 2156.439325775294, 2156.9784302156936, 2163.7619861815265, 2166.144372972675, 2168.3386567097027, 2166.696662467256, 2177.031221106608, 2182.19258874216, 2182.618041842671, 2190.605690975624, 7481.513701609432, 7595.658195381221, 7605.923940760632, 7623.466357354987, 7633.007708997795, 4474.261746811805, 4577.153226653079, 4590.609798167126, 4641.76791160444, 4647.883802904955, 2814.690384057752, 2913.03869722993, 2916.854157292148, 2927.970720292791, 2935.368895687416, 954.9809003819954, 963.9036096390375, 978.8972157923387, 985.3595163143942, 987.2694206287367, 10512.106470949979, 10529.36823790575, 10565.9471702641, 10606.310589811637, 10634.361938283728, 4177.561356057631, 4212.094399704079, 4379.0585024219945, 4389.582989615981, 4433.0, 8999.82000359989, 9004.189622933967, 9045.547722613843, 9068.183863452321, 9069.18377346042, 4621.930671039937, 4634.443866736014, 4647.209974304376, 4658.627309815207, 4663.044075964419, 3649.489071529988, 4078.7960601969785, 4199.538050814408, 4203.222403855297, 4236.08924081324, 3670.1742108025483, 3686.2627474505207, 3786.7917264550715, 3793.5447746270625, 3820.3696390095324, 1178.5933852820763, 1209.6975756060986, 1211.42457332768, 1215.3133479584008, 1240.3240234072452, 836.1304243586602, 838.6813011055759, 855.6021450025768, 877.1491653096487, 884.3190743127756, 5428.75570599324, 5453.672779633234, 5511.063119269734, 5518.365387980433, 5569.805056822992, 428.54146063712153, 431.2474731593327, 431.2926800047924, 435.7189612699791, 439.4572702712148, 3802.4866643002842, 3806.1245913440066, 3912.9630647878334, 3914.72596918213, 3914.980425097913, 9111.726648200565, 9548.761280968032, 9588.76028099303, 9596.616135354647, 9646.083622055894, 8868.379213455126, 9279.211267042241, 9466.715998520056, 9551.665691700757, 9580.56887440053, 6874.312568743086, 6924.099867017357, 6992.440604751608, 7054.576725396492, 7080.964595177094, 5350.117230656898, 5494.890102197854, 5556.555475561864, 5702.8289151325525, 5712.285964254468, 8242.793930151794, 8463.53450560225, 8523.82952340962, 8553.74338769838, 8598.355123365898, 8319.792005199919, 8599.656013759379, 8617.353698472514, 8718.302535796995, 8895.510746908982, 6163.3528479509005, 6598.60408375499, 6811.523193376416, 6815.556988795713, 6923.861522769415, 7428.331450169295, 7448.590327531821, 7465.664045117874, 7476.439267054884, 7484.70061197546, 6590.868182636416, 6697.665116744241, 6712.697928593323, 6820.31796820314, 6879.89680154788, 6662.0, 6668.166479190101, 6696.4977626679165, 6725.9663701681175, 6794.524383293122, 6192.442680158807, 6205.131281620667, 6231.53263505248, 6298.559100862895, 6298.748050077946, 4838.637102217277, 4849.224124140121, 4889.3888263967, 4945.455999840086, 5017.623678224075, 4784.425868895755, 4805.918668299604, 4842.104210721028, 4846.80612775485, 4859.246816743411], "value": 4093.4427827910167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1617406565354, 303.9240189952512, 309.2531536339739, 312.0653642341187, 312.9170769746016, 5323.3878104018, 5396.163594642827, 5403.081476149055, 5403.594730395226, 5408.810691625789, 5312.654677445963, 5322.973385133069, 5328.653637513559, 5332.440093790155, 5334.946650533493, 3889.988602963229, 3983.40248962655, 4098.446709694183, 4103.138340948404, 4129.710920235585, 4081.979590102045, 4086.223617512663, 4092.263392589333, 4092.4679791627045, 4100.097978444737, 4063.6545893599077, 4069.2268468990947, 4077.5514693383852, 4078.6940979426513, 4090.550039495653, 3793.2792769374005, 4014.3376342903384, 4022.577629348935, 4053.918921621566, 4101.056756945889, 3487.1630808606005, 3491.4413693809124, 3501.2997400519744, 3502.737294702882, 3507.2108775525558, 5039.546440820307, 5040.36995375578, 5049.1164046292115, 5061.468545802674, 5067.518585734386, 4406.317020861771, 4637.86086417408, 4640.027988105042, 4641.976790116028, 4643.605293550052, 5563.887222555464, 5594.272744543224, 5595.524380427669, 5600.1599760035915, 5603.971980140114, 3856.4986551748093, 3859.0, 3864.536255649312, 3865.4781604483314, 3865.8646947356706, 5752.395998420147, 5799.623024503394, 5832.125181222808, 5854.795082172103, 5857.6778277194735, 3864.7294689371474, 3912.628300311466, 3923.43110249018, 3935.8819235422984, 3935.9016024599614, 3963.1677347757295, 3980.606787624366, 3981.22366138606, 3992.920141597152, 3998.300297447935, 4540.250858608359, 4579.9084018319445, 4601.401817763736, 4602.217623004098, 4612.907741845144, 5415.187721841677, 5530.281063461724, 5565.582581306418, 5586.078297081018, 5587.994161050969, 1375.9656008599866, 1380.6617378742071, 1390.4160252693894, 1395.9022868399115, 1401.7126489069717, 848.6435697007272, 884.4825776920574, 887.658251573149, 913.4701872913694, 919.2599957034652, 4856.891589382798, 4925.335079764258, 4932.482089380635, 4934.950650493521, 4955.975220123876, 5668.319801623749, 5672.5745569081655, 5673.290838645169, 5681.659100453986, 5683.374828768832, 4736.123817093849, 4870.172070747982, 4902.534259245366, 4924.679895806761, 4995.350604421402, 3063.1270088025253, 3090.5673205751214, 3104.301532155292, 3106.1923899785766, 3111.4131792785843, 5489.149181876815, 5505.146702261156, 5505.201745746845, 5516.586256030814, 5529.060059789846, 5828.5337173026055, 5917.970410147922, 5927.081302398135, 5962.809896705242, 5968.343482216953, 5452.345718513804, 5489.917651235235, 5489.945100548944, 5498.862528436741, 5527.336719593513, 5569.192467092168, 5735.655860648374, 5751.971240143773, 5753.884922301614, 5766.308043034863, 5593.888122237451, 5618.2415373924, 5669.518090962314, 5669.914951275651, 5684.289463817023, 5440.591955603267, 5442.782288708566, 5450.836474905759, 5457.5633949283165, 5478.972605136949, 3700.7489254763614, 3822.636849499293, 3836.681270700768, 3839.2897313997, 3865.7873816940337, 5733.499203125526, 5739.397363276963, 5750.654960702372, 5754.971225144015, 5767.509761670305, 5529.203009022003, 5557.44425557441, 5572.972135139461, 5592.496675299242, 5638.9286035653095, 5317.096093664164, 5565.909056843298, 5638.154276858504, 5645.294338207724, 5664.122061080539, 5214.217867319932, 5523.226748255328, 5523.972380138234, 5533.529649979797, 5552.083906155439, 5503.642263252876, 5623.184638227516, 5626.521745651666, 5641.12562552805, 5642.322921249476, 5488.231647569263, 5515.310586176728, 5537.667739935617, 5543.6396634218645, 5555.416681248573], "value": 4153.162277117179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.852219728364, 674.27852198148, 683.8974153876915, 689.2142957028987, 755.792157156782, 11247.55009799607, 11299.49152288147, 11474.541018359267, 11488.36813975231, 12039.51841926323, 12816.0, 12907.870921290783, 12980.415881285342, 12986.0, 12987.415566299516, 638.141699414287, 797.4736673795296, 815.804206990324, 815.8123631564744, 816.5304949653943, 778.5523324088643, 803.1887793328722, 805.6012273924416, 806.2662976691212, 806.3589446390105, 850.9446885952424, 852.0584753847003, 852.2968550945463, 853.4921721575683, 857.1642648417806, 848.8429640516524, 849.6049337058298, 850.4982060584254, 851.2083762101244, 853.6670698427619, 628.1645411602603, 629.2166253015025, 631.1416473595906, 632.3265722006049, 633.1294470103608, 12137.635870923887, 12231.69420764479, 12236.082293827998, 12243.632691019284, 12256.08079394049, 12630.557930472482, 12846.871531284662, 12916.677083072904, 12983.480660773557, 13023.088383813138, 10057.497125143713, 10126.443045632488, 10285.897141028569, 10362.948185259025, 10420.739481513023, 3253.886113986023, 3351.463765797485, 3407.6762707542744, 3415.573053368329, 3502.159481724393, 44851.32723009158, 45127.09745805065, 45223.321650175276, 45480.0, 45674.543254567696, 10140.797184056277, 10210.948945255375, 10261.794764104676, 10388.37669739818, 10630.30902991303, 17476.388326408516, 18086.095695215186, 18227.270909163486, 18259.45221643353, 18284.268629254948, 7108.725207933515, 7121.821954451077, 7221.675024623904, 7296.7810965671115, 7307.086614173229, 3849.8075096245075, 3897.4543563901075, 3927.096767743435, 3944.6055394460323, 3965.4250133730447, 2791.511485490031, 2861.570764385359, 2866.1831378057154, 2875.856207189632, 2880.5391137417914, 500.1921896137784, 501.24812780828756, 511.15659162381627, 512.1319363678529, 514.0977584339461, 543.7199842081332, 565.6690835861067, 622.6419808610067, 664.5281849886538, 672.559473544829, 7444.813879653052, 7506.3244308012545, 7646.9617651911385, 7674.53952762836, 7726.922730772732, 506.8200788720025, 566.1649067625302, 596.1058412381428, 611.6635850282416, 641.4227195523972, 3343.9665603343656, 3505.053635518396, 3969.955487777681, 4132.73137246078, 4237.512686041083, 47373.289400659014, 49029.0, 49705.0, 50088.74955625198, 50626.49373506218, 46020.3096953546, 46217.537824622, 46341.768291158325, 46441.30338044932, 47292.29061564079, 41083.38374924379, 41272.174556508704, 41324.1735165301, 41991.7900410496, 42292.788536057735, 8381.622826972924, 8439.535825529654, 8488.448250863674, 8530.701425450328, 8660.263877570476, 28313.150605481867, 28424.289392765346, 28686.856565717037, 29179.7082029177, 29429.26426839346, 34886.30227395387, 36639.816800915825, 37499.0, 38062.80968595139, 38387.42418863775, 10915.890841091488, 10964.945175274073, 11044.613438529614, 11058.612948547085, 11065.170112241452, 12003.579874704343, 12247.632571022883, 12285.508579656713, 12996.090273680751, 13092.672683182996, 11093.611723589636, 11178.0, 11300.547978080785, 11709.238899471507, 11747.060235181336, 11850.644480665595, 12076.879231207928, 12080.154389192672, 12116.15186936906, 12161.270323780602, 9497.810043799223, 10395.58417663285, 10532.0, 10793.460326983777, 11352.659420217407, 9746.415215087118, 9768.706938791847, 9785.461799601091, 9833.459159746282, 10417.9479102604, 9517.571709272961, 9873.555689993824, 9874.55564499585, 9915.405075695482, 9998.900010999796], "value": 5991.158770445982, "unit": "score"}], "name": "dromaeo_css", "value": 6323.10332056619, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 116.0, 115.0, 128.0, 114.0, 118.0, 114.0, 112.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 153.0, 183.0, 148.0, 154.0, 154.0, 133.0, 185.0, 133.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 169.0, 167.0, 161.0, 162.0, 163.0, 163.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 73.0, 150.0, 77.0, 74.0, 78.0, 74.0, 151.0, 75.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 146.0, 94.0, 96.0, 95.0, 145.0, 95.0, 93.0, 145.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 64.0, 67.0, 81.0, 63.0, 64.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 71.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 134.0, 138.0, 144.0, 131.0, 143.0, 146.0, 169.0, 138.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 182.0, 186.0, 177.0, 177.0, 178.0, 182.0, 179.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 77.0, 73.0, 73.0, 73.0, 73.0, 73.0, 72.0, 75.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1603.1999999999998, "alertThreshold": 2.0}]} 06:02:55 INFO - Return code: 0 06:02:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:02:55 ERROR - # TBPL SUCCESS # 06:02:55 INFO - Running post-action listener: _resource_record_post_action 06:02:55 INFO - Running post-run listener: _resource_record_post_run 06:02:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 394162176; Read time: 0; Write time: 350132 06:02:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110346240; Read time: 0; Write time: 125524 06:02:56 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 283815936; Read time: 0; Write time: 224608 06:02:56 INFO - Running post-run listener: _upload_blobber_files 06:02:56 INFO - Blob upload gear active. 06:02:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02:56 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 06:02:56 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'] 06:02:56 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 06:02:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:57 INFO - (blobuploader) - INFO - Done attempting. 06:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:58 INFO - (blobuploader) - INFO - Done attempting. 06:02:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:58 INFO - Return code: 0 06:02:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79643908453e1c668e50e712496794fb4df980c198c77d24864a82cd334ca140ca8bcafdfb187bf65a54162bcb79f435e565b2a296aced13340f126396e00adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a42c9738177d90dae94e2ebb00e8a8ea05332f39604f7535573fce55dc8af3193ccaacf9c34af6370c252c8f5397492291b386e54d90433d331da1e1dcd6ce2"} 06:02:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:58 INFO - Contents: 06:02:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79643908453e1c668e50e712496794fb4df980c198c77d24864a82cd334ca140ca8bcafdfb187bf65a54162bcb79f435e565b2a296aced13340f126396e00adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a42c9738177d90dae94e2ebb00e8a8ea05332f39604f7535573fce55dc8af3193ccaacf9c34af6370c252c8f5397492291b386e54d90433d331da1e1dcd6ce2"} 06:02:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:58 INFO - Copying logs to upload dir... 06:02:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.208400 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-21 06:02:58.121801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:02:58.125395) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570 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/79643908453e1c668e50e712496794fb4df980c198c77d24864a82cd334ca140ca8bcafdfb187bf65a54162bcb79f435e565b2a296aced13340f126396e00adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a42c9738177d90dae94e2ebb00e8a8ea05332f39604f7535573fce55dc8af3193ccaacf9c34af6370c252c8f5397492291b386e54d90433d331da1e1dcd6ce2"} build_url:https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/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/79643908453e1c668e50e712496794fb4df980c198c77d24864a82cd334ca140ca8bcafdfb187bf65a54162bcb79f435e565b2a296aced13340f126396e00adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a42c9738177d90dae94e2ebb00e8a8ea05332f39604f7535573fce55dc8af3193ccaacf9c34af6370c252c8f5397492291b386e54d90433d331da1e1dcd6ce2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:02:58.152649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:02:58.153258) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461236608.720485-1006930570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:02:58.235849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:02:58.236179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:02:58.236476) ========= ========= Total master_lag: 0.18 =========