builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1461310035.73 results: success (0) buildid: 20160421214206 builduid: d87ec07671774d628e65ce7f47b50216 revision: 2271b0c11307 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:15.730702) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:15.731153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:15.731427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:15.749523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:15.749795) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 00:27: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-22 00:27:16 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.378050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.141587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.141903) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.191741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.192110) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2271b0c11307 --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 2271b0c11307 --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=20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 00:27:16,735 Setting DEBUG logging. 2016-04-22 00:27:16,735 attempt 1/10 2016-04-22 00:27:16,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2271b0c11307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 00:27:16,999 unpacking tar archive at: fx-team-2271b0c11307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568710 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.773627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.773990) ========= script_repo_revision: 2271b0c11307 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.774435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.774706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 00:27:16.783415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 00:27:16.783734) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:27:17 INFO - MultiFileLogger online at 20160422 00:27:17 in /builds/slave/test 00:27:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:27:17 INFO - {'append_to_log': False, 00:27:17 INFO - 'base_work_dir': '/builds/slave/test', 00:27:17 INFO - 'blob_upload_branch': 'Fx-Team', 00:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:27:17 INFO - 'branch': 'Fx-Team', 00:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 00:27:17 INFO - 'config_files': ('talos/linux_config.py',), 00:27:17 INFO - 'default_actions': ('clobber', 00:27:17 INFO - 'read-buildbot-config', 00:27:17 INFO - 'download-and-extract', 00:27:17 INFO - 'populate-webroot', 00:27:17 INFO - 'create-virtualenv', 00:27:17 INFO - 'install', 00:27:17 INFO - 'run-tests'), 00:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:27:17 INFO - 'download_minidump_stackwalk': True, 00:27:17 INFO - 'download_symbols': 'ondemand', 00:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 00:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 00:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:27:17 INFO - 'installer_path': 'installer.exe', 00:27:17 INFO - 'log_level': 'info', 00:27:17 INFO - 'log_name': 'talos', 00:27:17 INFO - 'log_to_console': True, 00:27:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:27:17 INFO - 'opt_config_files': (), 00:27:17 INFO - 'pip_index': False, 00:27:17 INFO - 'sps_profile': False, 00:27:17 INFO - 'sps_profile_interval': 0, 00:27:17 INFO - 'suite': 'dromaeojs', 00:27:17 INFO - 'system_bits': '32', 00:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:27:17 INFO - 'title': 'talos-linux64-ix-015', 00:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:27:17 INFO - 'use_talos_json': True, 00:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:27:17 INFO - 'work_dir': 'build'} 00:27:17 INFO - ##### 00:27:17 INFO - ##### Running clobber step. 00:27:17 INFO - ##### 00:27:17 INFO - Running pre-action listener: _resource_record_pre_action 00:27:17 INFO - Running main action method: clobber 00:27:17 INFO - rmtree: /builds/slave/test/build 00:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:27:17 INFO - Running post-action listener: _resource_record_post_action 00:27:17 INFO - ##### 00:27:17 INFO - ##### Running read-buildbot-config step. 00:27:17 INFO - ##### 00:27:17 INFO - Running pre-action listener: _resource_record_pre_action 00:27:17 INFO - Running main action method: read_buildbot_config 00:27:17 INFO - Using buildbot properties: 00:27:17 INFO - { 00:27:17 INFO - "project": "", 00:27:17 INFO - "product": "firefox", 00:27:17 INFO - "script_repo_revision": "production", 00:27:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:27:17 INFO - "repository": "", 00:27:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:27:17 INFO - "buildid": "20160421214206", 00:27:17 INFO - "pgo_build": "True", 00:27:17 INFO - "basedir": "/builds/slave/test", 00:27:17 INFO - "buildnumber": 598, 00:27:17 INFO - "slavename": "talos-linux64-ix-015", 00:27:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:27:17 INFO - "platform": "ubuntu64_hw", 00:27:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:27:17 INFO - "branch": "fx-team", 00:27:17 INFO - "repo_path": "integration/fx-team", 00:27:17 INFO - "revision": "2271b0c11307 ", 00:27:17 INFO - "stage_platform": "linux64-pgo", 00:27:17 INFO - "builduid": "d87ec07671774d628e65ce7f47b50216", 00:27:17 INFO - "slavebuilddir": "test" 00:27:17 INFO - } 00:27:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 00:27:17 INFO - Running post-action listener: _resource_record_post_action 00:27:17 INFO - ##### 00:27:17 INFO - ##### Running download-and-extract step. 00:27:17 INFO - ##### 00:27:17 INFO - Running pre-action listener: _resource_record_pre_action 00:27:17 INFO - Running main action method: download_and_extract 00:27:17 INFO - mkdir: /builds/slave/test/build/tests 00:27: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')]} 00:27:17 INFO - https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:27:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:27:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:27:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:20 INFO - Downloaded 1361 bytes. 00:27:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:27:20 INFO - Using the following test package requirements: 00:27:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:27:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:27:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:27:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'jsshell-linux-x86_64.zip'], 00:27:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:27:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:27:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:27:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:27:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:27:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:27:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:27:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:20 INFO - https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:23 INFO - Downloaded 23853872 bytes. 00:27:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:27:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:27:24 INFO - Return code: 0 00:27:24 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 00:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:24 INFO - https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:32 INFO - Downloaded 23853872 bytes. 00:27:32 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'] 00:27:32 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 00:27:33 INFO - Return code: 0 00:27:33 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')]} 00:27:33 INFO - https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:27:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:27:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:27:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:34 INFO - Downloaded 10845952 bytes. 00:27:34 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'] 00:27:34 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 00:27:34 INFO - Return code: 0 00:27: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')]} 00:27:34 INFO - https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:27:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:27:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:27:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnqtcIenRHupV8Gmhd0DGg/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 00:27:35 INFO - Downloaded 58328438 bytes. 00:27:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:27:35 INFO - mkdir: /builds/slave/test/properties 00:27:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:27:35 INFO - Writing to file /builds/slave/test/properties/build_url 00:27:35 INFO - Contents: 00:27:35 INFO - build_url:https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:27:36 INFO - Running post-action listener: _resource_record_post_action 00:27:36 INFO - Running post-action listener: set_extra_try_arguments 00:27:36 INFO - ##### 00:27:36 INFO - ##### Running populate-webroot step. 00:27:36 INFO - ##### 00:27:36 INFO - Running pre-action listener: _resource_record_pre_action 00:27:36 INFO - Running main action method: populate_webroot 00:27:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:27:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:27:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:27:36 INFO - '--tppagecycles', 00:27:36 INFO - '7'], 00:27:36 INFO - 'tests': ['tsvgm']}}, 00:27:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:27:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:27:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:27:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:27:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:27:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:27:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['damp', 'tps']}, 00:27:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'tests': ['damp', 'tps']}, 00:27:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['dromaeo_dom']}, 00:27:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:27:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['a11yr', 00:27:36 INFO - 'ts_paint', 00:27:36 INFO - 'tpaint', 00:27:36 INFO - 'sessionrestore', 00:27:36 INFO - 'sessionrestore_no_auto_restore', 00:27:36 INFO - 'tabpaint']}, 00:27:36 INFO - 'other-e10s': {'tests': ['a11yr', 00:27:36 INFO - 'ts_paint', 00:27:36 INFO - 'tpaint', 00:27:36 INFO - 'sessionrestore', 00:27:36 INFO - 'sessionrestore_no_auto_restore', 00:27:36 INFO - 'tabpaint']}, 00:27:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:27:36 INFO - 'ts_paint', 00:27:36 INFO - 'tpaint', 00:27:36 INFO - 'sessionrestore', 00:27:36 INFO - 'sessionrestore_no_auto_restore', 00:27:36 INFO - 'tabpaint']}, 00:27:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:27:36 INFO - 'ts_paint', 00:27:36 INFO - 'tpaint', 00:27:36 INFO - 'sessionrestore', 00:27:36 INFO - 'sessionrestore_no_auto_restore', 00:27:36 INFO - 'tabpaint']}, 00:27:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['a11yr', 00:27:36 INFO - 'ts_paint', 00:27:36 INFO - 'tpaint', 00:27:36 INFO - 'sessionrestore', 00:27:36 INFO - 'sessionrestore_no_auto_restore', 00:27:36 INFO - 'tabpaint']}, 00:27:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['a11yr', 00:27:36 INFO - 'ts_paint', 00:27:36 INFO - 'tpaint', 00:27:36 INFO - 'sessionrestore', 00:27:36 INFO - 'sessionrestore_no_auto_restore', 00:27:36 INFO - 'tabpaint']}, 00:27:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['tsvgx', 00:27:36 INFO - 'tsvgr_opacity', 00:27:36 INFO - 'tart', 00:27:36 INFO - 'tscrollx', 00:27:36 INFO - 'cart']}, 00:27:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:27:36 INFO - 'tsvgr_opacity', 00:27:36 INFO - 'tart', 00:27:36 INFO - 'tscrollx', 00:27:36 INFO - 'cart']}, 00:27:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'talos_options': ['--disable-e10s'], 00:27:36 INFO - 'tests': ['tp5o']}, 00:27:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'tests': ['tp5o']}, 00:27:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'talos_options': ['--disable-e10s', 00:27:36 INFO - '--xperf_path', 00:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:27:36 INFO - 'tests': ['tp5n']}, 00:27:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:36 INFO - 'talos_options': ['--xperf_path', 00:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:27:36 INFO - 'tests': ['tp5n']}}, 00:27:36 INFO - 'talos.zip': {'path': '', 00:27:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:27:36 INFO - Running post-action listener: _resource_record_post_action 00:27:36 INFO - ##### 00:27:36 INFO - ##### Running create-virtualenv step. 00:27:36 INFO - ##### 00:27:36 INFO - Running pre-action listener: _resource_record_pre_action 00:27:36 INFO - Running main action method: create_virtualenv 00:27:36 INFO - Creating virtualenv /builds/slave/test/build/venv 00:27:36 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 00:27:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:27:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:27:36 INFO - Using real prefix '/usr' 00:27:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:27:37 INFO - Installing distribute.............................................................................................................................................................................................done. 00:27:39 INFO - Installing pip.................done. 00:27:39 INFO - Return code: 0 00:27:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:27: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')]} 00:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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')]} 00:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27: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', 'pip>=1.5'] in /builds/slave/test/build 00:27: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 pip>=1.5 00:27:39 INFO - Using env: {'DISPLAY': ':0', 00:27:39 INFO - 'HOME': '/home/cltbld', 00:27:39 INFO - 'LANG': 'en_US.UTF-8', 00:27:39 INFO - 'LANGUAGE': 'en_US:en', 00:27:39 INFO - 'LOGNAME': 'cltbld', 00:27:39 INFO - 'MAIL': '/var/mail/cltbld', 00:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:39 INFO - 'MOZ_NO_REMOTE': '1', 00:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:39 INFO - 'NO_EM_RESTART': '1', 00:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:39 INFO - 'PWD': '/builds/slave/test', 00:27:39 INFO - 'SHELL': '/bin/bash', 00:27:39 INFO - 'SHLVL': '1', 00:27:39 INFO - 'TERM': 'linux', 00:27:39 INFO - 'TMOUT': '86400', 00:27:39 INFO - 'USER': 'cltbld', 00:27:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:39 INFO - '_': '/tools/buildbot/bin/python'} 00:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:39 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 00:27:39 INFO - Cleaning up... 00:27:39 INFO - Return code: 0 00:27:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:27: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')]} 00:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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')]} 00:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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', '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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27: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', 'psutil>=0.7.1'] in /builds/slave/test/build 00:27: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 psutil>=0.7.1 00:27:39 INFO - Using env: {'DISPLAY': ':0', 00:27:39 INFO - 'HOME': '/home/cltbld', 00:27:39 INFO - 'LANG': 'en_US.UTF-8', 00:27:39 INFO - 'LANGUAGE': 'en_US:en', 00:27:39 INFO - 'LOGNAME': 'cltbld', 00:27:39 INFO - 'MAIL': '/var/mail/cltbld', 00:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:39 INFO - 'MOZ_NO_REMOTE': '1', 00:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:39 INFO - 'NO_EM_RESTART': '1', 00:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:39 INFO - 'PWD': '/builds/slave/test', 00:27:39 INFO - 'SHELL': '/bin/bash', 00:27:39 INFO - 'SHLVL': '1', 00:27:39 INFO - 'TERM': 'linux', 00:27:39 INFO - 'TMOUT': '86400', 00:27:39 INFO - 'USER': 'cltbld', 00:27:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:39 INFO - '_': '/tools/buildbot/bin/python'} 00:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:39 INFO - Downloading/unpacking psutil>=0.7.1 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:27:41 INFO - Installing collected packages: psutil 00:27:41 INFO - Running setup.py install for psutil 00:27:41 INFO - building 'psutil._psutil_linux' extension 00:27:41 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 00:27:42 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 00:27:42 INFO - building 'psutil._psutil_posix' extension 00:27:42 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 00:27:42 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 00:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:27:42 INFO - Successfully installed psutil 00:27:42 INFO - Cleaning up... 00:27:42 INFO - Return code: 0 00:27:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:27:42 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')]} 00:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:42 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')]} 00:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:42 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:42 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 00:27:42 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 00:27:42 INFO - Using env: {'DISPLAY': ':0', 00:27:42 INFO - 'HOME': '/home/cltbld', 00:27:42 INFO - 'LANG': 'en_US.UTF-8', 00:27:42 INFO - 'LANGUAGE': 'en_US:en', 00:27:42 INFO - 'LOGNAME': 'cltbld', 00:27:42 INFO - 'MAIL': '/var/mail/cltbld', 00:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:42 INFO - 'MOZ_NO_REMOTE': '1', 00:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:42 INFO - 'NO_EM_RESTART': '1', 00:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:42 INFO - 'PWD': '/builds/slave/test', 00:27:42 INFO - 'SHELL': '/bin/bash', 00:27:42 INFO - 'SHLVL': '1', 00:27:42 INFO - 'TERM': 'linux', 00:27:42 INFO - 'TMOUT': '86400', 00:27:42 INFO - 'USER': 'cltbld', 00:27:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:42 INFO - '_': '/tools/buildbot/bin/python'} 00:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:27:44 INFO - Installing collected packages: mozsystemmonitor 00:27:44 INFO - Running setup.py install for mozsystemmonitor 00:27:44 INFO - Successfully installed mozsystemmonitor 00:27:44 INFO - Cleaning up... 00:27:44 INFO - Return code: 0 00:27:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:27: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')]} 00:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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')]} 00:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:44 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:44 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 00:27:44 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 00:27:44 INFO - Using env: {'DISPLAY': ':0', 00:27:44 INFO - 'HOME': '/home/cltbld', 00:27:44 INFO - 'LANG': 'en_US.UTF-8', 00:27:44 INFO - 'LANGUAGE': 'en_US:en', 00:27:44 INFO - 'LOGNAME': 'cltbld', 00:27:44 INFO - 'MAIL': '/var/mail/cltbld', 00:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:44 INFO - 'MOZ_NO_REMOTE': '1', 00:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:44 INFO - 'NO_EM_RESTART': '1', 00:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:44 INFO - 'PWD': '/builds/slave/test', 00:27:44 INFO - 'SHELL': '/bin/bash', 00:27:44 INFO - 'SHLVL': '1', 00:27:44 INFO - 'TERM': 'linux', 00:27:44 INFO - 'TMOUT': '86400', 00:27:44 INFO - 'USER': 'cltbld', 00:27:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:44 INFO - '_': '/tools/buildbot/bin/python'} 00:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:44 INFO - Downloading/unpacking blobuploader==1.2.4 00:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:46 INFO - Downloading blobuploader-1.2.4.tar.gz 00:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:27:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:27:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:47 INFO - Downloading docopt-0.6.1.tar.gz 00:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:27:47 INFO - Installing collected packages: blobuploader, requests, docopt 00:27:47 INFO - Running setup.py install for blobuploader 00:27:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:27:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:27:47 INFO - Running setup.py install for requests 00:27:47 INFO - Running setup.py install for docopt 00:27:48 INFO - Successfully installed blobuploader requests docopt 00:27:48 INFO - Cleaning up... 00:27:48 INFO - Return code: 0 00:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:48 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:48 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 00:27:48 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 00:27:48 INFO - Using env: {'DISPLAY': ':0', 00:27:48 INFO - 'HOME': '/home/cltbld', 00:27:48 INFO - 'LANG': 'en_US.UTF-8', 00:27:48 INFO - 'LANGUAGE': 'en_US:en', 00:27:48 INFO - 'LOGNAME': 'cltbld', 00:27:48 INFO - 'MAIL': '/var/mail/cltbld', 00:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:48 INFO - 'MOZ_NO_REMOTE': '1', 00:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:48 INFO - 'NO_EM_RESTART': '1', 00:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:48 INFO - 'PWD': '/builds/slave/test', 00:27:48 INFO - 'SHELL': '/bin/bash', 00:27:48 INFO - 'SHLVL': '1', 00:27:48 INFO - 'TERM': 'linux', 00:27:48 INFO - 'TMOUT': '86400', 00:27:48 INFO - 'USER': 'cltbld', 00:27:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:48 INFO - '_': '/tools/buildbot/bin/python'} 00:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:27:48 INFO - Running setup.py (path:/tmp/pip-bcCVeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:27:48 INFO - Running setup.py (path:/tmp/pip-meHOFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:27:48 INFO - Running setup.py (path:/tmp/pip-uHnc6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:27:48 INFO - Running setup.py (path:/tmp/pip-fK0Ka8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:27:48 INFO - Running setup.py (path:/tmp/pip-DFqyeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:27:48 INFO - Running setup.py (path:/tmp/pip-PJRnAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:27:48 INFO - Running setup.py (path:/tmp/pip-LKmTdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:27:48 INFO - Running setup.py (path:/tmp/pip-IDFD9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:27:48 INFO - Running setup.py (path:/tmp/pip-XAu9bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:27:48 INFO - Running setup.py (path:/tmp/pip-Y1AXrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:27:49 INFO - Running setup.py (path:/tmp/pip-l9sbZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:27:49 INFO - Running setup.py (path:/tmp/pip-lRw4Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:27:49 INFO - Running setup.py (path:/tmp/pip-Gobeia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:27:49 INFO - Running setup.py (path:/tmp/pip-dbtnwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:49 INFO - Running setup.py (path:/tmp/pip-2gMsJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:27:49 INFO - Running setup.py (path:/tmp/pip-FtqaF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:27:49 INFO - Running setup.py (path:/tmp/pip-8jJrEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:27:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:27:49 INFO - Running setup.py install for manifestparser 00:27:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:27:49 INFO - Running setup.py install for mozcrash 00:27:49 INFO - Running setup.py install for mozdebug 00:27:49 INFO - Running setup.py install for mozdevice 00:27:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:27:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:27:49 INFO - Running setup.py install for mozfile 00:27:50 INFO - Running setup.py install for mozhttpd 00:27:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for mozinfo 00:27:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for mozInstall 00:27:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for mozleak 00:27:50 INFO - Running setup.py install for mozlog 00:27:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for moznetwork 00:27:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for mozprocess 00:27:50 INFO - Running setup.py install for mozprofile 00:27:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for mozrunner 00:27:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:27:50 INFO - Running setup.py install for mozscreenshot 00:27:51 INFO - Running setup.py install for moztest 00:27:51 INFO - Running setup.py install for mozversion 00:27:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:27:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:27:51 INFO - Cleaning up... 00:27:51 INFO - Return code: 0 00:27:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27: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')]} 00:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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')]} 00:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:51 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:51 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 00:27:51 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 00:27:51 INFO - Using env: {'DISPLAY': ':0', 00:27:51 INFO - 'HOME': '/home/cltbld', 00:27:51 INFO - 'LANG': 'en_US.UTF-8', 00:27:51 INFO - 'LANGUAGE': 'en_US:en', 00:27:51 INFO - 'LOGNAME': 'cltbld', 00:27:51 INFO - 'MAIL': '/var/mail/cltbld', 00:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:51 INFO - 'MOZ_NO_REMOTE': '1', 00:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:51 INFO - 'NO_EM_RESTART': '1', 00:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:51 INFO - 'PWD': '/builds/slave/test', 00:27:51 INFO - 'SHELL': '/bin/bash', 00:27:51 INFO - 'SHLVL': '1', 00:27:51 INFO - 'TERM': 'linux', 00:27:51 INFO - 'TMOUT': '86400', 00:27:51 INFO - 'USER': 'cltbld', 00:27:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:51 INFO - '_': '/tools/buildbot/bin/python'} 00:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:27:51 INFO - Running setup.py (path:/tmp/pip-snc8Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:27:51 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)) 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:27:51 INFO - Running setup.py (path:/tmp/pip-uRYgDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:27:51 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)) 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:27:51 INFO - Running setup.py (path:/tmp/pip-gDt7i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:27:51 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)) 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:27:51 INFO - Running setup.py (path:/tmp/pip-6d_PA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:27:51 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)) 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:27:51 INFO - Running setup.py (path:/tmp/pip-6yd10n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:27:51 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)) 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:27:51 INFO - Running setup.py (path:/tmp/pip-X3wh0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:27:51 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)) 00:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:27:51 INFO - Running setup.py (path:/tmp/pip-8bPAz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:27:52 INFO - Running setup.py (path:/tmp/pip-vlv3c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:27:52 INFO - Running setup.py (path:/tmp/pip-DcEWRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:27:52 INFO - Running setup.py (path:/tmp/pip-UZPFyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:27:52 INFO - Running setup.py (path:/tmp/pip-MEo9AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:27:52 INFO - Running setup.py (path:/tmp/pip-ArpQ4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:27:52 INFO - Running setup.py (path:/tmp/pip-bn0mEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:27:52 INFO - Running setup.py (path:/tmp/pip-H8r3Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:52 INFO - Running setup.py (path:/tmp/pip-80_mEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:27:52 INFO - Running setup.py (path:/tmp/pip-ZRHuB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:27:52 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)) 00:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:27:52 INFO - Running setup.py (path:/tmp/pip-k4znDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:27:52 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)) 00:27:52 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)) 00:27:52 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)) 00:27:52 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)) 00:27:52 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)) 00:27:52 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)) 00:27:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:54 INFO - Downloading blessings-1.6.tar.gz 00:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:27:54 INFO - Installing collected packages: blessings 00:27:54 INFO - Running setup.py install for blessings 00:27:54 INFO - Successfully installed blessings 00:27:54 INFO - Cleaning up... 00:27:54 INFO - Return code: 0 00:27:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:27:55 INFO - Reading from file tmpfile_stdout 00:27:55 INFO - Current package versions: 00:27:55 INFO - argparse == 1.2.1 00:27:55 INFO - blessings == 1.6 00:27:55 INFO - blobuploader == 1.2.4 00:27:55 INFO - docopt == 0.6.1 00:27:55 INFO - manifestparser == 1.1 00:27:55 INFO - mozInstall == 1.12 00:27:55 INFO - mozcrash == 0.17 00:27:55 INFO - mozdebug == 0.1 00:27:55 INFO - mozdevice == 0.48 00:27:55 INFO - mozfile == 1.2 00:27:55 INFO - mozhttpd == 0.7 00:27:55 INFO - mozinfo == 0.9 00:27:55 INFO - mozleak == 0.1 00:27:55 INFO - mozlog == 3.1 00:27:55 INFO - moznetwork == 0.27 00:27:55 INFO - mozprocess == 0.22 00:27:55 INFO - mozprofile == 0.28 00:27:55 INFO - mozrunner == 6.11 00:27:55 INFO - mozscreenshot == 0.1 00:27:55 INFO - mozsystemmonitor == 0.0 00:27:55 INFO - moztest == 0.7 00:27:55 INFO - mozversion == 1.4 00:27:55 INFO - psutil == 3.1.1 00:27:55 INFO - requests == 1.2.3 00:27:55 INFO - wsgiref == 0.1.2 00:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:55 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:55 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 00:27:55 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 00:27:55 INFO - Using env: {'DISPLAY': ':0', 00:27:55 INFO - 'HOME': '/home/cltbld', 00:27:55 INFO - 'LANG': 'en_US.UTF-8', 00:27:55 INFO - 'LANGUAGE': 'en_US:en', 00:27:55 INFO - 'LOGNAME': 'cltbld', 00:27:55 INFO - 'MAIL': '/var/mail/cltbld', 00:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:55 INFO - 'MOZ_NO_REMOTE': '1', 00:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:55 INFO - 'NO_EM_RESTART': '1', 00:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:55 INFO - 'PWD': '/builds/slave/test', 00:27:55 INFO - 'SHELL': '/bin/bash', 00:27:55 INFO - 'SHLVL': '1', 00:27:55 INFO - 'TERM': 'linux', 00:27:55 INFO - 'TMOUT': '86400', 00:27:55 INFO - 'USER': 'cltbld', 00:27:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:55 INFO - '_': '/tools/buildbot/bin/python'} 00:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 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)) 00:27:55 INFO - Cleaning up... 00:27:55 INFO - Return code: 0 00:27:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:55 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:55 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 00:27:55 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 00:27:55 INFO - Using env: {'DISPLAY': ':0', 00:27:55 INFO - 'HOME': '/home/cltbld', 00:27:55 INFO - 'LANG': 'en_US.UTF-8', 00:27:55 INFO - 'LANGUAGE': 'en_US:en', 00:27:55 INFO - 'LOGNAME': 'cltbld', 00:27:55 INFO - 'MAIL': '/var/mail/cltbld', 00:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:55 INFO - 'MOZ_NO_REMOTE': '1', 00:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:55 INFO - 'NO_EM_RESTART': '1', 00:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:55 INFO - 'PWD': '/builds/slave/test', 00:27:55 INFO - 'SHELL': '/bin/bash', 00:27:55 INFO - 'SHLVL': '1', 00:27:55 INFO - 'TERM': 'linux', 00:27:55 INFO - 'TMOUT': '86400', 00:27:55 INFO - 'USER': 'cltbld', 00:27:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:55 INFO - '_': '/tools/buildbot/bin/python'} 00:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:55 INFO - Downloading/unpacking jsonschema 00:27:55 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 00:27:55 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 00:27:55 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 00:27:55 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 00:27:55 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 00:27:55 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 00:27:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:27:57 INFO - Downloading/unpacking functools32 (from jsonschema) 00:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:57 INFO - Downloading functools32-3.2.3-2.tar.gz 00:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:27:57 INFO - warning: no files found matching '*.txt' 00:27:57 INFO - no previously-included directories found matching 'build' 00:27:57 INFO - no previously-included directories found matching 'dist' 00:27:57 INFO - no previously-included directories found matching '.git*' 00:27:57 INFO - Installing collected packages: jsonschema, functools32 00:27:57 INFO - Running setup.py install for functools32 00:27:57 INFO - warning: no files found matching '*.txt' 00:27:57 INFO - no previously-included directories found matching 'build' 00:27:57 INFO - no previously-included directories found matching 'dist' 00:27:57 INFO - no previously-included directories found matching '.git*' 00:27:57 INFO - Successfully installed jsonschema functools32 00:27:57 INFO - Cleaning up... 00:27:57 INFO - Return code: 0 00:27:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:27:57 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')]} 00:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:57 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')]} 00:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:58 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 0x7fdb11975f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', '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 00:27:58 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 00:27:58 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 00:27:58 INFO - Using env: {'DISPLAY': ':0', 00:27:58 INFO - 'HOME': '/home/cltbld', 00:27:58 INFO - 'LANG': 'en_US.UTF-8', 00:27:58 INFO - 'LANGUAGE': 'en_US:en', 00:27:58 INFO - 'LOGNAME': 'cltbld', 00:27:58 INFO - 'MAIL': '/var/mail/cltbld', 00:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:58 INFO - 'MOZ_NO_REMOTE': '1', 00:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:58 INFO - 'NO_EM_RESTART': '1', 00:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:58 INFO - 'PWD': '/builds/slave/test', 00:27:58 INFO - 'SHELL': '/bin/bash', 00:27:58 INFO - 'SHLVL': '1', 00:27:58 INFO - 'TERM': 'linux', 00:27:58 INFO - 'TMOUT': '86400', 00:27:58 INFO - 'USER': 'cltbld', 00:27:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:58 INFO - '_': '/tools/buildbot/bin/python'} 00:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:58 INFO - Downloading/unpacking flake8 00:27:58 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 00:27:58 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 00:27:58 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 00:27:58 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 00:27:58 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 00:27:58 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 00:28:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:28:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:28:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 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 00:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:28:00 INFO - no previously-included directories found matching 'docs/_build' 00:28:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:28:00 INFO - Running setup.py install for pep8 00:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:28:00 INFO - no previously-included directories found matching 'docs/_build' 00:28:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:28:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:28:01 INFO - Cleaning up... 00:28:01 INFO - Return code: 0 00:28:01 INFO - Running post-action listener: _resource_record_post_action 00:28:01 INFO - Running post-action listener: _start_resource_monitoring 00:28:01 INFO - Starting resource monitoring. 00:28:01 INFO - ##### 00:28:01 INFO - ##### Running install step. 00:28:01 INFO - ##### 00:28:01 INFO - Running pre-action listener: _resource_record_pre_action 00:28:01 INFO - Running main action method: install 00:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:28:01 INFO - Reading from file tmpfile_stdout 00:28:01 INFO - Detecting whether we're running mozinstall >=1.0... 00:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:28:01 INFO - Reading from file tmpfile_stdout 00:28:01 INFO - Output received: 00:28:01 INFO - Usage: mozinstall [options] installer 00:28:01 INFO - Options: 00:28:01 INFO - -h, --help show this help message and exit 00:28:01 INFO - -d DEST, --destination=DEST 00:28:01 INFO - Directory to install application into. [default: 00:28:01 INFO - "/builds/slave/test"] 00:28:01 INFO - --app=APP Application being installed. [default: firefox] 00:28:01 INFO - mkdir: /builds/slave/test/build/application 00:28:01 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'] 00:28:01 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 00:28:17 INFO - Reading from file tmpfile_stdout 00:28:17 INFO - Output received: 00:28:17 INFO - /builds/slave/test/build/application/firefox/firefox 00:28:17 INFO - Running post-action listener: _resource_record_post_action 00:28:17 INFO - ##### 00:28:17 INFO - ##### Running run-tests step. 00:28:17 INFO - ##### 00:28:17 INFO - Running pre-action listener: _resource_record_pre_action 00:28:17 INFO - Running main action method: run_tests 00:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:28:17 INFO - Python 2.7.3 00:28:17 INFO - Return code: 0 00:28:17 INFO - grabbing minidump binary from tooltool 00:28: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')]} 00:28:17 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 0x2458810>, '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 0x2459710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:28:17 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 00:28:17 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 00:28:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:28:18 INFO - Return code: 0 00:28:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:28:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:28:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:28:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:28:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:28:19 INFO - Return code: 0 00:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:28:19 INFO - Using env: {'DISPLAY': ':0', 00:28:19 INFO - 'HOME': '/home/cltbld', 00:28:19 INFO - 'LANG': 'en_US.UTF-8', 00:28:19 INFO - 'LANGUAGE': 'en_US:en', 00:28:19 INFO - 'LOGNAME': 'cltbld', 00:28:19 INFO - 'MAIL': '/var/mail/cltbld', 00:28:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:28:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:19 INFO - 'MOZ_NO_REMOTE': '1', 00:28:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:19 INFO - 'NO_EM_RESTART': '1', 00:28:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:19 INFO - 'PWD': '/builds/slave/test', 00:28:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:28:19 INFO - 'SHELL': '/bin/bash', 00:28:19 INFO - 'SHLVL': '1', 00:28:19 INFO - 'TERM': 'linux', 00:28:19 INFO - 'TMOUT': '86400', 00:28:19 INFO - 'USER': 'cltbld', 00:28:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757', 00:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:19 INFO - '_': '/tools/buildbot/bin/python'} 00:28:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:28:19 INFO - mozversion application_buildid: 20160421214206 00:28:19 INFO - mozversion application_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 00:28:19 INFO - mozversion application_display_name: Nightly 00:28:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:28:19 INFO - mozversion application_name: Firefox 00:28:19 INFO - mozversion application_remotingname: firefox 00:28:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:28:19 INFO - mozversion application_vendor: Mozilla 00:28:19 INFO - mozversion application_version: 48.0a1 00:28:19 INFO - mozversion platform_buildid: 20160421214206 00:28:19 INFO - mozversion platform_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 00:28:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:28:19 INFO - mozversion platform_version: 48.0a1 00:28:19 INFO - using testdate: 1461310099 00:28:19 INFO - actual date: 1461310099 00:28:19 INFO - starting webserver on 'localhost:56952' 00:28:19 INFO - SUITE-START | Running 2 tests 00:28:19 INFO - TEST-START | dromaeo_css 00:28:19 INFO - operating with platform_type : linux_ 00:28:19 INFO - Initialising browser for dromaeo_css test... 00:28:19 INFO - TEST-INFO | started process 17867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJgeSF/profile http://localhost:56952/getInfo.html) 00:28:23 INFO - PROCESS | 17867 | __metrics Screen width/height:1600/1200 00:28:23 INFO - PROCESS | 17867 | colorDepth:24 00:28:23 INFO - PROCESS | 17867 | Browser inner width/height: 1024/697 00:28:23 INFO - PROCESS | 17867 | __metrics 00:28:24 ERROR - PROCESS | 17867 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:28:24 INFO - TEST-INFO | 17867: exit 0 00:28:24 INFO - Browser initialized. 00:28:24 INFO - Running cycle 1/1 for dromaeo_css test... 00:28:24 INFO - TEST-INFO | started process 17947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJgeSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:28:36 INFO - PROCESS | 17947 | RSS: Main: 153866240 00:28:36 INFO - PROCESS | 17947 | 00:29:27 INFO - PROCESS | 17947 | 1461310167735 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] 00:31:35 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:56952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56952/tests/dromaeo/cssquery-ext.html) 00:31:36 INFO - PROCESS | 17947 | RSS: Main: 261005312 00:31:36 INFO - PROCESS | 17947 | 00:34:38 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:56952/tests/dromaeo/cssquery-ext.html (next: http://localhost:56952/tests/dromaeo/cssquery-jquery.html) 00:34:38 INFO - PROCESS | 17947 | RSS: Main: 232685568 00:34:38 INFO - PROCESS | 17947 | 00:37:40 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:56952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56952/tests/dromaeo/cssquery-mootools.html) 00:37:41 INFO - PROCESS | 17947 | RSS: Main: 230154240 00:37:41 INFO - PROCESS | 17947 | 00:40:43 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:56952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56952/tests/dromaeo/cssquery-prototype.html) 00:40:43 INFO - PROCESS | 17947 | RSS: Main: 229511168 00:40:43 INFO - PROCESS | 17947 | 00:43:46 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:56952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56952/tests/dromaeo/cssquery-yui.html) 00:43:47 INFO - PROCESS | 17947 | RSS: Main: 213749760 00:43:47 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:56952/tests/dromaeo/cssquery-yui.html (next: http://localhost:56952/tests/dromaeo/cssquery-dojo.html) 00:46:49 INFO - PROCESS | 17947 | RSS: Main: 266670080 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | __start_tp_report 00:46:49 INFO - PROCESS | 17947 | _x_x_mozilla_page_load 00:46:49 INFO - PROCESS | 17947 | _x_x_mozilla_page_load_details 00:46:49 INFO - PROCESS | 17947 | |i|pagename|runs| 00:46:49 INFO - PROCESS | 17947 | |0;dojo.html;3020.7130322619346;3056.8318742469182;3106.9223269418276;3111.7666175036866;3130.593022907022;5139.6659217150855;5159.896802063957;5180.533751962323;5197.792088316468;5207.140821764414;5168.508991645787;5170.612204084689;5191.5327620514145;5202.843914682566;5215.295935048767;4668.323093151491;4696.459907110692;4818.421789385278;4831.637627177958;4863.124637565237;4671.789769460365;4773.809047638108;4792.2332426811545;4819.301201325806;4835.6131509479155;4763.571278584926;4764.332993380912;4767.308740232682;4779.163646361872;4818.301346304784;4767.666263361566;4776.402949631296;4784.904301913943;4801.975990120062;4820.855374338776;4662.300654901758;4743.430788305391;4747.146571643893;4753.382060332169;4804.471508134103;5036.420811606676;5054.241863720435;5069.569086627641;5109.41241757199;5115.104856650109;5427.565794736451;5464.23500709901;5485.890282194334;5511.173324001392;5513.365962914276;5504.697241651707;5522.861928451781;5535.58483113768;5643.971780141073;5700.942990570083;5186.24799404088;5213.582913366921;5218.817341393109;5220.29526013987;5260.500252476008;5671.2060311556415;5673.234113394639;5673.914891276634;5677.063284558084;5679.176519404663;5315.973420132875;5467.781288748485;5527.778888844401;5528.778848846082;5550.139728342114;5565.276514053147;5566.192902029183;5569.470900264469;5571.637843540157;5572.721363931787;5536.52939500147;5536.557075433956;5538.529225015838;5547.72261386929;5559.471850174227;5470.53500452466;5586.245856809279;5619.7471113799975;5629.493345598916;5653.830385088454;4207.726497777635;4212.957870421318;4217.156568686275;4218.388333691598;4253.914921701548;3724.5530536335273;3777.433384992273;3795.905102372463;3825.617438256152;3835.0987517933263;5265.183896496049;5273.235380869753;5277.129273669878;5281.894362112736;5318.494742999486;5516.668999860021;5639.548836093185;5644.096944488862;5647.040003199466;5650.74571644277;5079.263506791494;5219.634625576249;5297.867553311121;5316.282301889273;5335.813246536352;4792.976035119872;4807.543283388072;4815.085133824562;4829.058333624909;4839.1531481991215;5781.971090144522;5782.855428614318;5788.18965344852;5791.420857914175;5796.768129274866;5506.724663766716;5509.559235261249;5568.081266590967;5568.526675232651;5578.944210558005;5793.304803423616;5813.854653633523;5816.127580862904;5834.27071616048;5835.212246346859;5532.419095995024;5546.195801608664;5555;5556.333240011225;5559.722013899208;5399.568034557305;5530.364008139116;5579.525740312119;5593;5643.88712225745;5385.461453854583;5434.239206511171;5449.23710680513;5456.127019676833;5458.918116228339;5268.893532358247;5441.564674826083;5443.129099344086;5450.5367043801725;5499.84503254305;5405.621606487508;5448.618596698351;5449.855530338673;5481.314835645544;5501.449855014466;5403.594730395314;5426.701531415652;5446.782128714807;5449.2371068049715;5452.018636645442;5213.556847667991;5259.474052594863;5310.070737620824;5339.679619222859;5349.919751203657 00:46:49 INFO - PROCESS | 17947 | |1;ext.html;587.7237698281806;630.0895206426712;638.3425072175661;641.4355367276796;656.3174298729322;31404.214894627617;37431.25137497248;38875.222495550144;38884.22231555374;39036.60963390365;40560;41580.88143389243;41584.58415415845;41684.79157604208;41724;8602.526861022641;8804.163604457566;8809.823803523926;8813.42712723671;8820.647174113059;8751.168638979287;8889.19997200255;8890.333225008118;8890.59992300348;8894.4663320201;8840.071792461795;8942.642294308253;8963.148500892405;8974.05772393899;8974.102589741005;8767.430117042404;8832.293416526663;8834.955825220864;8835.911640883573;8839.558022098869;8705.7823554411;8842.955785221096;8852.247558957497;8859.379843410963;8862.468251904906;41017.79491102525;41497.585024149674;41498.79250603758;41501.792491037355;41507.58492415067;3490.234228840834;3558.3594952908466;3585.103724068983;3725.590185079639;3854.2676891390824;31926.680733192836;32029;32180.839095804604;32212.355752885047;33403.665963340296;3906.199229158016;3914.197589494147;3938.468306778577;3976.5228172619472;4043.636072753437;294593;296307;297443.1264340229;297984;298370;50270.74864625726;55520.72239638776;56318.436815632136;57793.42206577965;57868.71065644645;53695.731521342146;53852.192217116775;53979.52245730538;54055.459445405046;54078.18882716762;16282;16484.175791210633;16521.752173717403;16525.33898644065;16528.66942661164;11881.287122772661;12122.878771212176;12488.625341239778;12491.50033998648;12505.437255323532;16100.75848862268;16175.757363639555;16247.918760406123;16386;16817.663646726996;6237.313895471494;6301.14934483848;6362.168834868439;6426.068220108058;6455.128557644752;1013.3717095400899;1045.8012977534245;1061.1669839176363;1070.1652710885521;1089.2538611051455;32113.357732845212;32349.191270218435;32502.674973249967;32611.184720381705;32919.67080329166;1102.1733699725205;1146.1919346860443;1158.4323681396224;1169.1582060916128;1184.6979020349927;17226.827731722773;17366.39217627377;17409.91295043542;17428.390006349717;17502.693524122587;455599;461909;462684;463705;465640;56880.146797798065;57558.7122064387;57575;57590.13614795781;57699;1240.1443004327166;1340.6112227454123;1410.0975375759522;1428.2287564715145;1464.6191990082655;30950.69049309568;31975.680243197272;32460.188495287806;32543.674563254066;32909.83545082259;46606.76696616495;46674.29988550107;47271.52728472671;47272.29091563698;47359.52640473689;298774;299059;300355;300872;301773;27385.863070684518;27982;28209.858950705115;28318.43363132767;28360.716392835806;42123.7893810529;42834.78582607067;43097;43511.78244108886;43692.34461483017;38758;39674.2065158701;40053.799731001156;40225.1954960905;40642;38540.42189367218;38583.2283354337;39100.6089939097;39851;40495.392569112075;40072;40368.19263614652;41163.588364117175;42611.3608295882;42643.36034959416;33541.496877547346;35605;35851.64148358483;35941.64058359383;36328.09179770527;27225.591616125377;27921.581176281965;28093;28283;28412 00:46:49 INFO - PROCESS | 17947 | |2;jquery.html;381.039551507494;385.6009030653274;388.32237745134745;396.17397725741824;402.90531725044593;17653.382131625396;19074.141663625134;19257.133428995694;19291.13189906456;19347.70978435323;18066.5483362916;18377.356792512266;18903.441459429127;18998.33505827296;19125.521861953457;5685.886282274352;5706.28671416073;5799.10113932339;5862.06207006879;5865.090910908816;5574.414686457924;5762.3949485304065;5769.221155144065;5775.480206781389;5777.682227477487;5647.53149337477;5739.971300143494;5749.080147176453;5750.3962083981205;5751.05107657236;5602.187682785993;5698.230738850244;5715.514181294553;5732.598718089715;5743.54051675865;4901.50984901507;5040.495950404967;5067.923981140286;5077.314562534048;5084.059449001947;22019.779802201934;22135.225267115573;22319.665205021938;22394.552108957894;22420.32739017832;2387.1883559589824;2423.1155628195756;2449.0326321103066;2555.527227462907;2882.538793793004;9454.621815127386;13701.90384769226;14007.719845603133;14242.287885605781;14579.635509112357;1835.4677143628332;1886.368066697658;1921.932732354361;1922.0774028466274;1963.3717210492648;70957;72807.27192728058;73476;74677.6266118666;76113.61943190248;10111.696649100539;10232.232582556338;10291;10321.380717156844;10334.328268662513;14111.78832317516;14486.710265794625;14627.341769620392;14639.780403293958;14656.48702295436;7932.960335198402;7967.8406431871035;8032.4778889372;8089.514629122272;8218.054923683852;7776.222377762291;7867.252611001945;7998.400119990907;8066;8117.918820811835;4353.760543170156;4468.7155287122305;4479.955200448019;4517.164324599959;4673.859784206479;1811.80975997521;1867.1037901807208;1891.8297353238274;1912.6474436442975;1945.8248757611882;954.4368822394821;989.649128938993;1014.8934361891895;1024.0783295034528;1062.1555863088863;18459.538511537317;19332;19437.31969381065;19476.318328858422;19684;1003.6336737091056;1004.6182450668699;1013.5945621751358;1030.443560477334;1044.7335929337971;10189.796204076025;10778.4071876046;10841.945790271157;10848.132149428027;10849.511771970281;473745;474079;479227;485353.8913803183;489687;89107.55446222727;91639.54180229057;92502;94419;95596.52201738946;1042.864427624404;1052.4422056310168;1059.2479339668766;1063.2185343772321;1104.8453216549528;16222.26999784989;16457.506274811774;16878.746818797972;17376.652466950844;17757.378491752726;37864.62135378611;38131.42802857904;38330.80834595809;39835.402468962406;40957.18085638211;54429;55853;55952.44047559635;56033.71983140058;56513;7806.414518911218;7995.560244186626;8077.27304542594;8456.83086338282;8530.829383412422;12629.2422454653;12677.366131693194;12902.612921612366;12985.740285194055;13175.60473185806;11263.436828158396;11390.088792896715;11541.480633371351;11639.41802909868;12008.579699710468;11161.330320180816;11412.31526108436;11567.595134170264;11735.882641173479;11848.348340841336;6674.16572928384;10983.780324393307;11016.622922134733;11758.647240582795;11778.411079446165;7882;8336.249737523409;8576.742697719079;8635.136486351566;8644.697435589724;10023.69928902134;10795.784084318428;11505;11689.415529223335;11795 00:46:49 INFO - PROCESS | 17947 | |3;mootools.html;1333.353323638036;1532.7011232809602;1542.2905463486795;1701.4300209429841;1857.693480575705;8065.5967201639905;8241.423100382961;8247.546384948833;8256.876146857801;8261.75214743557;8058.919410805905;8219.260266576008;8222.588870556463;8227.54748488833;8233.505989640626;2056.5269987902793;2261.4685548895995;2321.4776675248017;2339.590571649963;2352.529494101178;2333.288347054148;2361.362432143329;2363.432776133724;2364.3970787449175;2366.1600131953082;2278.134308962592;2316.281952594701;2317.884105794712;2319.3273950554403;2322.1756276521846;2024.0486971123548;2268.3875353654503;2343.5312937412414;2347.3310106619533;2350.15394457995;2293.8738369389675;2298.253067752987;2312.2485192312397;2329.3477826208687;2329.464223228667;8160.673573057071;8222.547759873205;8239.876401853977;8240.423170378075;8244.587770611446;4934.629902757271;5075.974620126875;5092.134337162691;5112.897742045176;5171;3269.1173383186406;3270.427675156862;3331.1339051846453;3338.2488939988552;3344.782589131699;1017.3438132404558;1030.8041472120349;1036.1451802263089;1040.9479526023745;1060.5386656804314;11372.203945723802;11607.535698572132;11611.709707257301;11612.94193529027;11621.186516943817;4462.174497717932;4466.173757854807;4632.351470794091;4637.791299391535;4663.766811659403;9863.408195508293;9891.802163956681;9903.207743380657;9941.701748947544;9948.701538953843;4724.362211101526;5259.474052594786;5260.158374660036;5274.630775845654;5290.947090529123;4692.436907571113;4799.520047995243;4816.662833601685;4845.224764037807;4868.488808675038;3792.7534710243744;3821.8662346817728;3879.7090218233743;3913.3934240192816;3939.881803545898;1227.9877201228053;1266.6200139957975;1276.4957841652495;1282.807578863178;1291.109134697056;872.3806097670725;949.3354651743807;962.9073078139791;963.6145541783343;972.8978457262027;5807.941920580824;5828.88342233153;5852.4440178183;5872.823815285548;5991.820245392645;414.734569875274;424.069168175851;427.05833636831335;434.34414034807037;448.6097095526847;3733.4586484959527;3786.962130378716;3807.600201978808;3826.6364695353896;3883.456316115746;10103.343282686601;10427.165826733843;10454.63408780689;10455.215858810467;10495.212859035602;10134.442605656759;10315.535800888978;10362.015608517178;10398.324108932895;10419.843702344318;7718.035245594188;7774;7797.259260370256;7826.804329891685;7901.486403383762;5633.718314084362;5693.345265294379;5704.401037890962;5715.257016587817;5887.8233652990475;9263.76840578991;9389.530523473662;9503.857442138235;9505.619775208914;9608.519574021131;9799.069088436587;9829.901700982899;9860.802783944424;9926.900730992598;9939.801203975736;6711.463082953254;7245.855082898418;7372.152202496782;7451.2176221495965;7533.660985255567;8087.757367278991;8107.14874938123;8190;8197.180281971756;8205.097439281555;7225.349718525358;7346.52247603904;7384.224656411215;7493.400527957641;7501.024866767285;7123.180834204133;7341;7348.448866335153;7348.52234604749;7449.14334851499;6610.537262391586;6675;6679.599224046573;6682.899756503559;6683.164604424447;4803.5916947059895;4876.414830220397;4877.463479017376;4887.144749668865;5008.6744361616375;4793.257045158006;4890.584300334512;4920.6063514918005;4937.851864444073;4982.402111746614 00:46:49 INFO - PROCESS | 17947 | |4;prototype.html;319.603691422636;321.16977612870716;321.32201055772333;328.0339400465629;331.97178239849603;5646.20953066571;5668.178114173443;5692.316921969359;5694.6867922264255;5743.770249190033;5598.636088654245;5618.2415373924505;5628.43715628438;5653.208550802891;5654.642885707432;4098.8360465581345;4174.144300418407;4303.612674859262;4349.7390156590545;4358.694891357606;4296.355546667994;4337.371081193225;4338.655016944742;4355.695101342907;4360.8255669773325;4092.7258193445273;4317.892052698692;4324.178406102847;4340.544242854487;4356.542563030884;4190.685698572619;4282.372698374629;4284.100338928829;4287.656987440997;4306.612404883575;3733.701303895682;3738.6261373862667;3750.962490375116;3758.361078616642;3761.6238376162437;5362.168863826113;5450.427705090948;5458.344998600153;5462.672239665593;5464.617476776627;4925.605951523869;4950.232713929347;4952.158133117378;4967.7764500597195;4980.662955819574;5889.734961926723;5892.292924849003;5908.822735317947;5911.763529458816;5922.170896074553;4035.7376770509823;4125.938110928339;4152.944292575195;4154.480689913761;4164.4586203793615;6139.26328840542;6144.446999769997;6145.924463218918;6152.784652537184;6156.907646385263;4188.204241194163;4219.45147130871;4232.513260975027;4240.109576988867;4245.893852653709;4147.502299724052;4274.401583778274;4294.806733696991;4297.67767417445;4298.118885628439;4924.261360795837;4938.407391113089;4940.333055037524;4958.330625365602;4969.130402179604;5844.620099693507;5901.439363260483;5922.200502932135;5932.525397968152;5939.198208241832;1458.0522660270697;1471.852814718541;1485.769705695619;1490.3293517916982;1496.6557691730964;939.557778809524;1005.492226425665;1019.3628981886321;1027.5992362978445;1042.4579218806177;5566.415526369754;5662;5662.66024038559;5679.006173919547;5692.203091567184;5980.102984552352;6002.309734380515;6011.12838638395;6053.757849685963;6060.33336333003;5378.1663842104535;5662.235598194191;5685.857853553612;5714.457126572969;5776.971115144482;3232.3858466891215;3255.5604993326074;3263.216827961272;3267.640559538449;3277.2298509850166;6109.266887973383;6192.256929168439;6276.874462510816;6294.653794041372;6352;6211.9689401552705;6221.160143380585;6232.696670764502;6247.09417134522;6254.124422580842;6170.074488826533;6270.216222972129;6291.716872740738;6320.9772872680305;6329.177206963065;6071.908921366271;6075.1191077294425;6079.483243924316;6086.482648974887;6122.877542449037;5985.880282394241;6008.54935879802;6055.848603784941;6058.636481811105;6059.757609695739;6123.632002398574;6261.843453913689;6279.340669229665;6290.622562646256;6321.241451025906;4175.227582897173;4179.937300940549;4198.349255865346;4199.391088292242;4204.411382406404;6000.369961154191;6083;6101.29835068955;6107.786227482017;6137.263528376445;5912.852178695395;5981.431763982415;5983.995361553754;6002.189704389852;6002.748969136574;5898.764049437975;5900.763969441175;5937.614055086406;5968.8806223876145;5979.611325263844;5008.323876276656;5388.164834450667;5835.7373918174635;5840;5840.2115714378015;5970.791022314198;5985.6408615483215;5991.520678345809;5994.820155395345;6000.849978750566;5836.708164591839;5840.1531777892815;5842.824715258549;5862.706864656665;5885.323187833454 00:46:49 INFO - PROCESS | 17947 | |5;yui.html;766.375404045703;827.2389401750389;842.4313588327877;859.5444414460338;875.2953872132932;13204.207747535154;13494.662633434169;13574.457021719132;13579.321033948312;14622.330755932906;13886.09740366878;13913.791293130611;13943.860561394384;13946.163230206195;13963.650908727286;664.9900251496232;817.709713051867;819.4755356571799;822.40786633624;822.5147163173726;793.1552896165595;819.8770184472318;828.5235989306143;829.1128492513013;829.5810615639094;843.6498852976008;846.0735494633398;849.7918010087537;849.9362547808909;850.6639877248483;683.2381894187994;696.979090627282;839.7984483723924;844.2064459408167;846.0650980666337;511.8950615123891;602.1930612978585;620.512897375558;628.8962321216994;629.4020680353636;13857.099288546213;14062.578122656336;14080.155190688489;14108.788368174486;14167.645808854759;12886.742265154644;13172.798883238684;13256.40346184424;13415.731685366336;13748.243846588433;11112.44437778116;11259.54961801527;11486.42567871603;11527.538898444052;11666.358350290731;3744.850205991757;3757.079515518688;3812.066043819282;3816.446615240802;3844.5386553613466;56588;57222.42777572213;57308;57459.243002195006;57565;10147;10197.898021019842;10231.139153992042;10623.681289561326;10624.043836054792;18542.629147416978;18866.434006979813;19085.904570477338;19115.330963416214;19132.61734765297;7973.162817904153;7989.201079892081;8020.398470114765;8112.878306825402;8273.958630206931;4584.4957054723955;4645;4659;4705.341252224691;4709.905801883943;3357.6138744044747;3412.283420481677;3412.812295323781;3415.163284995192;3418.4701371287492;594.5867622002753;604.9879002419927;608.5983251054283;614.3334482086985;623.0187454758773;662.2978944113678;701.9824504387329;715.2882881532908;752.5747952406873;779.7894568466482;9089.772755681028;9196.356255062215;9245.44527328349;9399.154076133182;9496.287778416647;646.5021933111572;801.102764903312;806.3226889412921;808.2564041082219;821.4330218068536;4439.78932842234;4513.864584062483;4545.36364908913;4642.558956899089;4696.7651617419;51272;52307;52335.73832130815;54128.72935635297;54788;45373.773131134134;45754.54245457503;45797.77101114473;46297.537024629324;46934.765326173154;45537.77231113889;45551.31673024907;45639.54360456419;46043.76978115088;46940.5305946943;9172.35793494449;9421.85867212006;9433.811323773349;9492.145706886413;9523.476208808583;32413.675863241067;32664.34671306608;33231.501527477594;33363.666363337026;33544.49683254802;41128;43557.346639801064;43893.78053109714;44857;45186.54813451955;11830.822537662114;11899.82150267764;11967.162298639012;12129.272243665408;12476.5009399623;12793.744125117631;12822.47076614423;13088.607341779381;13092.934535327262;13548.390322435711;10384.844227336747;10858.728531786768;12050.51797928073;12647.557335493213;13034;12069.758604827679;12563.87436125627;12720.872791272339;12788.168769030042;12945.029122815638;11667.824982625098;11759.294442333487;11902.166848320881;12177.452014659184;12356.567520136752;10370.896291037296;10509.78980420372;10630.787384252426;10654.786904262026;11011.37399437269;9984.400935943866;10743.140548755924;11070.28043177191;11165.553377864795;11211.383373914186 00:46:49 INFO - PROCESS | 17947 | __end_tp_report 00:46:49 INFO - PROCESS | 17947 | __start_cc_report 00:46:49 INFO - PROCESS | 17947 | _x_x_mozilla_cycle_collect,822 00:46:49 INFO - PROCESS | 17947 | __end_cc_report 00:46:49 INFO - PROCESS | 17947 | __startTimestamp1461311209688__endTimestamp 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | ------- Summary: start ------- 00:46:49 INFO - PROCESS | 17947 | Number of tests: 6 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | [#0] dojo.html Cycles:165 Average:5176.20 Median:5385.46 stddev:578.73 (10.7%) stddev-sans-first:555.26 00:46:49 INFO - PROCESS | 17947 | Values: 3020.7 3056.8 3106.9 3111.8 3130.6 5139.7 5159.9 5180.5 5197.8 5207.1 5168.5 5170.6 5191.5 5202.8 5215.3 4668.3 4696.5 4818.4 4831.6 4863.1 4671.8 4773.8 4792.2 4819.3 4835.6 4763.6 4764.3 4767.3 4779.2 4818.3 4767.7 4776.4 4784.9 4802.0 4820.9 4662.3 4743.4 4747.1 4753.4 4804.5 5036.4 5054.2 5069.6 5109.4 5115.1 5427.6 5464.2 5485.9 5511.2 5513.4 5504.7 5522.9 5535.6 5644.0 5700.9 5186.2 5213.6 5218.8 5220.3 5260.5 5671.2 5673.2 5673.9 5677.1 5679.2 5316.0 5467.8 5527.8 5528.8 5550.1 5565.3 5566.2 5569.5 5571.6 5572.7 5536.5 5536.6 5538.5 5547.7 5559.5 5470.5 5586.2 5619.7 5629.5 5653.8 4207.7 4213.0 4217.2 4218.4 4253.9 3724.6 3777.4 3795.9 3825.6 3835.1 5265.2 5273.2 5277.1 5281.9 5318.5 5516.7 5639.5 5644.1 5647.0 5650.7 5079.3 5219.6 5297.9 5316.3 5335.8 4793.0 4807.5 4815.1 4829.1 4839.2 5782.0 5782.9 5788.2 5791.4 5796.8 5506.7 5509.6 5568.1 5568.5 5578.9 5793.3 5813.9 5816.1 5834.3 5835.2 5532.4 5546.2 5555.0 5556.3 5559.7 5399.6 5530.4 5579.5 5593.0 5643.9 5385.5 5434.2 5449.2 5456.1 5458.9 5268.9 5441.6 5443.1 5450.5 5499.8 5405.6 5448.6 5449.9 5481.3 5501.4 5403.6 5426.7 5446.8 5449.2 5452.0 5213.6 5259.5 5310.1 5339.7 5349.9 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | [#1] ext.html Cycles:180 Average:51943.37 Median:3926.33 stddev:95276.07 (2426.6%) stddev-sans-first:95465.32 00:46:49 INFO - PROCESS | 17947 | Values: 587.7 630.1 638.3 641.4 656.3 31404.2 37431.3 38875.2 38884.2 39036.6 40560.0 41580.9 41584.6 41684.8 41724.0 8602.5 8804.2 8809.8 8813.4 8820.6 8751.2 8889.2 8890.3 8890.6 8894.5 8840.1 8942.6 8963.1 8974.1 8974.1 8767.4 8832.3 8835.0 8835.9 8839.6 8705.8 8843.0 8852.2 8859.4 8862.5 41017.8 41497.6 41498.8 41501.8 41507.6 3490.2 3558.4 3585.1 3725.6 3854.3 31926.7 32029.0 32180.8 32212.4 33403.7 3906.2 3914.2 3938.5 3976.5 4043.6 294593.0 296307.0 297443.1 297984.0 298370.0 50270.7 55520.7 56318.4 57793.4 57868.7 53695.7 53852.2 53979.5 54055.5 54078.2 16282.0 16484.2 16521.8 16525.3 16528.7 11881.3 12122.9 12488.6 12491.5 12505.4 16100.8 16175.8 16247.9 16386.0 16817.7 6237.3 6301.1 6362.2 6426.1 6455.1 1013.4 1045.8 1061.2 1070.2 1089.3 32113.4 32349.2 32502.7 32611.2 32919.7 1102.2 1146.2 1158.4 1169.2 1184.7 17226.8 17366.4 17409.9 17428.4 17502.7 455599.0 461909.0 462684.0 463705.0 465640.0 56880.1 57558.7 57575.0 57590.1 57699.0 1240.1 1340.6 1410.1 1428.2 1464.6 30950.7 31975.7 32460.2 32543.7 32909.8 46606.8 46674.3 47271.5 47272.3 47359.5 298774.0 299059.0 300355.0 300872.0 301773.0 27385.9 27982.0 28209.9 28318.4 28360.7 42123.8 42834.8 43097.0 43511.8 43692.3 38758.0 39674.2 40053.8 40225.2 40642.0 38540.4 38583.2 39100.6 39851.0 40495.4 40072.0 40368.2 41163.6 42611.4 42643.4 33541.5 35605.0 35851.6 35941.6 36328.1 27225.6 27921.6 28093.0 28283.0 28412.0 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | [#2] jquery.html Cycles:180 Average:28297.09 Median:12403.76 stddev:79147.12 (638.1%) stddev-sans-first:79341.39 00:46:49 INFO - PROCESS | 17947 | Values: 381.0 385.6 388.3 396.2 402.9 17653.4 19074.1 19257.1 19291.1 19347.7 18066.5 18377.4 18903.4 18998.3 19125.5 5685.9 5706.3 5799.1 5862.1 5865.1 5574.4 5762.4 5769.2 5775.5 5777.7 5647.5 5740.0 5749.1 5750.4 5751.1 5602.2 5698.2 5715.5 5732.6 5743.5 4901.5 5040.5 5067.9 5077.3 5084.1 22019.8 22135.2 22319.7 22394.6 22420.3 2387.2 2423.1 2449.0 2555.5 2882.5 9454.6 13701.9 14007.7 14242.3 14579.6 1835.5 1886.4 1921.9 1922.1 1963.4 70957.0 72807.3 73476.0 74677.6 76113.6 10111.7 10232.2 10291.0 10321.4 10334.3 14111.8 14486.7 14627.3 14639.8 14656.5 7933.0 7967.8 8032.5 8089.5 8218.1 7776.2 7867.3 7998.4 8066.0 8117.9 4353.8 4468.7 4480.0 4517.2 4673.9 1811.8 1867.1 1891.8 1912.6 1945.8 954.4 989.6 1014.9 1024.1 1062.2 18459.5 19332.0 19437.3 19476.3 19684.0 1003.6 1004.6 1013.6 1030.4 1044.7 10189.8 10778.4 10841.9 10848.1 10849.5 473745.0 474079.0 479227.0 485353.9 489687.0 89107.6 91639.5 92502.0 94419.0 95596.5 1042.9 1052.4 1059.2 1063.2 1104.8 16222.3 16457.5 16878.7 17376.7 17757.4 37864.6 38131.4 38330.8 39835.4 40957.2 54429.0 55853.0 55952.4 56033.7 56513.0 7806.4 7995.6 8077.3 8456.8 8530.8 12629.2 12677.4 12902.6 12985.7 13175.6 11263.4 11390.1 11541.5 11639.4 12008.6 11161.3 11412.3 11567.6 11735.9 11848.3 6674.2 10983.8 11016.6 11758.6 11778.4 7882.0 8336.2 8576.7 8635.1 8644.7 10023.7 10795.8 11505.0 11689.4 11795.0 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | [#3] mootools.html Cycles:180 Average:5542.49 Median:4888.86 stddev:3116.45 (63.7%) stddev-sans-first:3109.14 00:46:49 INFO - PROCESS | 17947 | Values: 1333.4 1532.7 1542.3 1701.4 1857.7 8065.6 8241.4 8247.5 8256.9 8261.8 8058.9 8219.3 8222.6 8227.5 8233.5 2056.5 2261.5 2321.5 2339.6 2352.5 2333.3 2361.4 2363.4 2364.4 2366.2 2278.1 2316.3 2317.9 2319.3 2322.2 2024.0 2268.4 2343.5 2347.3 2350.2 2293.9 2298.3 2312.2 2329.3 2329.5 8160.7 8222.5 8239.9 8240.4 8244.6 4934.6 5076.0 5092.1 5112.9 5171.0 3269.1 3270.4 3331.1 3338.2 3344.8 1017.3 1030.8 1036.1 1040.9 1060.5 11372.2 11607.5 11611.7 11612.9 11621.2 4462.2 4466.2 4632.4 4637.8 4663.8 9863.4 9891.8 9903.2 9941.7 9948.7 4724.4 5259.5 5260.2 5274.6 5290.9 4692.4 4799.5 4816.7 4845.2 4868.5 3792.8 3821.9 3879.7 3913.4 3939.9 1228.0 1266.6 1276.5 1282.8 1291.1 872.4 949.3 962.9 963.6 972.9 5807.9 5828.9 5852.4 5872.8 5991.8 414.7 424.1 427.1 434.3 448.6 3733.5 3787.0 3807.6 3826.6 3883.5 10103.3 10427.2 10454.6 10455.2 10495.2 10134.4 10315.5 10362.0 10398.3 10419.8 7718.0 7774.0 7797.3 7826.8 7901.5 5633.7 5693.3 5704.4 5715.3 5887.8 9263.8 9389.5 9503.9 9505.6 9608.5 9799.1 9829.9 9860.8 9926.9 9939.8 6711.5 7245.9 7372.2 7451.2 7533.7 8087.8 8107.1 8190.0 8197.2 8205.1 7225.3 7346.5 7384.2 7493.4 7501.0 7123.2 7341.0 7348.4 7348.5 7449.1 6610.5 6675.0 6679.6 6682.9 6683.2 4803.6 4876.4 4877.5 4887.1 5008.7 4793.3 4890.6 4920.6 4937.9 4982.4 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | [#4] prototype.html Cycles:180 Average:4951.99 Median:5662.45 stddev:1485.40 (26.2%) stddev-sans-first:1448.30 00:46:49 INFO - PROCESS | 17947 | Values: 319.6 321.2 321.3 328.0 332.0 5646.2 5668.2 5692.3 5694.7 5743.8 5598.6 5618.2 5628.4 5653.2 5654.6 4098.8 4174.1 4303.6 4349.7 4358.7 4296.4 4337.4 4338.7 4355.7 4360.8 4092.7 4317.9 4324.2 4340.5 4356.5 4190.7 4282.4 4284.1 4287.7 4306.6 3733.7 3738.6 3751.0 3758.4 3761.6 5362.2 5450.4 5458.3 5462.7 5464.6 4925.6 4950.2 4952.2 4967.8 4980.7 5889.7 5892.3 5908.8 5911.8 5922.2 4035.7 4125.9 4152.9 4154.5 4164.5 6139.3 6144.4 6145.9 6152.8 6156.9 4188.2 4219.5 4232.5 4240.1 4245.9 4147.5 4274.4 4294.8 4297.7 4298.1 4924.3 4938.4 4940.3 4958.3 4969.1 5844.6 5901.4 5922.2 5932.5 5939.2 1458.1 1471.9 1485.8 1490.3 1496.7 939.6 1005.5 1019.4 1027.6 1042.5 5566.4 5662.0 5662.7 5679.0 5692.2 5980.1 6002.3 6011.1 6053.8 6060.3 5378.2 5662.2 5685.9 5714.5 5777.0 3232.4 3255.6 3263.2 3267.6 3277.2 6109.3 6192.3 6276.9 6294.7 6352.0 6212.0 6221.2 6232.7 6247.1 6254.1 6170.1 6270.2 6291.7 6321.0 6329.2 6071.9 6075.1 6079.5 6086.5 6122.9 5985.9 6008.5 6055.8 6058.6 6059.8 6123.6 6261.8 6279.3 6290.6 6321.2 4175.2 4179.9 4198.3 4199.4 4204.4 6000.4 6083.0 6101.3 6107.8 6137.3 5912.9 5981.4 5984.0 6002.2 6002.7 5898.8 5900.8 5937.6 5968.9 5979.6 5008.3 5388.2 5835.7 5840.0 5840.2 5970.8 5985.6 5991.5 5994.8 6000.8 5836.7 5840.2 5842.8 5862.7 5885.3 00:46:49 INFO - PROCESS | 17947 | 00:46:49 INFO - PROCESS | 17947 | [#5] yui.html Cycles:180 Average:14099.97 Median:45280.16 stddev:15694.55 (34.7%) stddev-sans-first:15706.63 00:46:49 INFO - PROCESS | 17947 | Values: 766.4 827.2 842.4 859.5 875.3 13204.2 13494.7 13574.5 13579.3 14622.3 13886.1 13913.8 13943.9 13946.2 13963.7 665.0 817.7 819.5 822.4 822.5 793.2 819.9 828.5 829.1 829.6 843.6 846.1 849.8 849.9 850.7 683.2 697.0 839.8 844.2 846.1 511.9 602.2 620.5 628.9 629.4 13857.1 14062.6 14080.2 14108.8 14167.6 12886.7 13172.8 13256.4 13415.7 13748.2 11112.4 11259.5 11486.4 11527.5 11666.4 3744.9 3757.1 3812.1 3816.4 3844.5 56588.0 57222.4 57308.0 57459.2 57565.0 10147.0 10197.9 10231.1 10623.7 10624.0 18542.6 18866.4 19085.9 19115.3 19132.6 7973.2 7989.2 8020.4 8112.9 8274.0 4584.5 4645.0 4659.0 4705.3 4709.9 3357.6 3412.3 3412.8 3415.2 3418.5 594.6 605.0 608.6 614.3 623.0 662.3 702.0 715.3 752.6 779.8 9089.8 9196.4 9245.4 9399.2 9496.3 646.5 801.1 806.3 808.3 821.4 4439.8 4513.9 4545.4 4642.6 4696.8 51272.0 52307.0 52335.7 54128.7 54788.0 45373.8 45754.5 45797.8 46297.5 46934.8 45537.8 45551.3 45639.5 46043.8 46940.5 9172.4 9421.9 9433.8 9492.1 9523.5 32413.7 32664.3 33231.5 33363.7 33544.5 41128.0 43557.3 43893.8 44857.0 45186.5 11830.8 11899.8 11967.2 12129.3 12476.5 12793.7 12822.5 13088.6 13092.9 13548.4 10384.8 10858.7 12050.5 12647.6 13034.0 12069.8 12563.9 12720.9 12788.2 12945.0 11667.8 11759.3 11902.2 12177.5 12356.6 10370.9 10509.8 10630.8 10654.8 11011.4 9984.4 10743.1 11070.3 11165.6 11211.4 00:46:49 INFO - PROCESS | 17947 | -------- Summary: end -------- 00:46:49 INFO - PROCESS | 17947 | 00:46:50 INFO - TEST-INFO | 17947: exit 0 00:46:50 INFO - TEST-OK | dromaeo_css | took 1111235ms 00:46:50 INFO - TEST-START | kraken 00:46:50 INFO - operating with platform_type : linux_ 00:46:50 INFO - Initialising browser for kraken test... 00:46:50 INFO - TEST-INFO | started process 18131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRRta5j/profile http://localhost:56952/getInfo.html) 00:46:54 INFO - PROCESS | 18131 | __metrics Screen width/height:1600/1200 00:46:54 INFO - PROCESS | 18131 | colorDepth:24 00:46:54 INFO - PROCESS | 18131 | Browser inner width/height: 1024/697 00:46:54 INFO - PROCESS | 18131 | __metrics 00:46:55 ERROR - PROCESS | 18131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:46:56 INFO - TEST-INFO | 18131: exit 0 00:46:56 INFO - Browser initialized. 00:46:56 INFO - Running cycle 1/1 for kraken test... 00:46:56 INFO - TEST-INFO | started process 18212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRRta5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:47:07 INFO - PROCESS | 18212 | RSS: Main: 154025984 00:47:07 INFO - PROCESS | 18212 | 00:47:10 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56952/tests/kraken/driver.html?testName=audio-beat-detection) 00:47:11 INFO - PROCESS | 18212 | RSS: Main: 209031168 00:47:11 INFO - PROCESS | 18212 | 00:47:14 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56952/tests/kraken/driver.html?testName=audio-dft) 00:47:14 INFO - PROCESS | 18212 | RSS: Main: 194715648 00:47:14 INFO - PROCESS | 18212 | 00:47:17 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56952/tests/kraken/driver.html?testName=audio-fft) 00:47:18 INFO - PROCESS | 18212 | RSS: Main: 265428992 00:47:18 INFO - PROCESS | 18212 | 00:47:20 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56952/tests/kraken/driver.html?testName=audio-oscillator) 00:47:20 INFO - PROCESS | 18212 | RSS: Main: 173604864 00:47:20 INFO - PROCESS | 18212 | 00:47:23 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:47:23 INFO - PROCESS | 18212 | RSS: Main: 178212864 00:47:23 INFO - PROCESS | 18212 | 00:47:26 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56952/tests/kraken/driver.html?testName=imaging-darkroom) 00:47:27 INFO - PROCESS | 18212 | RSS: Main: 214306816 00:47:27 INFO - PROCESS | 18212 | 00:47:30 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56952/tests/kraken/driver.html?testName=imaging-desaturate) 00:47:31 INFO - PROCESS | 18212 | RSS: Main: 214708224 00:47:31 INFO - PROCESS | 18212 | 00:47:34 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56952/tests/kraken/driver.html?testName=json-parse-financial) 00:47:34 INFO - PROCESS | 18212 | RSS: Main: 215027712 00:47:34 INFO - PROCESS | 18212 | 00:47:36 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:47:36 INFO - PROCESS | 18212 | RSS: Main: 200347648 00:47:36 INFO - PROCESS | 18212 | 00:47:38 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:47:39 INFO - PROCESS | 18212 | RSS: Main: 202694656 00:47:39 INFO - PROCESS | 18212 | 00:47:41 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:47:41 INFO - PROCESS | 18212 | RSS: Main: 217042944 00:47:41 INFO - PROCESS | 18212 | 00:47:44 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:47:44 INFO - PROCESS | 18212 | RSS: Main: 223272960 00:47:44 INFO - PROCESS | 18212 | 00:47:47 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:47:48 INFO - PROCESS | 18212 | RSS: Main: 220426240 00:47:48 INFO - PROCESS | 18212 | 00:47:49 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:56952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56952/tests/kraken/driver.html?testName=ai-astar) 00:47:50 INFO - PROCESS | 18212 | RSS: Main: 284168192 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | __start_tp_report 00:47:50 INFO - PROCESS | 18212 | _x_x_mozilla_page_load 00:47:50 INFO - PROCESS | 18212 | _x_x_mozilla_page_load_details 00:47:50 INFO - PROCESS | 18212 | |i|pagename|runs| 00:47:50 INFO - PROCESS | 18212 | |0;ai-astar;111;112;106;110;110;113;102;112;110;113 00:47:50 INFO - PROCESS | 18212 | |1;audio-beat-detection;158;126;160;182;128;153;151;129;194;136 00:47:50 INFO - PROCESS | 18212 | |2;audio-dft;162;161;161;162;159;160;159;161;160;160 00:47:50 INFO - PROCESS | 18212 | |3;audio-fft;74;76;101;107;73;75;72;123;110;74 00:47:50 INFO - PROCESS | 18212 | |4;audio-oscillator;92;92;158;93;93;92;153;92;92;150 00:47:50 INFO - PROCESS | 18212 | |5;imaging-gaussian-blur;117;117;116;118;117;116;116;116;116;117 00:47:50 INFO - PROCESS | 18212 | |6;imaging-darkroom;145;146;146;146;145;145;145;146;145;144 00:47:50 INFO - PROCESS | 18212 | |7;imaging-desaturate;94;95;94;95;95;95;95;94;95;95 00:47:50 INFO - PROCESS | 18212 | |8;json-parse-financial;59;58;58;59;59;59;61;74;56;56 00:47:50 INFO - PROCESS | 18212 | |9;json-stringify-tinderbox;60;60;60;60;61;60;61;61;60;61 00:47:50 INFO - PROCESS | 18212 | |10;stanford-crypto-aes;75;75;75;75;76;78;76;78;86;77 00:47:50 INFO - PROCESS | 18212 | |11;stanford-crypto-ccm;123;122;122;121;125;120;123;131;157;135 00:47:50 INFO - PROCESS | 18212 | |12;stanford-crypto-pbkdf2;163;162;163;169;162;167;170;166;162;161 00:47:50 INFO - PROCESS | 18212 | |13;stanford-crypto-sha256-iterative;68;69;70;66;69;67;67;67;67;67 00:47:50 INFO - PROCESS | 18212 | __end_tp_report 00:47:50 INFO - PROCESS | 18212 | __start_cc_report 00:47:50 INFO - PROCESS | 18212 | _x_x_mozilla_cycle_collect,1628 00:47:50 INFO - PROCESS | 18212 | __end_cc_report 00:47:50 INFO - PROCESS | 18212 | __startTimestamp1461311270217__endTimestamp 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | ------- Summary: start ------- 00:47:50 INFO - PROCESS | 18212 | Number of tests: 14 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.45 (3.1%) stddev-sans-first:3.63 00:47:50 INFO - PROCESS | 18212 | Values: 111.0 112.0 106.0 110.0 110.0 113.0 102.0 112.0 110.0 113.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.50 stddev:23.10 (14.9%) stddev-sans-first:24.39 00:47:50 INFO - PROCESS | 18212 | Values: 158.0 126.0 160.0 182.0 128.0 153.0 151.0 129.0 194.0 136.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 00:47:50 INFO - PROCESS | 18212 | Values: 162.0 161.0 161.0 162.0 159.0 160.0 159.0 161.0 160.0 160.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#3] audio-fft Cycles:10 Average:88.50 Median:73.50 stddev:19.50 (26.5%) stddev-sans-first:19.97 00:47:50 INFO - PROCESS | 18212 | Values: 74.0 76.0 101.0 107.0 73.0 75.0 72.0 123.0 110.0 74.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:92.00 stddev:29.71 (32.3%) stddev-sans-first:30.74 00:47:50 INFO - PROCESS | 18212 | Values: 92.0 92.0 158.0 93.0 93.0 92.0 153.0 92.0 92.0 150.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 00:47:50 INFO - PROCESS | 18212 | Values: 117.0 117.0 116.0 118.0 117.0 116.0 116.0 116.0 116.0 117.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 00:47:50 INFO - PROCESS | 18212 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 144.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 00:47:50 INFO - PROCESS | 18212 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.00 stddev:5.17 (8.8%) stddev-sans-first:5.48 00:47:50 INFO - PROCESS | 18212 | Values: 59.0 58.0 58.0 59.0 59.0 59.0 61.0 74.0 56.0 56.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 00:47:50 INFO - PROCESS | 18212 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 61.0 61.0 60.0 61.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.50 stddev:3.35 (4.4%) stddev-sans-first:3.46 00:47:50 INFO - PROCESS | 18212 | Values: 75.0 75.0 75.0 75.0 76.0 78.0 76.0 78.0 86.0 77.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:124.00 stddev:11.27 (9.1%) stddev-sans-first:11.81 00:47:50 INFO - PROCESS | 18212 | Values: 123.0 122.0 122.0 121.0 125.0 120.0 123.0 131.0 157.0 135.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:3.24 (2.0%) stddev-sans-first:3.39 00:47:50 INFO - PROCESS | 18212 | Values: 163.0 162.0 163.0 169.0 162.0 167.0 170.0 166.0 162.0 161.0 00:47:50 INFO - PROCESS | 18212 | 00:47:50 INFO - PROCESS | 18212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 00:47:50 INFO - PROCESS | 18212 | Values: 68.0 69.0 70.0 66.0 69.0 67.0 67.0 67.0 67.0 67.0 00:47:50 INFO - PROCESS | 18212 | -------- Summary: end -------- 00:47:50 INFO - PROCESS | 18212 | 00:47:51 INFO - TEST-INFO | 18212: exit 0 00:47:51 INFO - TEST-OK | kraken | took 60786ms 00:47:51 INFO - SUITE-END | took 1172s 00:47:51 INFO - Completed test suite (00:19:32) 00:47:51 INFO - javascript benchmark 00:47:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.7130322619346, 3056.8318742469182, 3106.9223269418276, 3111.7666175036866, 3130.593022907022, 5139.6659217150855, 5159.896802063957, 5180.533751962323, 5197.792088316468, 5207.140821764414, 5168.508991645787, 5170.612204084689, 5191.5327620514145, 5202.843914682566, 5215.295935048767, 4668.323093151491, 4696.459907110692, 4818.421789385278, 4831.637627177958, 4863.124637565237, 4671.789769460365, 4773.809047638108, 4792.2332426811545, 4819.301201325806, 4835.6131509479155, 4763.571278584926, 4764.332993380912, 4767.308740232682, 4779.163646361872, 4818.301346304784, 4767.666263361566, 4776.402949631296, 4784.904301913943, 4801.975990120062, 4820.855374338776, 4662.300654901758, 4743.430788305391, 4747.146571643893, 4753.382060332169, 4804.471508134103, 5036.420811606676, 5054.241863720435, 5069.569086627641, 5109.41241757199, 5115.104856650109, 5427.565794736451, 5464.23500709901, 5485.890282194334, 5511.173324001392, 5513.365962914276, 5504.697241651707, 5522.861928451781, 5535.58483113768, 5643.971780141073, 5700.942990570083, 5186.24799404088, 5213.582913366921, 5218.817341393109, 5220.29526013987, 5260.500252476008, 5671.2060311556415, 5673.234113394639, 5673.914891276634, 5677.063284558084, 5679.176519404663, 5315.973420132875, 5467.781288748485, 5527.778888844401, 5528.778848846082, 5550.139728342114, 5565.276514053147, 5566.192902029183, 5569.470900264469, 5571.637843540157, 5572.721363931787, 5536.52939500147, 5536.557075433956, 5538.529225015838, 5547.72261386929, 5559.471850174227, 5470.53500452466, 5586.245856809279, 5619.7471113799975, 5629.493345598916, 5653.830385088454, 4207.726497777635, 4212.957870421318, 4217.156568686275, 4218.388333691598, 4253.914921701548, 3724.5530536335273, 3777.433384992273, 3795.905102372463, 3825.617438256152, 3835.0987517933263, 5265.183896496049, 5273.235380869753, 5277.129273669878, 5281.894362112736, 5318.494742999486, 5516.668999860021, 5639.548836093185, 5644.096944488862, 5647.040003199466, 5650.74571644277, 5079.263506791494, 5219.634625576249, 5297.867553311121, 5316.282301889273, 5335.813246536352, 4792.976035119872, 4807.543283388072, 4815.085133824562, 4829.058333624909, 4839.1531481991215, 5781.971090144522, 5782.855428614318, 5788.18965344852, 5791.420857914175, 5796.768129274866, 5506.724663766716, 5509.559235261249, 5568.081266590967, 5568.526675232651, 5578.944210558005, 5793.304803423616, 5813.854653633523, 5816.127580862904, 5834.27071616048, 5835.212246346859, 5532.419095995024, 5546.195801608664, 5555.0, 5556.333240011225, 5559.722013899208, 5399.568034557305, 5530.364008139116, 5579.525740312119, 5593.0, 5643.88712225745, 5385.461453854583, 5434.239206511171, 5449.23710680513, 5456.127019676833, 5458.918116228339, 5268.893532358247, 5441.564674826083, 5443.129099344086, 5450.5367043801725, 5499.84503254305, 5405.621606487508, 5448.618596698351, 5449.855530338673, 5481.314835645544, 5501.449855014466, 5403.594730395314, 5426.701531415652, 5446.782128714807, 5449.2371068049715, 5452.018636645442, 5213.556847667991, 5259.474052594863, 5310.070737620824, 5339.679619222859, 5349.919751203657], "value": 5138.041076041223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7237698281806, 630.0895206426712, 638.3425072175661, 641.4355367276796, 656.3174298729322, 31404.214894627617, 37431.25137497248, 38875.222495550144, 38884.22231555374, 39036.60963390365, 40560.0, 41580.88143389243, 41584.58415415845, 41684.79157604208, 41724.0, 8602.526861022641, 8804.163604457566, 8809.823803523926, 8813.42712723671, 8820.647174113059, 8751.168638979287, 8889.19997200255, 8890.333225008118, 8890.59992300348, 8894.4663320201, 8840.071792461795, 8942.642294308253, 8963.148500892405, 8974.05772393899, 8974.102589741005, 8767.430117042404, 8832.293416526663, 8834.955825220864, 8835.911640883573, 8839.558022098869, 8705.7823554411, 8842.955785221096, 8852.247558957497, 8859.379843410963, 8862.468251904906, 41017.79491102525, 41497.585024149674, 41498.79250603758, 41501.792491037355, 41507.58492415067, 3490.234228840834, 3558.3594952908466, 3585.103724068983, 3725.590185079639, 3854.2676891390824, 31926.680733192836, 32029.0, 32180.839095804604, 32212.355752885047, 33403.665963340296, 3906.199229158016, 3914.197589494147, 3938.468306778577, 3976.5228172619472, 4043.636072753437, 294593.0, 296307.0, 297443.1264340229, 297984.0, 298370.0, 50270.74864625726, 55520.72239638776, 56318.436815632136, 57793.42206577965, 57868.71065644645, 53695.731521342146, 53852.192217116775, 53979.52245730538, 54055.459445405046, 54078.18882716762, 16282.0, 16484.175791210633, 16521.752173717403, 16525.33898644065, 16528.66942661164, 11881.287122772661, 12122.878771212176, 12488.625341239778, 12491.50033998648, 12505.437255323532, 16100.75848862268, 16175.757363639555, 16247.918760406123, 16386.0, 16817.663646726996, 6237.313895471494, 6301.14934483848, 6362.168834868439, 6426.068220108058, 6455.128557644752, 1013.3717095400899, 1045.8012977534245, 1061.1669839176363, 1070.1652710885521, 1089.2538611051455, 32113.357732845212, 32349.191270218435, 32502.674973249967, 32611.184720381705, 32919.67080329166, 1102.1733699725205, 1146.1919346860443, 1158.4323681396224, 1169.1582060916128, 1184.6979020349927, 17226.827731722773, 17366.39217627377, 17409.91295043542, 17428.390006349717, 17502.693524122587, 455599.0, 461909.0, 462684.0, 463705.0, 465640.0, 56880.146797798065, 57558.7122064387, 57575.0, 57590.13614795781, 57699.0, 1240.1443004327166, 1340.6112227454123, 1410.0975375759522, 1428.2287564715145, 1464.6191990082655, 30950.69049309568, 31975.680243197272, 32460.188495287806, 32543.674563254066, 32909.83545082259, 46606.76696616495, 46674.29988550107, 47271.52728472671, 47272.29091563698, 47359.52640473689, 298774.0, 299059.0, 300355.0, 300872.0, 301773.0, 27385.863070684518, 27982.0, 28209.858950705115, 28318.43363132767, 28360.716392835806, 42123.7893810529, 42834.78582607067, 43097.0, 43511.78244108886, 43692.34461483017, 38758.0, 39674.2065158701, 40053.799731001156, 40225.1954960905, 40642.0, 38540.42189367218, 38583.2283354337, 39100.6089939097, 39851.0, 40495.392569112075, 40072.0, 40368.19263614652, 41163.588364117175, 42611.3608295882, 42643.36034959416, 33541.496877547346, 35605.0, 35851.64148358483, 35941.64058359383, 36328.09179770527, 27225.591616125377, 27921.581176281965, 28093.0, 28283.0, 28412.0], "value": 19235.145670368907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.039551507494, 385.6009030653274, 388.32237745134745, 396.17397725741824, 402.90531725044593, 17653.382131625396, 19074.141663625134, 19257.133428995694, 19291.13189906456, 19347.70978435323, 18066.5483362916, 18377.356792512266, 18903.441459429127, 18998.33505827296, 19125.521861953457, 5685.886282274352, 5706.28671416073, 5799.10113932339, 5862.06207006879, 5865.090910908816, 5574.414686457924, 5762.3949485304065, 5769.221155144065, 5775.480206781389, 5777.682227477487, 5647.53149337477, 5739.971300143494, 5749.080147176453, 5750.3962083981205, 5751.05107657236, 5602.187682785993, 5698.230738850244, 5715.514181294553, 5732.598718089715, 5743.54051675865, 4901.50984901507, 5040.495950404967, 5067.923981140286, 5077.314562534048, 5084.059449001947, 22019.779802201934, 22135.225267115573, 22319.665205021938, 22394.552108957894, 22420.32739017832, 2387.1883559589824, 2423.1155628195756, 2449.0326321103066, 2555.527227462907, 2882.538793793004, 9454.621815127386, 13701.90384769226, 14007.719845603133, 14242.287885605781, 14579.635509112357, 1835.4677143628332, 1886.368066697658, 1921.932732354361, 1922.0774028466274, 1963.3717210492648, 70957.0, 72807.27192728058, 73476.0, 74677.6266118666, 76113.61943190248, 10111.696649100539, 10232.232582556338, 10291.0, 10321.380717156844, 10334.328268662513, 14111.78832317516, 14486.710265794625, 14627.341769620392, 14639.780403293958, 14656.48702295436, 7932.960335198402, 7967.8406431871035, 8032.4778889372, 8089.514629122272, 8218.054923683852, 7776.222377762291, 7867.252611001945, 7998.400119990907, 8066.0, 8117.918820811835, 4353.760543170156, 4468.7155287122305, 4479.955200448019, 4517.164324599959, 4673.859784206479, 1811.80975997521, 1867.1037901807208, 1891.8297353238274, 1912.6474436442975, 1945.8248757611882, 954.4368822394821, 989.649128938993, 1014.8934361891895, 1024.0783295034528, 1062.1555863088863, 18459.538511537317, 19332.0, 19437.31969381065, 19476.318328858422, 19684.0, 1003.6336737091056, 1004.6182450668699, 1013.5945621751358, 1030.443560477334, 1044.7335929337971, 10189.796204076025, 10778.4071876046, 10841.945790271157, 10848.132149428027, 10849.511771970281, 473745.0, 474079.0, 479227.0, 485353.8913803183, 489687.0, 89107.55446222727, 91639.54180229057, 92502.0, 94419.0, 95596.52201738946, 1042.864427624404, 1052.4422056310168, 1059.2479339668766, 1063.2185343772321, 1104.8453216549528, 16222.26999784989, 16457.506274811774, 16878.746818797972, 17376.652466950844, 17757.378491752726, 37864.62135378611, 38131.42802857904, 38330.80834595809, 39835.402468962406, 40957.18085638211, 54429.0, 55853.0, 55952.44047559635, 56033.71983140058, 56513.0, 7806.414518911218, 7995.560244186626, 8077.27304542594, 8456.83086338282, 8530.829383412422, 12629.2422454653, 12677.366131693194, 12902.612921612366, 12985.740285194055, 13175.60473185806, 11263.436828158396, 11390.088792896715, 11541.480633371351, 11639.41802909868, 12008.579699710468, 11161.330320180816, 11412.31526108436, 11567.595134170264, 11735.882641173479, 11848.348340841336, 6674.16572928384, 10983.780324393307, 11016.622922134733, 11758.647240582795, 11778.411079446165, 7882.0, 8336.249737523409, 8576.742697719079, 8635.136486351566, 8644.697435589724, 10023.69928902134, 10795.784084318428, 11505.0, 11689.415529223335, 11795.0], "value": 9094.108933313342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.353323638036, 1532.7011232809602, 1542.2905463486795, 1701.4300209429841, 1857.693480575705, 8065.5967201639905, 8241.423100382961, 8247.546384948833, 8256.876146857801, 8261.75214743557, 8058.919410805905, 8219.260266576008, 8222.588870556463, 8227.54748488833, 8233.505989640626, 2056.5269987902793, 2261.4685548895995, 2321.4776675248017, 2339.590571649963, 2352.529494101178, 2333.288347054148, 2361.362432143329, 2363.432776133724, 2364.3970787449175, 2366.1600131953082, 2278.134308962592, 2316.281952594701, 2317.884105794712, 2319.3273950554403, 2322.1756276521846, 2024.0486971123548, 2268.3875353654503, 2343.5312937412414, 2347.3310106619533, 2350.15394457995, 2293.8738369389675, 2298.253067752987, 2312.2485192312397, 2329.3477826208687, 2329.464223228667, 8160.673573057071, 8222.547759873205, 8239.876401853977, 8240.423170378075, 8244.587770611446, 4934.629902757271, 5075.974620126875, 5092.134337162691, 5112.897742045176, 5171.0, 3269.1173383186406, 3270.427675156862, 3331.1339051846453, 3338.2488939988552, 3344.782589131699, 1017.3438132404558, 1030.8041472120349, 1036.1451802263089, 1040.9479526023745, 1060.5386656804314, 11372.203945723802, 11607.535698572132, 11611.709707257301, 11612.94193529027, 11621.186516943817, 4462.174497717932, 4466.173757854807, 4632.351470794091, 4637.791299391535, 4663.766811659403, 9863.408195508293, 9891.802163956681, 9903.207743380657, 9941.701748947544, 9948.701538953843, 4724.362211101526, 5259.474052594786, 5260.158374660036, 5274.630775845654, 5290.947090529123, 4692.436907571113, 4799.520047995243, 4816.662833601685, 4845.224764037807, 4868.488808675038, 3792.7534710243744, 3821.8662346817728, 3879.7090218233743, 3913.3934240192816, 3939.881803545898, 1227.9877201228053, 1266.6200139957975, 1276.4957841652495, 1282.807578863178, 1291.109134697056, 872.3806097670725, 949.3354651743807, 962.9073078139791, 963.6145541783343, 972.8978457262027, 5807.941920580824, 5828.88342233153, 5852.4440178183, 5872.823815285548, 5991.820245392645, 414.734569875274, 424.069168175851, 427.05833636831335, 434.34414034807037, 448.6097095526847, 3733.4586484959527, 3786.962130378716, 3807.600201978808, 3826.6364695353896, 3883.456316115746, 10103.343282686601, 10427.165826733843, 10454.63408780689, 10455.215858810467, 10495.212859035602, 10134.442605656759, 10315.535800888978, 10362.015608517178, 10398.324108932895, 10419.843702344318, 7718.035245594188, 7774.0, 7797.259260370256, 7826.804329891685, 7901.486403383762, 5633.718314084362, 5693.345265294379, 5704.401037890962, 5715.257016587817, 5887.8233652990475, 9263.76840578991, 9389.530523473662, 9503.857442138235, 9505.619775208914, 9608.519574021131, 9799.069088436587, 9829.901700982899, 9860.802783944424, 9926.900730992598, 9939.801203975736, 6711.463082953254, 7245.855082898418, 7372.152202496782, 7451.2176221495965, 7533.660985255567, 8087.757367278991, 8107.14874938123, 8190.0, 8197.180281971756, 8205.097439281555, 7225.349718525358, 7346.52247603904, 7384.224656411215, 7493.400527957641, 7501.024866767285, 7123.180834204133, 7341.0, 7348.448866335153, 7348.52234604749, 7449.14334851499, 6610.537262391586, 6675.0, 6679.599224046573, 6682.899756503559, 6683.164604424447, 4803.5916947059895, 4876.414830220397, 4877.463479017376, 4887.144749668865, 5008.6744361616375, 4793.257045158006, 4890.584300334512, 4920.6063514918005, 4937.851864444073, 4982.402111746614], "value": 4388.261581243476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.603691422636, 321.16977612870716, 321.32201055772333, 328.0339400465629, 331.97178239849603, 5646.20953066571, 5668.178114173443, 5692.316921969359, 5694.6867922264255, 5743.770249190033, 5598.636088654245, 5618.2415373924505, 5628.43715628438, 5653.208550802891, 5654.642885707432, 4098.8360465581345, 4174.144300418407, 4303.612674859262, 4349.7390156590545, 4358.694891357606, 4296.355546667994, 4337.371081193225, 4338.655016944742, 4355.695101342907, 4360.8255669773325, 4092.7258193445273, 4317.892052698692, 4324.178406102847, 4340.544242854487, 4356.542563030884, 4190.685698572619, 4282.372698374629, 4284.100338928829, 4287.656987440997, 4306.612404883575, 3733.701303895682, 3738.6261373862667, 3750.962490375116, 3758.361078616642, 3761.6238376162437, 5362.168863826113, 5450.427705090948, 5458.344998600153, 5462.672239665593, 5464.617476776627, 4925.605951523869, 4950.232713929347, 4952.158133117378, 4967.7764500597195, 4980.662955819574, 5889.734961926723, 5892.292924849003, 5908.822735317947, 5911.763529458816, 5922.170896074553, 4035.7376770509823, 4125.938110928339, 4152.944292575195, 4154.480689913761, 4164.4586203793615, 6139.26328840542, 6144.446999769997, 6145.924463218918, 6152.784652537184, 6156.907646385263, 4188.204241194163, 4219.45147130871, 4232.513260975027, 4240.109576988867, 4245.893852653709, 4147.502299724052, 4274.401583778274, 4294.806733696991, 4297.67767417445, 4298.118885628439, 4924.261360795837, 4938.407391113089, 4940.333055037524, 4958.330625365602, 4969.130402179604, 5844.620099693507, 5901.439363260483, 5922.200502932135, 5932.525397968152, 5939.198208241832, 1458.0522660270697, 1471.852814718541, 1485.769705695619, 1490.3293517916982, 1496.6557691730964, 939.557778809524, 1005.492226425665, 1019.3628981886321, 1027.5992362978445, 1042.4579218806177, 5566.415526369754, 5662.0, 5662.66024038559, 5679.006173919547, 5692.203091567184, 5980.102984552352, 6002.309734380515, 6011.12838638395, 6053.757849685963, 6060.33336333003, 5378.1663842104535, 5662.235598194191, 5685.857853553612, 5714.457126572969, 5776.971115144482, 3232.3858466891215, 3255.5604993326074, 3263.216827961272, 3267.640559538449, 3277.2298509850166, 6109.266887973383, 6192.256929168439, 6276.874462510816, 6294.653794041372, 6352.0, 6211.9689401552705, 6221.160143380585, 6232.696670764502, 6247.09417134522, 6254.124422580842, 6170.074488826533, 6270.216222972129, 6291.716872740738, 6320.9772872680305, 6329.177206963065, 6071.908921366271, 6075.1191077294425, 6079.483243924316, 6086.482648974887, 6122.877542449037, 5985.880282394241, 6008.54935879802, 6055.848603784941, 6058.636481811105, 6059.757609695739, 6123.632002398574, 6261.843453913689, 6279.340669229665, 6290.622562646256, 6321.241451025906, 4175.227582897173, 4179.937300940549, 4198.349255865346, 4199.391088292242, 4204.411382406404, 6000.369961154191, 6083.0, 6101.29835068955, 6107.786227482017, 6137.263528376445, 5912.852178695395, 5981.431763982415, 5983.995361553754, 6002.189704389852, 6002.748969136574, 5898.764049437975, 5900.763969441175, 5937.614055086406, 5968.8806223876145, 5979.611325263844, 5008.323876276656, 5388.164834450667, 5835.7373918174635, 5840.0, 5840.2115714378015, 5970.791022314198, 5985.6408615483215, 5991.520678345809, 5994.820155395345, 6000.849978750566, 5836.708164591839, 5840.1531777892815, 5842.824715258549, 5862.706864656665, 5885.323187833454], "value": 4471.349224608263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.375404045703, 827.2389401750389, 842.4313588327877, 859.5444414460338, 875.2953872132932, 13204.207747535154, 13494.662633434169, 13574.457021719132, 13579.321033948312, 14622.330755932906, 13886.09740366878, 13913.791293130611, 13943.860561394384, 13946.163230206195, 13963.650908727286, 664.9900251496232, 817.709713051867, 819.4755356571799, 822.40786633624, 822.5147163173726, 793.1552896165595, 819.8770184472318, 828.5235989306143, 829.1128492513013, 829.5810615639094, 843.6498852976008, 846.0735494633398, 849.7918010087537, 849.9362547808909, 850.6639877248483, 683.2381894187994, 696.979090627282, 839.7984483723924, 844.2064459408167, 846.0650980666337, 511.8950615123891, 602.1930612978585, 620.512897375558, 628.8962321216994, 629.4020680353636, 13857.099288546213, 14062.578122656336, 14080.155190688489, 14108.788368174486, 14167.645808854759, 12886.742265154644, 13172.798883238684, 13256.40346184424, 13415.731685366336, 13748.243846588433, 11112.44437778116, 11259.54961801527, 11486.42567871603, 11527.538898444052, 11666.358350290731, 3744.850205991757, 3757.079515518688, 3812.066043819282, 3816.446615240802, 3844.5386553613466, 56588.0, 57222.42777572213, 57308.0, 57459.243002195006, 57565.0, 10147.0, 10197.898021019842, 10231.139153992042, 10623.681289561326, 10624.043836054792, 18542.629147416978, 18866.434006979813, 19085.904570477338, 19115.330963416214, 19132.61734765297, 7973.162817904153, 7989.201079892081, 8020.398470114765, 8112.878306825402, 8273.958630206931, 4584.4957054723955, 4645.0, 4659.0, 4705.341252224691, 4709.905801883943, 3357.6138744044747, 3412.283420481677, 3412.812295323781, 3415.163284995192, 3418.4701371287492, 594.5867622002753, 604.9879002419927, 608.5983251054283, 614.3334482086985, 623.0187454758773, 662.2978944113678, 701.9824504387329, 715.2882881532908, 752.5747952406873, 779.7894568466482, 9089.772755681028, 9196.356255062215, 9245.44527328349, 9399.154076133182, 9496.287778416647, 646.5021933111572, 801.102764903312, 806.3226889412921, 808.2564041082219, 821.4330218068536, 4439.78932842234, 4513.864584062483, 4545.36364908913, 4642.558956899089, 4696.7651617419, 51272.0, 52307.0, 52335.73832130815, 54128.72935635297, 54788.0, 45373.773131134134, 45754.54245457503, 45797.77101114473, 46297.537024629324, 46934.765326173154, 45537.77231113889, 45551.31673024907, 45639.54360456419, 46043.76978115088, 46940.5305946943, 9172.35793494449, 9421.85867212006, 9433.811323773349, 9492.145706886413, 9523.476208808583, 32413.675863241067, 32664.34671306608, 33231.501527477594, 33363.666363337026, 33544.49683254802, 41128.0, 43557.346639801064, 43893.78053109714, 44857.0, 45186.54813451955, 11830.822537662114, 11899.82150267764, 11967.162298639012, 12129.272243665408, 12476.5009399623, 12793.744125117631, 12822.47076614423, 13088.607341779381, 13092.934535327262, 13548.390322435711, 10384.844227336747, 10858.728531786768, 12050.51797928073, 12647.557335493213, 13034.0, 12069.758604827679, 12563.87436125627, 12720.872791272339, 12788.168769030042, 12945.029122815638, 11667.824982625098, 11759.294442333487, 11902.166848320881, 12177.452014659184, 12356.567520136752, 10370.896291037296, 10509.78980420372, 10630.787384252426, 10654.786904262026, 11011.37399437269, 9984.400935943866, 10743.140548755924, 11070.28043177191, 11165.553377864795, 11211.383373914186], "value": 6613.659056840856, "unit": "score"}], "name": "dromaeo_css", "value": 6990.0184432946235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 110.0, 110.0, 113.0, 102.0, 112.0, 110.0, 113.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 160.0, 182.0, 128.0, 153.0, 151.0, 129.0, 194.0, 136.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 159.0, 160.0, 159.0, 161.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 101.0, 107.0, 73.0, 75.0, 72.0, 123.0, 110.0, 74.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 158.0, 93.0, 93.0, 92.0, 153.0, 92.0, 92.0, 150.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 61.0, 74.0, 56.0, 56.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 76.0, 78.0, 76.0, 78.0, 86.0, 77.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 122.0, 121.0, 125.0, 120.0, 123.0, 131.0, 157.0, 135.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 169.0, 162.0, 167.0, 170.0, 166.0, 162.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 66.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1535.4000000000003, "alertThreshold": 2.0}]} 00:47:51 INFO - Return code: 0 00:47:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:47:51 ERROR - # TBPL SUCCESS # 00:47:51 INFO - Running post-action listener: _resource_record_post_action 00:47:51 INFO - Running post-run listener: _resource_record_post_run 00:47:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 535969792; Read time: 0; Write time: 675672 00:47:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244547584; Read time: 0; Write time: 342424 00:47:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291422208; Read time: 0; Write time: 333248 00:47:52 INFO - Running post-run listener: _upload_blobber_files 00:47:52 INFO - Blob upload gear active. 00:47:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:47:52 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 00:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 00:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:53 INFO - (blobuploader) - INFO - Done attempting. 00:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:54 INFO - (blobuploader) - INFO - Done attempting. 00:47:54 INFO - (blobuploader) - INFO - Iteration through files over. 00:47:54 INFO - Return code: 0 00:47:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:47:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:47:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8affb103c3b6e6f7c3524aa5df000c37173ef8b449bea9a09875faa4e96d15eb939f8db7e2799a8980e7e381c98c443ded22d696539de91ab8e717cbcd87e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/781b6b52a51fe0bc0b403375b35e55c5eae335ba0c88e3f4d9b7798d878273887322b363fed89e2aec36cc447601bb056bd1e53869a6cbe0c3f974ca8a6073d9"} 00:47:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:47:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:47:54 INFO - Contents: 00:47:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8affb103c3b6e6f7c3524aa5df000c37173ef8b449bea9a09875faa4e96d15eb939f8db7e2799a8980e7e381c98c443ded22d696539de91ab8e717cbcd87e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/781b6b52a51fe0bc0b403375b35e55c5eae335ba0c88e3f4d9b7798d878273887322b363fed89e2aec36cc447601bb056bd1e53869a6cbe0c3f974ca8a6073d9"} 00:47:54 INFO - Running post-run listener: copy_logs_to_upload_dir 00:47:54 INFO - Copying logs to upload dir... 00:47:54 INFO - mkdir: /builds/slave/test/build/upload/logs 00:47:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.302662 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 00:47:54.108519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 00:47:54.112581) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8affb103c3b6e6f7c3524aa5df000c37173ef8b449bea9a09875faa4e96d15eb939f8db7e2799a8980e7e381c98c443ded22d696539de91ab8e717cbcd87e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/781b6b52a51fe0bc0b403375b35e55c5eae335ba0c88e3f4d9b7798d878273887322b363fed89e2aec36cc447601bb056bd1e53869a6cbe0c3f974ca8a6073d9"} build_url:https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/QnqtcIenRHupV8Gmhd0DGg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8affb103c3b6e6f7c3524aa5df000c37173ef8b449bea9a09875faa4e96d15eb939f8db7e2799a8980e7e381c98c443ded22d696539de91ab8e717cbcd87e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/781b6b52a51fe0bc0b403375b35e55c5eae335ba0c88e3f4d9b7798d878273887322b363fed89e2aec36cc447601bb056bd1e53869a6cbe0c3f974ca8a6073d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 00:47:54.138591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:47:54.138935) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461300486.708382-1069571757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004348 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:47:54.221172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 00:47:54.221511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 00:47:54.221836) ========= ========= Total master_lag: 0.17 =========