builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1450350094.28 results: success (0) buildid: 20151217022032 builduid: a3b561e232e84b94a5d1851a68aae9ed revision: 1e4c936c142d5d13da442e8a82d4f30a40971153 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.281380) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.281822) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.282102) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.462871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.463186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.569025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.569322) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.663840) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.664394) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.664781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.665072) ========= 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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 03:01:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-12-17 03:01:35 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.792069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.792583) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017491 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.843223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 03:01:34.843759) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e4c936c142d5d13da442e8a82d4f30a40971153 --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 1e4c936c142d5d13da442e8a82d4f30a40971153 --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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 03:01:35,846 truncating revision to first 12 chars 2015-12-17 03:01:35,847 Setting DEBUG logging. 2015-12-17 03:01:35,847 attempt 1/10 2015-12-17 03:01:35,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e4c936c142d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 03:01:37,006 unpacking tar archive at: fx-team-1e4c936c142d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.424576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 03:01:36.282791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.283085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.298604) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.298878) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.299267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-17 03:01:36.299556) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:37 INFO - MultiFileLogger online at 20151217 03:01:37 in /builds/slave/test 03:01:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:01:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:37 INFO - {'append_to_log': False, 03:01:37 INFO - 'base_work_dir': '/builds/slave/test', 03:01:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:01:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:37 INFO - 'branch': 'Fx-Team-Non-PGO', 03:01:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:37 INFO - 'config_files': ('talos/linux_config.py',), 03:01:37 INFO - 'default_actions': ('clobber', 03:01:37 INFO - 'read-buildbot-config', 03:01:37 INFO - 'download-and-extract', 03:01:37 INFO - 'populate-webroot', 03:01:37 INFO - 'create-virtualenv', 03:01:37 INFO - 'install', 03:01:37 INFO - 'run-tests'), 03:01:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:37 INFO - 'download_minidump_stackwalk': True, 03:01:37 INFO - 'download_symbols': 'ondemand', 03:01:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:37 INFO - 'installer_path': 'installer.exe', 03:01:37 INFO - 'log_level': 'info', 03:01:37 INFO - 'log_name': 'talos', 03:01:37 INFO - 'log_to_console': True, 03:01:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:37 INFO - 'opt_config_files': (), 03:01:37 INFO - 'pip_index': False, 03:01:37 INFO - 'sps_profile': False, 03:01:37 INFO - 'sps_profile_interval': 0, 03:01:37 INFO - 'suite': 'dromaeojs-e10s', 03:01:37 INFO - 'system_bits': '64', 03:01:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:37 INFO - 'title': 'talos-linux64-ix-025', 03:01:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:37 INFO - 'use_talos_json': True, 03:01:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:37 INFO - 'work_dir': 'build'} 03:01:37 INFO - ##### 03:01:37 INFO - ##### Running clobber step. 03:01:37 INFO - ##### 03:01:37 INFO - Running pre-action listener: _resource_record_pre_action 03:01:37 INFO - Running main action method: clobber 03:01:37 INFO - rmtree: /builds/slave/test/build 03:01:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:37 INFO - Running post-action listener: _resource_record_post_action 03:01:37 INFO - ##### 03:01:37 INFO - ##### Running read-buildbot-config step. 03:01:37 INFO - ##### 03:01:37 INFO - Running pre-action listener: _resource_record_pre_action 03:01:37 INFO - Running main action method: read_buildbot_config 03:01:37 INFO - Using buildbot properties: 03:01:37 INFO - { 03:01:37 INFO - "project": "", 03:01:37 INFO - "product": "firefox", 03:01:37 INFO - "script_repo_revision": "production", 03:01:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:01:37 INFO - "repository": "", 03:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:01:37 INFO - "buildid": "20151217022032", 03:01:37 INFO - "pgo_build": "False", 03:01:37 INFO - "basedir": "/builds/slave/test", 03:01:37 INFO - "buildnumber": 593, 03:01:37 INFO - "slavename": "talos-linux64-ix-025", 03:01:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:01:37 INFO - "platform": "ubuntu64_hw", 03:01:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:01:37 INFO - "branch": "fx-team", 03:01:37 INFO - "repo_path": "integration/fx-team", 03:01:37 INFO - "revision": "1e4c936c142d5d13da442e8a82d4f30a40971153", 03:01:37 INFO - "stage_platform": "linux64", 03:01:37 INFO - "builduid": "a3b561e232e84b94a5d1851a68aae9ed", 03:01:37 INFO - "slavebuilddir": "test" 03:01:37 INFO - } 03:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:01:37 INFO - Running post-action listener: _resource_record_post_action 03:01:37 INFO - ##### 03:01:37 INFO - ##### Running download-and-extract step. 03:01:37 INFO - ##### 03:01:37 INFO - Running pre-action listener: _resource_record_pre_action 03:01:37 INFO - Running main action method: download_and_extract 03:01:37 INFO - mkdir: /builds/slave/test/build/tests 03:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:37 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json 03:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json 03:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:01:41 INFO - Downloaded 1302 bytes. 03:01:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:01:41 INFO - Using the following test package requirements: 03:01:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:01:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'jsshell-linux-x86_64.zip'], 03:01:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:01:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:01:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:01:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:01:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:01:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:01:41 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')]} 03:01:41 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:01:42 INFO - Downloaded 21869235 bytes. 03:01:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:01:43 INFO - Return code: 0 03:01:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:43 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:01:45 INFO - Downloaded 21869235 bytes. 03:01:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:01:46 INFO - Return code: 0 03:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:46 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:01:48 INFO - Downloaded 11132052 bytes. 03:01:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:01:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:01:48 INFO - Return code: 0 03:01: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')]} 03:01:48 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:01:50 INFO - Downloaded 57772358 bytes. 03:01:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:50 INFO - mkdir: /builds/slave/test/properties 03:01:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:50 INFO - Contents: 03:01:50 INFO - build_url:https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:50 INFO - Running post-action listener: _resource_record_post_action 03:01:50 INFO - Running post-action listener: set_extra_try_arguments 03:01:50 INFO - ##### 03:01:50 INFO - ##### Running populate-webroot step. 03:01:50 INFO - ##### 03:01:50 INFO - Running pre-action listener: _resource_record_pre_action 03:01:50 INFO - Running main action method: populate_webroot 03:01:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:50 INFO - '--tppagecycles', 03:01:50 INFO - '7'], 03:01:50 INFO - 'tests': ['tsvgm']}}, 03:01:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:01:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:01:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:01:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'tests': ['damp', 'tps']}, 03:01:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['damp', 'tps']}, 03:01:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:01:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:50 INFO - 'other': {'tests': ['a11yr', 03:01:50 INFO - 'ts_paint', 03:01:50 INFO - 'tpaint', 03:01:50 INFO - 'sessionrestore', 03:01:50 INFO - 'sessionrestore_no_auto_restore']}, 03:01:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['a11yr', 03:01:50 INFO - 'ts_paint', 03:01:50 INFO - 'tpaint', 03:01:50 INFO - 'sessionrestore', 03:01:50 INFO - 'sessionrestore_no_auto_restore']}, 03:01:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['a11yr', 03:01:50 INFO - 'ts_paint', 03:01:50 INFO - 'tpaint', 03:01:50 INFO - 'sessionrestore', 03:01:50 INFO - 'sessionrestore_no_auto_restore']}, 03:01:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['a11yr', 03:01:50 INFO - 'ts_paint', 03:01:50 INFO - 'tpaint', 03:01:50 INFO - 'sessionrestore', 03:01:50 INFO - 'sessionrestore_no_auto_restore']}, 03:01:50 INFO - 'other_l64': {'tests': ['a11yr', 03:01:50 INFO - 'ts_paint', 03:01:50 INFO - 'tpaint', 03:01:50 INFO - 'sessionrestore', 03:01:50 INFO - 'sessionrestore_no_auto_restore']}, 03:01:50 INFO - 'other_nol64': {'tests': ['a11yr', 03:01:50 INFO - 'ts_paint', 03:01:50 INFO - 'tpaint', 03:01:50 INFO - 'sessionrestore', 03:01:50 INFO - 'sessionrestore_no_auto_restore']}, 03:01:50 INFO - 'svgr': {'tests': ['tsvgx', 03:01:50 INFO - 'tsvgr_opacity', 03:01:50 INFO - 'tart', 03:01:50 INFO - 'tscrollx', 03:01:50 INFO - 'cart']}, 03:01:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['tsvgx', 03:01:50 INFO - 'tsvgr_opacity', 03:01:50 INFO - 'tart', 03:01:50 INFO - 'tscrollx', 03:01:50 INFO - 'cart']}, 03:01:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'tests': ['tp5o']}, 03:01:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'talos_options': ['--e10s'], 03:01:50 INFO - 'tests': ['tp5o']}, 03:01:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'talos_options': ['--xperf_path', 03:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:50 INFO - 'tests': ['tp5n']}, 03:01:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:50 INFO - 'talos_options': ['--e10s', 03:01:50 INFO - '--xperf_path', 03:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:50 INFO - 'tests': ['tp5n']}}, 03:01:50 INFO - 'talos.zip': {'path': '', 03:01:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:50 INFO - Running post-action listener: _resource_record_post_action 03:01:50 INFO - ##### 03:01:50 INFO - ##### Running create-virtualenv step. 03:01:50 INFO - ##### 03:01:50 INFO - Running pre-action listener: _resource_record_pre_action 03:01:50 INFO - Running main action method: create_virtualenv 03:01:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:50 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 03:01:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:50 INFO - Using real prefix '/usr' 03:01:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:53 INFO - Installing pip.................done. 03:01:53 INFO - Return code: 0 03:01:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:53 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')]} 03:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:53 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')]} 03:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:01:53 INFO - Using env: {'DISPLAY': ':0', 03:01:53 INFO - 'HOME': '/home/cltbld', 03:01:53 INFO - 'LANG': 'en_US.UTF-8', 03:01:53 INFO - 'LANGUAGE': 'en_US:en', 03:01:53 INFO - 'LOGNAME': 'cltbld', 03:01:53 INFO - 'MAIL': '/var/mail/cltbld', 03:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:53 INFO - 'MOZ_NO_REMOTE': '1', 03:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:53 INFO - 'NO_EM_RESTART': '1', 03:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:53 INFO - 'PWD': '/builds/slave/test', 03:01:53 INFO - 'SHELL': '/bin/bash', 03:01:53 INFO - 'SHLVL': '1', 03:01:53 INFO - 'TERM': 'linux', 03:01:53 INFO - 'TMOUT': '86400', 03:01:53 INFO - 'USER': 'cltbld', 03:01:53 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:53 INFO - '_': '/tools/buildbot/bin/python'} 03:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:53 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 03:01:53 INFO - Cleaning up... 03:01:53 INFO - Return code: 0 03:01:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:01:53 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')]} 03:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:53 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')]} 03:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:01:53 INFO - Using env: {'DISPLAY': ':0', 03:01:53 INFO - 'HOME': '/home/cltbld', 03:01:53 INFO - 'LANG': 'en_US.UTF-8', 03:01:53 INFO - 'LANGUAGE': 'en_US:en', 03:01:53 INFO - 'LOGNAME': 'cltbld', 03:01:53 INFO - 'MAIL': '/var/mail/cltbld', 03:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:53 INFO - 'MOZ_NO_REMOTE': '1', 03:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:53 INFO - 'NO_EM_RESTART': '1', 03:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:53 INFO - 'PWD': '/builds/slave/test', 03:01:53 INFO - 'SHELL': '/bin/bash', 03:01:53 INFO - 'SHLVL': '1', 03:01:53 INFO - 'TERM': 'linux', 03:01:53 INFO - 'TMOUT': '86400', 03:01:53 INFO - 'USER': 'cltbld', 03:01:53 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:53 INFO - '_': '/tools/buildbot/bin/python'} 03:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:53 INFO - Downloading/unpacking psutil>=0.7.1 03:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:55 INFO - Installing collected packages: psutil 03:01:55 INFO - Running setup.py install for psutil 03:01:55 INFO - building 'psutil._psutil_linux' extension 03:01:55 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 03:01:55 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 03:01:55 INFO - building 'psutil._psutil_posix' extension 03:01:55 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 03:01:55 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 03:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:55 INFO - Successfully installed psutil 03:01:55 INFO - Cleaning up... 03:01:55 INFO - Return code: 0 03:01:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:01:55 INFO - Using env: {'DISPLAY': ':0', 03:01:55 INFO - 'HOME': '/home/cltbld', 03:01:55 INFO - 'LANG': 'en_US.UTF-8', 03:01:55 INFO - 'LANGUAGE': 'en_US:en', 03:01:55 INFO - 'LOGNAME': 'cltbld', 03:01:55 INFO - 'MAIL': '/var/mail/cltbld', 03:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:55 INFO - 'MOZ_NO_REMOTE': '1', 03:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:55 INFO - 'NO_EM_RESTART': '1', 03:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:55 INFO - 'PWD': '/builds/slave/test', 03:01:55 INFO - 'SHELL': '/bin/bash', 03:01:55 INFO - 'SHLVL': '1', 03:01:55 INFO - 'TERM': 'linux', 03:01:55 INFO - 'TMOUT': '86400', 03:01:55 INFO - 'USER': 'cltbld', 03:01:55 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:55 INFO - '_': '/tools/buildbot/bin/python'} 03:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:01:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:01:57 INFO - Installing collected packages: mozsystemmonitor 03:01:57 INFO - Running setup.py install for mozsystemmonitor 03:01:57 INFO - Successfully installed mozsystemmonitor 03:01:57 INFO - Cleaning up... 03:01:57 INFO - Return code: 0 03:01:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:01:57 INFO - Using env: {'DISPLAY': ':0', 03:01:57 INFO - 'HOME': '/home/cltbld', 03:01:57 INFO - 'LANG': 'en_US.UTF-8', 03:01:57 INFO - 'LANGUAGE': 'en_US:en', 03:01:57 INFO - 'LOGNAME': 'cltbld', 03:01:57 INFO - 'MAIL': '/var/mail/cltbld', 03:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:57 INFO - 'MOZ_NO_REMOTE': '1', 03:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:57 INFO - 'NO_EM_RESTART': '1', 03:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:57 INFO - 'PWD': '/builds/slave/test', 03:01:57 INFO - 'SHELL': '/bin/bash', 03:01:57 INFO - 'SHLVL': '1', 03:01:57 INFO - 'TERM': 'linux', 03:01:57 INFO - 'TMOUT': '86400', 03:01:57 INFO - 'USER': 'cltbld', 03:01:57 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:57 INFO - '_': '/tools/buildbot/bin/python'} 03:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:00 INFO - Downloading docopt-0.6.1.tar.gz 03:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:00 INFO - Running setup.py install for blobuploader 03:02:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:00 INFO - Running setup.py install for requests 03:02:00 INFO - Running setup.py install for docopt 03:02:01 INFO - Successfully installed blobuploader requests docopt 03:02:01 INFO - Cleaning up... 03:02:01 INFO - Return code: 0 03:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 03:02:01 INFO - Using env: {'DISPLAY': ':0', 03:02:01 INFO - 'HOME': '/home/cltbld', 03:02:01 INFO - 'LANG': 'en_US.UTF-8', 03:02:01 INFO - 'LANGUAGE': 'en_US:en', 03:02:01 INFO - 'LOGNAME': 'cltbld', 03:02:01 INFO - 'MAIL': '/var/mail/cltbld', 03:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:01 INFO - 'MOZ_NO_REMOTE': '1', 03:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:01 INFO - 'NO_EM_RESTART': '1', 03:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:01 INFO - 'PWD': '/builds/slave/test', 03:02:01 INFO - 'SHELL': '/bin/bash', 03:02:01 INFO - 'SHLVL': '1', 03:02:01 INFO - 'TERM': 'linux', 03:02:01 INFO - 'TMOUT': '86400', 03:02:01 INFO - 'USER': 'cltbld', 03:02:01 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:01 INFO - '_': '/tools/buildbot/bin/python'} 03:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:01 INFO - Running setup.py (path:/tmp/pip-3rRD5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:01 INFO - Running setup.py (path:/tmp/pip-zgCWgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:01 INFO - Running setup.py (path:/tmp/pip-vcPOV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:01 INFO - Running setup.py (path:/tmp/pip-NFTKQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:01 INFO - Running setup.py (path:/tmp/pip-FQIjLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:01 INFO - Running setup.py (path:/tmp/pip-vLd7v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:01 INFO - Running setup.py (path:/tmp/pip-tdoc03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:01 INFO - Running setup.py (path:/tmp/pip-FtYOqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:01 INFO - Running setup.py (path:/tmp/pip-tyL4O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:01 INFO - Running setup.py (path:/tmp/pip-u93FcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:02 INFO - Running setup.py (path:/tmp/pip-EWfoeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:02 INFO - Running setup.py (path:/tmp/pip-KFh4I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:02 INFO - Running setup.py (path:/tmp/pip-B0VYdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:02 INFO - Running setup.py (path:/tmp/pip-dT_AQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:02 INFO - Running setup.py (path:/tmp/pip-vxipP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:02 INFO - Running setup.py (path:/tmp/pip-qYiva8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:02 INFO - Running setup.py (path:/tmp/pip-Y85Sth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:02 INFO - Running setup.py install for manifestparser 03:02:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:02 INFO - Running setup.py install for mozcrash 03:02:02 INFO - Running setup.py install for mozdebug 03:02:02 INFO - Running setup.py install for mozdevice 03:02:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:02:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:02 INFO - Running setup.py install for mozfile 03:02:03 INFO - Running setup.py install for mozhttpd 03:02:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for mozinfo 03:02:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for mozInstall 03:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for mozleak 03:02:03 INFO - Running setup.py install for mozlog 03:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for moznetwork 03:02:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for mozprocess 03:02:03 INFO - Running setup.py install for mozprofile 03:02:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for mozrunner 03:02:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:03 INFO - Running setup.py install for mozscreenshot 03:02:04 INFO - Running setup.py install for moztest 03:02:04 INFO - Running setup.py install for mozversion 03:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:04 INFO - Cleaning up... 03:02:04 INFO - Return code: 0 03:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:04 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')]} 03:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:04 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')]} 03:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:02:04 INFO - Using env: {'DISPLAY': ':0', 03:02:04 INFO - 'HOME': '/home/cltbld', 03:02:04 INFO - 'LANG': 'en_US.UTF-8', 03:02:04 INFO - 'LANGUAGE': 'en_US:en', 03:02:04 INFO - 'LOGNAME': 'cltbld', 03:02:04 INFO - 'MAIL': '/var/mail/cltbld', 03:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:04 INFO - 'MOZ_NO_REMOTE': '1', 03:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:04 INFO - 'NO_EM_RESTART': '1', 03:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:04 INFO - 'PWD': '/builds/slave/test', 03:02:04 INFO - 'SHELL': '/bin/bash', 03:02:04 INFO - 'SHLVL': '1', 03:02:04 INFO - 'TERM': 'linux', 03:02:04 INFO - 'TMOUT': '86400', 03:02:04 INFO - 'USER': 'cltbld', 03:02:04 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:04 INFO - '_': '/tools/buildbot/bin/python'} 03:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:04 INFO - Running setup.py (path:/tmp/pip-LuoFy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:04 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)) 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:04 INFO - Running setup.py (path:/tmp/pip-T6LYGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:04 INFO - Running setup.py (path:/tmp/pip-IwcqLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:04 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)) 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:04 INFO - Running setup.py (path:/tmp/pip-AyNvS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:04 INFO - Running setup.py (path:/tmp/pip-d7rMsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:04 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)) 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:04 INFO - Running setup.py (path:/tmp/pip-cOQKBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:04 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)) 03:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:04 INFO - Running setup.py (path:/tmp/pip-yVR4n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:05 INFO - Running setup.py (path:/tmp/pip-iKf29S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:05 INFO - Running setup.py (path:/tmp/pip-LDqFKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:05 INFO - Running setup.py (path:/tmp/pip-nkoBK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:05 INFO - Running setup.py (path:/tmp/pip-rIVoKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:05 INFO - Running setup.py (path:/tmp/pip-3aZad4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:05 INFO - Running setup.py (path:/tmp/pip-T4boCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:05 INFO - Running setup.py (path:/tmp/pip-FUmwQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:05 INFO - Running setup.py (path:/tmp/pip-lK4l3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:05 INFO - Running setup.py (path:/tmp/pip-VSgno2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:05 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)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:05 INFO - Running setup.py (path:/tmp/pip-OQT9Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:05 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)) 03:02:05 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:05 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:05 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)) 03:02:05 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:05 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:05 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 03:02:05 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 03:02:05 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 03:02:05 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 03:02:05 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 03:02:05 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 03:02:07 INFO - Downloading blessings-1.5.1.tar.gz 03:02:07 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:07 INFO - Installing collected packages: blessings 03:02:07 INFO - Running setup.py install for blessings 03:02:07 INFO - Successfully installed blessings 03:02:07 INFO - Cleaning up... 03:02:07 INFO - Return code: 0 03:02:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:07 INFO - Reading from file tmpfile_stdout 03:02:07 INFO - Current package versions: 03:02:07 INFO - argparse == 1.2.1 03:02:07 INFO - blessings == 1.5.1 03:02:07 INFO - blobuploader == 1.2.4 03:02:07 INFO - docopt == 0.6.1 03:02:07 INFO - manifestparser == 1.1 03:02:07 INFO - mozInstall == 1.12 03:02:07 INFO - mozcrash == 0.16 03:02:07 INFO - mozdebug == 0.1 03:02:07 INFO - mozdevice == 0.47 03:02:07 INFO - mozfile == 1.2 03:02:07 INFO - mozhttpd == 0.7 03:02:07 INFO - mozinfo == 0.9 03:02:07 INFO - mozleak == 0.1 03:02:07 INFO - mozlog == 3.1 03:02:07 INFO - moznetwork == 0.27 03:02:07 INFO - mozprocess == 0.22 03:02:07 INFO - mozprofile == 0.27 03:02:07 INFO - mozrunner == 6.11 03:02:07 INFO - mozscreenshot == 0.1 03:02:07 INFO - mozsystemmonitor == 0.0 03:02:07 INFO - moztest == 0.7 03:02:07 INFO - mozversion == 1.4 03:02:07 INFO - psutil == 3.1.1 03:02:07 INFO - requests == 1.2.3 03:02:07 INFO - wsgiref == 0.1.2 03:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:07 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')]} 03:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:07 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')]} 03:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:02:07 INFO - Using env: {'DISPLAY': ':0', 03:02:07 INFO - 'HOME': '/home/cltbld', 03:02:07 INFO - 'LANG': 'en_US.UTF-8', 03:02:07 INFO - 'LANGUAGE': 'en_US:en', 03:02:07 INFO - 'LOGNAME': 'cltbld', 03:02:07 INFO - 'MAIL': '/var/mail/cltbld', 03:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:07 INFO - 'MOZ_NO_REMOTE': '1', 03:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:07 INFO - 'NO_EM_RESTART': '1', 03:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:07 INFO - 'PWD': '/builds/slave/test', 03:02:07 INFO - 'SHELL': '/bin/bash', 03:02:07 INFO - 'SHLVL': '1', 03:02:07 INFO - 'TERM': 'linux', 03:02:07 INFO - 'TMOUT': '86400', 03:02:07 INFO - 'USER': 'cltbld', 03:02:07 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:07 INFO - '_': '/tools/buildbot/bin/python'} 03:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:08 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 1)) 03:02:08 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 2)) 03:02:08 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 3)) 03:02:08 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 4)) 03:02:08 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 5)) 03:02:08 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 6)) 03:02:08 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 7)) 03:02:08 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 8)) 03:02:08 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:02:08 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 3)) 03:02:08 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:02:08 INFO - Cleaning up... 03:02:08 INFO - Return code: 0 03:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02:08 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')]} 03:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:08 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')]} 03:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:02:08 INFO - Using env: {'DISPLAY': ':0', 03:02:08 INFO - 'HOME': '/home/cltbld', 03:02:08 INFO - 'LANG': 'en_US.UTF-8', 03:02:08 INFO - 'LANGUAGE': 'en_US:en', 03:02:08 INFO - 'LOGNAME': 'cltbld', 03:02:08 INFO - 'MAIL': '/var/mail/cltbld', 03:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:08 INFO - 'MOZ_NO_REMOTE': '1', 03:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:08 INFO - 'NO_EM_RESTART': '1', 03:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:08 INFO - 'PWD': '/builds/slave/test', 03:02:08 INFO - 'SHELL': '/bin/bash', 03:02:08 INFO - 'SHLVL': '1', 03:02:08 INFO - 'TERM': 'linux', 03:02:08 INFO - 'TMOUT': '86400', 03:02:08 INFO - 'USER': 'cltbld', 03:02:08 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:08 INFO - '_': '/tools/buildbot/bin/python'} 03:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:08 INFO - Downloading/unpacking jsonschema 03:02:08 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 03:02:08 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 03:02:08 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 03:02:08 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 03:02:08 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 03:02:08 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 03:02:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:02:10 INFO - Downloading/unpacking functools32 (from jsonschema) 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:10 INFO - warning: no files found matching '*.txt' 03:02:10 INFO - no previously-included directories found matching 'build' 03:02:10 INFO - no previously-included directories found matching 'dist' 03:02:10 INFO - no previously-included directories found matching '.git*' 03:02:10 INFO - Installing collected packages: jsonschema, functools32 03:02:10 INFO - Running setup.py install for functools32 03:02:10 INFO - warning: no files found matching '*.txt' 03:02:10 INFO - no previously-included directories found matching 'build' 03:02:10 INFO - no previously-included directories found matching 'dist' 03:02:10 INFO - no previously-included directories found matching '.git*' 03:02:10 INFO - Successfully installed jsonschema functools32 03:02:10 INFO - Cleaning up... 03:02:10 INFO - Return code: 0 03:02:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39949e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, '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': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', '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 03:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 03:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:02:10 INFO - Using env: {'DISPLAY': ':0', 03:02:10 INFO - 'HOME': '/home/cltbld', 03:02:10 INFO - 'LANG': 'en_US.UTF-8', 03:02:10 INFO - 'LANGUAGE': 'en_US:en', 03:02:10 INFO - 'LOGNAME': 'cltbld', 03:02:10 INFO - 'MAIL': '/var/mail/cltbld', 03:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:10 INFO - 'MOZ_NO_REMOTE': '1', 03:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:10 INFO - 'NO_EM_RESTART': '1', 03:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:10 INFO - 'PWD': '/builds/slave/test', 03:02:10 INFO - 'SHELL': '/bin/bash', 03:02:10 INFO - 'SHLVL': '1', 03:02:10 INFO - 'TERM': 'linux', 03:02:10 INFO - 'TMOUT': '86400', 03:02:10 INFO - 'USER': 'cltbld', 03:02:10 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:10 INFO - '_': '/tools/buildbot/bin/python'} 03:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:10 INFO - Downloading/unpacking flake8 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 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 03:02:10 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 03:02:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:02:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:02:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:02:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:02:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:02:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:02:12 INFO - no previously-included directories found matching 'docs/_build' 03:02:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:02:13 INFO - Running setup.py install for pep8 03:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:02:13 INFO - no previously-included directories found matching 'docs/_build' 03:02:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:02:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:02:13 INFO - Cleaning up... 03:02:13 INFO - Return code: 0 03:02:13 INFO - Running post-action listener: _resource_record_post_action 03:02:13 INFO - Running post-action listener: _start_resource_monitoring 03:02:13 INFO - Starting resource monitoring. 03:02:13 INFO - ##### 03:02:13 INFO - ##### Running install step. 03:02:13 INFO - ##### 03:02:13 INFO - Running pre-action listener: _resource_record_pre_action 03:02:13 INFO - Running main action method: install 03:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:13 INFO - Reading from file tmpfile_stdout 03:02:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:13 INFO - Reading from file tmpfile_stdout 03:02:13 INFO - Output received: 03:02:13 INFO - Usage: mozinstall [options] installer 03:02:13 INFO - Options: 03:02:13 INFO - -h, --help show this help message and exit 03:02:13 INFO - -d DEST, --destination=DEST 03:02:13 INFO - Directory to install application into. [default: 03:02:13 INFO - "/builds/slave/test"] 03:02:13 INFO - --app=APP Application being installed. [default: firefox] 03:02:13 INFO - mkdir: /builds/slave/test/build/application 03:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:02:28 INFO - Reading from file tmpfile_stdout 03:02:28 INFO - Output received: 03:02:28 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:28 INFO - Running post-action listener: _resource_record_post_action 03:02:28 INFO - ##### 03:02:28 INFO - ##### Running run-tests step. 03:02:28 INFO - ##### 03:02:28 INFO - Running pre-action listener: _resource_record_pre_action 03:02:28 INFO - Running main action method: run_tests 03:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:28 INFO - Python 2.7.3 03:02:28 INFO - Return code: 0 03:02:28 INFO - grabbing minidump binary from tooltool 03:02:28 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')]} 03:02:28 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 0x1b480b0>, '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 0x1b48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:28 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 03:02:28 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 03:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:28 INFO - Return code: 0 03:02:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:02:29 INFO - Return code: 0 03:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 03:02:29 INFO - Using env: {'DISPLAY': ':0', 03:02:29 INFO - 'HOME': '/home/cltbld', 03:02:29 INFO - 'LANG': 'en_US.UTF-8', 03:02:29 INFO - 'LANGUAGE': 'en_US:en', 03:02:29 INFO - 'LOGNAME': 'cltbld', 03:02:29 INFO - 'MAIL': '/var/mail/cltbld', 03:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:29 INFO - 'MOZ_NO_REMOTE': '1', 03:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:29 INFO - 'NO_EM_RESTART': '1', 03:02:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:29 INFO - 'PWD': '/builds/slave/test', 03:02:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:29 INFO - 'SHELL': '/bin/bash', 03:02:29 INFO - 'SHLVL': '1', 03:02:29 INFO - 'TERM': 'linux', 03:02:29 INFO - 'TMOUT': '86400', 03:02:29 INFO - 'USER': 'cltbld', 03:02:29 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450346830.11201-2077122040', 03:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:29 INFO - '_': '/tools/buildbot/bin/python'} 03:02:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 03:02:29 INFO - mozversion INFO | application_buildid: 20151217022032 03:02:29 INFO - mozversion INFO | application_changeset: 1e4c936c142d5d13da442e8a82d4f30a40971153 03:02:29 INFO - mozversion INFO | application_display_name: Nightly 03:02:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:29 INFO - mozversion INFO | application_name: Firefox 03:02:29 INFO - mozversion INFO | application_remotingname: firefox 03:02:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:02:29 INFO - mozversion INFO | application_vendor: Mozilla 03:02:29 INFO - mozversion INFO | application_version: 46.0a1 03:02:29 INFO - mozversion INFO | platform_buildid: 20151217022032 03:02:29 INFO - mozversion INFO | platform_changeset: 1e4c936c142d5d13da442e8a82d4f30a40971153 03:02:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:02:29 INFO - mozversion INFO | platform_version: 46.0a1 03:02:29 INFO - 2015-12-17 03:02:29,380 DEBUG : using testdate: 1450350149 03:02:29 INFO - 2015-12-17 03:02:29,381 DEBUG : actual date: 1450350149 03:02:29 INFO - 2015-12-17 03:02:29,489 INFO : starting webserver on 'localhost:46595' 03:02:29 INFO - 2015-12-17 03:02:29,490 INFO : Starting test suite talos-linux64-ix-025.e 03:02:29 INFO - 2015-12-17 03:02:29,491 INFO : Starting test dromaeo_css 03:02:29 INFO - 2015-12-17 03:02:29,491 DEBUG : operating with platform_type : linux_ 03:02:29 INFO - 2015-12-17 03:02:29,492 INFO : Initialising browser for dromaeo_css test... 03:02:29 INFO - 2015-12-17 03:02:29,503 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCG2f1a/profile http://localhost:46595/getInfo.html 03:02:34 INFO - 2015-12-17 03:02:34,448 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:02:34 INFO - 2015-12-17 03:02:34,448 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:02:34 INFO - 2015-12-17 03:02:34,448 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:02:34 INFO - 2015-12-17 03:02:34,448 DEBUG : BROWSER_OUTPUT: __metrics 03:02:34 INFO - 2015-12-17 03:02:34,545 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:02:35 INFO - 2015-12-17 03:02:35,459 INFO : Browser initialized. 03:02:35 INFO - 2015-12-17 03:02:35,459 INFO : Running cycle 1/1 for dromaeo_css test... 03:02:35 INFO - 2015-12-17 03:02:35,460 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCG2f1a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:02:47 INFO - 2015-12-17 03:02:47,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 143110144 03:02:47 INFO - 2015-12-17 03:02:47,556 DEBUG : BROWSER_OUTPUT: 03:03:37 INFO - 2015-12-17 03:03:37,194 DEBUG : BROWSER_OUTPUT: 1450350217193 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] 03:05:49 INFO - 2015-12-17 03:05:49,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46595/tests/dromaeo/cssquery-ext.html) 03:05:50 INFO - 2015-12-17 03:05:50,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 146370560 03:05:50 INFO - 2015-12-17 03:05:50,020 DEBUG : BROWSER_OUTPUT: 03:08:52 INFO - 2015-12-17 03:08:52,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/dromaeo/cssquery-ext.html (next: http://localhost:46595/tests/dromaeo/cssquery-jquery.html) 03:08:52 INFO - 2015-12-17 03:08:52,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 144510976 03:08:52 INFO - 2015-12-17 03:08:52,695 DEBUG : BROWSER_OUTPUT: 03:11:54 INFO - 2015-12-17 03:11:54,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46595/tests/dromaeo/cssquery-mootools.html) 03:11:55 INFO - 2015-12-17 03:11:55,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 146841600 03:11:55 INFO - 2015-12-17 03:11:55,055 DEBUG : BROWSER_OUTPUT: 03:14:56 INFO - 2015-12-17 03:14:56,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46595/tests/dromaeo/cssquery-prototype.html) 03:14:57 INFO - 2015-12-17 03:14:57,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 143740928 03:14:57 INFO - 2015-12-17 03:14:57,451 DEBUG : BROWSER_OUTPUT: 03:18:00 INFO - 2015-12-17 03:18:00,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46595/tests/dromaeo/cssquery-yui.html) 03:18:00 INFO - 2015-12-17 03:18:00,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 144592896 03:18:00 INFO - 2015-12-17 03:18:00,741 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/dromaeo/cssquery-yui.html (next: http://localhost:46595/tests/dromaeo/cssquery-dojo.html) 03:21:03 INFO - 2015-12-17 03:21:03,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 147296256 03:21:03 INFO - 2015-12-17 03:21:03,302 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,304 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:21:03 INFO - 2015-12-17 03:21:03,304 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:21:03 INFO - 2015-12-17 03:21:03,304 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:21:03 INFO - 2015-12-17 03:21:03,304 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:21:03 INFO - 2015-12-17 03:21:03,308 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2668.6130511075894;2697.946041079177;2725.291424229701;2729.263098963279;2746.862656867156;4629.884252893679;4734.502877197892;4766.928496072562;4789.688670236432;4857.805687772489;4718.834840780573;4780.617550595953;4788.64085193611;4828.661993660445;4831.565159135677;4343.239933011726;4413.646908247349;4445.466544014723;4452.7996240169105;4495.527969563198;4391.9121617567625;4459.977700111495;4472.642188624918;4509.594136527712;4549.09018196362;4275.572442755731;4344.022594916119;4372.803223854934;4410.316400957857;4464.553544645542;4359.237133501656;4361.258586040349;4363.498197707241;4370.2570563004365;4396.9886926006875;4394.4946331172005;4395.406620106277;4404.775588327906;4424.137293227822;4456.93314600278;4498.122866041123;4592.931106033412;4665.766711664403;4802.807887684488;4842.782074806642;5119.974400127976;5189.117849965515;5193.688378697252;5195.662281951699;5243.370795504564;4911.140550403701;5216.60875434344;5229.660072095302;5232.7122008289525;5240.082985477527;4692.085043416535;4721.811127554894;4758.500357462486;4779.737114458738;4834.105690447279;5218.399884013311;5361.597880159004;5367.624266301322;5384.488473595002;5411.161270003156;4828.03439312139;4942.283368911488;5106.617003724661;5146.845594632167;5153.484651534892;5048.924266136011;5136.5890728741615;5153.3815942087185;5175.585953123741;5209.166533354645;5059.038782631288;5068.822591209364;5070.923936140961;5096.592272618256;5102.515261050195;4825.348577942003;4953.1332016896895;4981.526754958273;5044.596432285409;5054.82308119214;4276.444062271885;4289.056407590325;4296.677749168824;4300.78496075195;4342.08816148606;3767;3780.5085338905765;3782.3759079751535;3806.923861522754;3817.9045523862123;4178.623923846869;4331.545187755303;4369.628581570539;4479.193745125908;4485.0805584855025;5193.870153246124;5226.451222621646;5229.555487783581;5260.473952604709;5292.391374991848;4471.5528447155675;4475.70907890986;4476.35092911526;4479.932801007987;4519.683622146484;4353.869383918487;4452.9554704453185;4458.197524445631;4513.5486451355255;4548.727076375362;4824.445188803333;4917.557419832232;4942.728149951859;4957.950420495749;5039.420466646236;4883.755812209304;5242;5267.236250743697;5269;5276.841694749163;4715.669903106749;4875.68308059975;4937.185364414831;4942.4316203637045;5019.698818070928;5044.495550444926;5077.238414237894;5086.931744333731;5087.516685914832;5142.717150556755;4915.311856340187;5045.217991211368;5154.175331946871;5157.406898206755;5157.510036546522;4955.801767929387;5006.949930500648;5027.296178534935;5030.9245361320345;5092.643514954066;4951.752412379438;4952.950470495249;4953.133201689618;4958.479359667327;5006.274090256965;4622.05247924168;4738.644601654959;4828.155072862165;4867.099586576494;4895.657303988686;5019.372578427697;5035.697858128524;5046.823361182341;5051.545360917388;5056;4916.11509928202;4927.901441971212;4951.331570238116;4954.5788607968725;4965.602751779921 03:21:03 INFO - 2015-12-17 03:21:03,309 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.507534193648;571.2459553389527;579.7565022690472;583.2942140010588;591.3554225893777;33670.32659346812;34255.31489370214;34270.31459370811;34306;34439.655603443956;37977.620223797756;38533;38649.61350386495;38724.41913371302;38762.80618596903;7726.381889448859;7859.331956783681;7880.093789214227;7882.60586970652;7892.960535197316;7727.806804829868;7727.9613601931915;7790.104138024115;7802.024746906637;7817.1791961843755;7810.453268271223;7947.08608510023;7951.880721789178;7956.04527456706;7965.203479652017;7764.611769411506;7871.448998570102;7922.207779222089;7928.207179282083;7931.048274207074;7769.456138070337;7916.485428447132;7916.920830791676;7929.286364227247;7930.246626570467;35482.64517354819;35916.64083359159;35972.280554388766;35991.64008359909;36022;2871.7415432611165;3033;3038.1645047612083;3102.90691279262;3434.8797792077407;27055.729442705713;27546;27709.86145069282;27985.30036749077;28070.719292807014;3426.297608990151;3504.316658251642;3530.5939816921127;3562.768420052714;3562.982185089084;213274;214276;214348;215535;216206.99999999843;54116.188257176174;54873;55005.44994550003;55184.44815551793;55247.72376138174;49132;49314;65074;66426.33573664201;66573;14351.712965740626;14611;14635.121892686473;14656.780148297785;14689.853101469062;10781.137508999262;10908.672739817817;10925.180611454172;10927.071198948179;10931.398773067558;19087.141078651493;19183.52041198953;19392.12735426909;19398.12708428124;19459.51351216231;7639.923600764032;7793.2596403341595;7837.275799324254;7883.2116788321855;7893.644785984645;816.4366587055032;939.9342046056711;966.8984756600596;986.9259805514615;1079.082779637302;25952.09167679122;26057;26161.215163545123;28035.299117522227;30107;936.6113063078882;969.6121551379505;971.5676523946776;975.2441857560306;1037.6057098302597;12673.09945894728;13027.739445211042;13086.214827110214;13120.803187952188;13322.134061285986;305639;311450;312859;312946;314038;44222.33666495005;44638.33042504365;44690.32964505535;44725.32912006322;44845.327320090226;1240.1938739819009;1243.7325974915436;1246.2584762066556;1250.112420181663;1251.8372611560621;24948.625770613093;25013;25102.62346064847;25413;25486.87256563705;38684.03289917774;39292;39398.212035759694;39410.605893940694;39512.802435988786;246868;249360;249399;249507;249653;28738.568921465776;38206.42690359702;38630.42054369243;38980.6101938977;39115.2176956465;35073.29853402867;37858.43212351762;37990.81004594959;38371.42442863415;38624.42063369108;31786.682133179296;32088;32562.348753025282;32841.50737738888;33091.66908330982;29665.851670741507;29688.25779355447;29785.85107074451;29870;36694.8165259172;32335.191620209684;32829.671703282664;32834.835825820715;33136;33137.171570710925;29047;29351.412971740872;29621.851890740407;29628.259293517833;29921.251968700086;23369.532609348058;23607.881960590086;24542.32553499334;24673;27123.86438067797 03:21:03 INFO - 2015-12-17 03:21:03,312 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.5941849489861;341.44856057467183;343.0685688356113;344.02812055941956;344.177415975818;14836.851631483682;14922;15764.369425222978;15817;16324.83675163248;14082.225477598728;14091.436342546285;14128.011039227258;14466.638334041654;15046.699066018673;4445.510993790688;4763.809447622091;4970.279309500138;4985.875353116183;5000.224965130393;4187.979060104695;4885.0718363511;4908.0429316283335;4911.729854857981;5611.466910643482;5536.446355364452;5540.307461567304;5561.694106824123;5565.109582466806;5582.330120385559;4668.136394766962;4669.2529195328925;4669.7431641259545;4679.578837904605;4922.089413458504;4924.753762311906;4958.429780575208;5045.016221836743;5056.064628043787;5059.241113832918;12701.047421443336;18419.263229470806;18764.34324798639;18871.62256754871;18969.33607323737;1818.436284751718;1875.6717574424558;1889.5653999580175;1934.4680212941553;1961.4900125967208;8809;9034.954825225897;9123.224525915306;11102;12688.80966785499;1732.9220185091701;1765.082157278221;1785.3572713823014;1922.6539222939866;1985.3547597031022;53270.467295327326;56186;56967.145492818054;57018.85962280773;57362.426375736126;10033.444816053523;10067.647632332833;10093.343932644355;10110.949445252727;10188.490575471196;11870.525178992917;12073.517059317528;12080.335581542924;12120.81818772719;12705.872941270654;7153.3561979421065;7369.77890663281;7390.03929489163;7431.2197219292275;7489.28851759082;7204.855902881913;7228.096487939008;7302.123745150509;7359.062901347753;7363.374113200438;3938.1926705025976;4093.099518106012;4211.494620645481;4283.871483855427;4336.6530677545725;1743.9040852752967;1773.645270945816;1779;1803.8376546110912;1811.791643960935;826.0129145670866;867.5878957495139;872.358816270041;874.152072489684;948.5968463403026;15065.698686026437;15261.47385261465;15522.456714015181;15785.763213551805;15889.761653575206;863.5121156546531;892.5938697892443;909.3634455880909;937.9484128373005;942.6606421688186;8895.510746908982;8944.73165805014;8955.955220223988;9001.954990225138;9140.771480712903;455201.2399380018;455679;457625;503447;518471;59677;64543.35456645468;69530.26174345682;69985;70993.6450317745;1054.8048611006989;1063.941483218415;1065.7974984752873;1107.4905543450104;1110.7833972375308;13843.238621875893;13872.445102196203;14037;14041.929790350983;14195.219262940638;28092.71907280983;30622.693773061983;31020.53469198009;32527.18682032968;32945.505817412275;34176.65823341834;35763.64236357603;35946.28107437889;36193.81903090468;36804.26391472102;8551.33249016436;8624.18070283322;9135.583984482415;9302.534873256445;9311.348205625813;10410.427426491615;10560.788784224118;13598.93200533991;16266.268017939457;16627.25177366997;13511.05422620407;13872.791908121184;13980.231087290296;14056;14208.431662733788;13406.463741450232;13682.31588420555;13749.175049497062;13852.238126903118;14038.578842634737;14036.508722195083;14138.02067710542;14326.641833953818;14470.059446135967;14473.276336182938;8681.175288347597;8696.260817830555;8714.128587141235;8759.562021899006;8959.955200224218;9321.533923303943;9323.02108278621;12629.2422454653;13633.386497607433;13997.090189137674 03:21:03 INFO - 2015-12-17 03:21:03,316 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1493.7759336099577;1660.377358490566;1732.1685590916359;1739.1652007036623;1753.8947663140204;6936.826579335513;7201.207867134624;7484.390855965966;7562.810929726759;7585.658645360952;7533.547987120776;7569.735059272926;7628.50414723044;7679.462437629368;7682.385409167267;1946.8929208893505;1964.6758284882976;1964.99017504913;1972.1914015253749;1978.139509313446;2023.8988050597484;2027.523531969986;2036.65376885929;2070.7515098188237;2071.6685330347145;2043.3359158273547;2086.415803574994;2089.300084471704;2112;2136.914523419069;1997.3109277299309;2018.222984151105;2018.9798102019013;2020.2222144474335;2027.2296527319525;2038.9286374976953;2094.1623350659856;2095.6646936490088;2097.842661800371;2102.096098677568;7237.674304656303;7301.744438944665;7309.415246780245;7315.634218289064;7316.524425912352;4206.579342065799;4246.851360202409;4251.4685664291965;4256.4679415073115;4278.336857787048;2723.4144658898235;2733.685626152998;2765.14280573023;2771.016289217339;2777.5694767310897;847.5211505499435;865.5888452984844;874.3922973533397;889.4352086425102;892.9151730585584;9617;9672.661456848977;9696.272779541563;9699.466529340883;9699.951500242454;3736.570294416177;3781.941056504183;3831.1571454280015;3861.768293902375;3869.6130386961077;7986.720464783704;7989.7203597873795;7991.68033278674;8005.919940800634;8017.078036025931;4200.663946884242;4211.7472951623;4239.936400953989;4250.086231460189;4258.914821703549;3870.8838734838;3884.864029758945;3891;3907.628775266345;3912;3116.2209447638093;3204.967950320467;3208.326251487167;3224.951625725616;3233.951490727641;944.4097439100562;957.3729207369184;965.9082387173207;974.9707508774748;975.5024937281895;829.5520418973807;831.193742070191;990.9801803964025;1035.2649618770606;1237.5111830826772;6867.862642747117;6923.446124310043;6941.791746247621;6954.547954382949;6974;539.8866238090045;546.0825812634812;553.2061491759338;554.1798138754666;705.3651713457826;5314.468553144655;5315.388730296066;5412.56699464042;5425.511703946664;5428.6199966002005;8641.870371944426;8907;8920.24177944869;8959.148880856308;8975.865362019575;8619.525926074;8841.248493877963;8850.822983540422;8856.64573417069;8939.240164585954;6883.483738719616;6891.173059232824;6903.171619405603;6971.337722916315;6973.093497845248;6384.808455746335;6443.097966284818;6491.350864913471;6527.11883895687;6531.608103513614;7648.847023059397;7845.882311765214;7894.250046245597;7914.920850791418;7976.521408715495;8002.51984880909;8014.398920081134;8049.678012879419;8055.677772889018;8174.754757357289;6018.608790428608;6026.849328766816;6029.186059881859;6062;6077.149199112039;6723.294054124247;6872.965635171992;7024.26245244242;7061.929380706127;7063.540869843444;6319.494440444661;6419.614823110628;6504.1869766279215;6506.219253689587;6613;6427.839304017437;6453;6458.580192287486;6499.122618446449;6564.934350656432;6296.748130074929;6505.8698826024165;6514.54398192122;6524.5432819704065;6594.934050659624;5999;6070.7875224366935;6071.817845464643;6078.787242446493;6085.2393450818645;6082.878342433215;6130.63216207029;6158.199434073542;6167.814965550861;6184.690765461799 03:21:03 INFO - 2015-12-17 03:21:03,316 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.97914146009776;304.14383510418173;306.99999999999994;308.1787037544943;310.9471389863722;5481.945180548193;5638.238837756901;5640.661560306379;5665.490105890464;5683.204351390804;5417.187421886719;5604.41153678864;5607.495325420711;5608.635438696492;5629.099344104944;4325.416068830699;4331.631811296028;4332.155229730204;4337.848175313865;4340.717853339539;4328.718633288826;4329.090890912912;4339.717918335314;4344.674149438789;4347.043650396908;4086.6322031017203;4180.184863951531;4310.331898555729;4313.2451820931365;4314.460692413449;4157.792110394484;4158.2307273154565;4164.666826653891;4188.350805625133;4202.726822756511;3609.6824658999276;3614.548181477315;3617.6382361763876;3624.0577449863226;3625.365561026836;5251.159814429711;5412.134058550613;5423.430539793304;5424.077906755861;5440.347158341025;4867.050925069613;4879;4885.975570122127;4890.535399137077;4896.1186986342445;5900.616459930091;5903.79336723217;5915.1718759373725;5922.230110085704;5927.229460170193;3877.2827027000094;4015.5181378234797;4030.9596904031173;4033;4038.374052021941;6049.425304596057;6182.629042257479;6188.783392581283;6189.814305570795;6207.410296021916;4122.299209134454;4141.627253547135;4167.041580436517;4167.812448439767;4179.26862799009;4220.810063547086;4225.176090662353;4226.915461690811;4233.724807887477;4247.214265360918;4694.342792009122;4870.878228044327;4871.464138944713;4875.122477953932;4877.341558889575;5882.882342353129;5883.441073098049;5883.794067207713;5889.676067816225;5897.882042359129;1468.6768910839598;1495.2224843081538;1497.0867770659888;1497.2962707527445;1497.9700405992037;971.7279161834698;994.9801003979879;1001.6494227020485;1002.013017178079;1002.1932344462778;5116.104681680691;5120.641555091108;5133.845984620468;5138.126518491866;5138.3833939927445;6048.425399587032;6099.573029887865;6115.113308570232;6121.4490695837585;6123.846903827351;5138.2806407103035;5145.845624631267;5146.176611742103;5148.6910785353;5158.45836187195;3202.9359412811614;3207.903762887117;3236.838158092086;3310.784798988058;3317.2038710709257;5682.374938756733;5769.278840144982;5781.739821708034;5860.736266868002;5861.41385861419;6359.046143078575;6363;6365.49076073913;6393.424591786668;6394.71223794921;5854.765809367577;5855.560832937546;5861.032929566659;5865.589408741433;5878;6178.196834411498;6182.969085154546;6184.721687524162;6200.3179650237535;6214.9067763982675;5831.79588714393;6016.187814644967;6040.879182416239;6063;6066.332703402534;5807.0998995155815;5830.76676932918;5840;5858.853528661817;5861.267341582302;4120.670346372223;4147.813348399269;4188.434561334181;4191.11986482842;4198.034452075978;6020.729067192075;6153.2000839890525;6160.353162917829;6167.383261673976;6183.350748171377;5868.67722275279;5872.207252020922;5917.993941030121;5928.970355148197;5938.732757025858;5945.256842894638;5956.285245770535;5960.493358064613;5963.91054134197;5970.76116955317;5623.268975033219;5817.069268916953;5822.563307752021;5835.9708201458725;5842.38654941242;6010.068439391901;6010.459058684739;6014.766972770659;6024.307204671343;6035.939640603538;5825.883482330414;5848.502877255481;5850.678212698343;5855.414458554281;5871.4715675589405 03:21:03 INFO - 2015-12-17 03:21:03,317 DEBUG : BROWSER_OUTPUT: |5;yui.html;744.6165224909173;750.7259850154695;776.798032511547;780.839927814798;806.0649646410166;11656.417179141052;11711.297322160677;12018.939905300473;12022.218555793866;12047.518099276018;11726.882731172685;11839.585614503472;11849.703757406069;11922.582709605165;11946.462409191585;796.5340275938554;810.1736229046369;814.7881550796806;818.1981657975188;825.5088222507628;813.0609146435846;816.8162163513192;819.778659761864;823.127484866041;823.3289868756974;833.5790425834945;841.5665932045001;841.8232171244047;842.4187310755559;844.0588743550927;830.3191383065888;834.1866679986964;834.5159807311744;836.5148214035875;837.811492414208;618.279704144671;621.5027977617933;627.3632263252802;628.4187126907592;629.515273239603;11177.441127943652;11218.382988935606;11279.887201128047;11334.886651133465;11339.546418143264;10606.681799546026;10904.291221070684;10921.781564368748;10979.890201097967;11455.541778328858;9037.412568183046;9202.677906273248;9313.720588382359;9317.11487408695;9403.717888463358;3149.2599239178776;3156.2425017995747;3161.2254997525524;3162.9683703162905;3179.77741558091;37725.81137094297;38445.42331864996;38524;38539.42190867139;38641.806790965864;8834.514101724339;9056.592453339616;9061.95469022664;9193.126652967958;9210.907890921006;15499.922500387425;15566.22168891551;15813.1302778346;15818.525444236691;15864.52406427809;5963.970180149072;5965.850853728604;6174;6253.093301471261;6309.337519560472;3427.7600567960003;3449.6722811332884;3463.631865413148;3499.230169362736;3506.8246587670515;2503.8873250703764;2504.8497090174646;2516.446381796002;2526.886290116949;2533.949321013606;467.43440437071524;468.5642352612035;472.9314249433813;477.21974571575726;478.0892399978047;565.2877374508149;584.3572070722172;607.8601921558067;615.2709039787866;622.3745136138152;7396.593187374746;7541.5475071495885;7662.118856331594;7740.225977402328;7812.648430820626;441.5385921711819;506.73902939985936;585.7786515116031;594.6609146498307;607.113614123376;3718.721095917817;3750.7937063461227;3828.5979972103087;3919.627635374635;3963.504561929759;46478.76760616243;47377.28934065992;47517.28724069142;47549.5245047552;48172.7591362048;40966;41145.382819257735;41385.586144138775;41878.581214188074;43224.13551728948;38967.99999999943;39474;39808;39810.60189398127;40416.19167616631;8126.918730812617;8168.550729709923;8214.178582141738;8329.167083291622;8549.658013679384;29917.70082299149;29998.700013000464;30098.548521772627;30146;31309.53035704421;39298.214035718556;39573.2085358297;39607.801960991164;43452.78273608612;44448.33327500025;10541.947290263499;10869;11074.833877492005;11143.777124457303;11263.493142808757;11278.943605281922;11407.600733974272;11555.942220288845;11556.826647600461;11643.767124657628;10833.51249193804;10919;11043.834342484708;11275.267107638305;11628.534858605899;10398.428086455318;10788.892111078789;10824.783504329711;10928.289661171999;11044.502997365298;10671.786564268516;11036.779264414827;11084.833727493933;11128.221024528206;11364.090872729996;9088.863667045132;9291.581878815334;9405.24758019343;9428.95285523568;9509.572069256761;8642.567871606268;8898.73303800887;8952.820943580962;8964.641414343354;8969.416987895765 03:21:03 INFO - 2015-12-17 03:21:03,317 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:21:03 INFO - 2015-12-17 03:21:03,317 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,342 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: __startTimestamp1450351263302__endTimestamp 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4736.58 Median:4867.10 stddev:505.66 (10.4%) stddev-sans-first:480.48 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: Values: 2668.6 2697.9 2725.3 2729.3 2746.9 4629.9 4734.5 4766.9 4789.7 4857.8 4718.8 4780.6 4788.6 4828.7 4831.6 4343.2 4413.6 4445.5 4452.8 4495.5 4391.9 4460.0 4472.6 4509.6 4549.1 4275.6 4344.0 4372.8 4410.3 4464.6 4359.2 4361.3 4363.5 4370.3 4397.0 4394.5 4395.4 4404.8 4424.1 4456.9 4498.1 4592.9 4665.8 4802.8 4842.8 5120.0 5189.1 5193.7 5195.7 5243.4 4911.1 5216.6 5229.7 5232.7 5240.1 4692.1 4721.8 4758.5 4779.7 4834.1 5218.4 5361.6 5367.6 5384.5 5411.2 4828.0 4942.3 5106.6 5146.8 5153.5 5048.9 5136.6 5153.4 5175.6 5209.2 5059.0 5068.8 5070.9 5096.6 5102.5 4825.3 4953.1 4981.5 5044.6 5054.8 4276.4 4289.1 4296.7 4300.8 4342.1 3767.0 3780.5 3782.4 3806.9 3817.9 4178.6 4331.5 4369.6 4479.2 4485.1 5193.9 5226.5 5229.6 5260.5 5292.4 4471.6 4475.7 4476.4 4479.9 4519.7 4353.9 4453.0 4458.2 4513.5 4548.7 4824.4 4917.6 4942.7 4958.0 5039.4 4883.8 5242.0 5267.2 5269.0 5276.8 4715.7 4875.7 4937.2 4942.4 5019.7 5044.5 5077.2 5086.9 5087.5 5142.7 4915.3 5045.2 5154.2 5157.4 5157.5 4955.8 5006.9 5027.3 5030.9 5092.6 4951.8 4953.0 4953.1 4958.5 5006.3 4622.1 4738.6 4828.2 4867.1 4895.7 5019.4 5035.7 5046.8 5051.5 5056.0 4916.1 4927.9 4951.3 4954.6 4965.6 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,318 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41726.99 Median:18870.44 stddev:68348.46 (362.2%) stddev-sans-first:68470.28 03:21:03 INFO - 2015-12-17 03:21:03,320 DEBUG : BROWSER_OUTPUT: Values: 552.5 571.2 579.8 583.3 591.4 33670.3 34255.3 34270.3 34306.0 34439.7 37977.6 38533.0 38649.6 38724.4 38762.8 7726.4 7859.3 7880.1 7882.6 7893.0 7727.8 7728.0 7790.1 7802.0 7817.2 7810.5 7947.1 7951.9 7956.0 7965.2 7764.6 7871.4 7922.2 7928.2 7931.0 7769.5 7916.5 7916.9 7929.3 7930.2 35482.6 35916.6 35972.3 35991.6 36022.0 2871.7 3033.0 3038.2 3102.9 3434.9 27055.7 27546.0 27709.9 27985.3 28070.7 3426.3 3504.3 3530.6 3562.8 3563.0 213274.0 214276.0 214348.0 215535.0 216207.0 54116.2 54873.0 55005.4 55184.4 55247.7 49132.0 49314.0 65074.0 66426.3 66573.0 14351.7 14611.0 14635.1 14656.8 14689.9 10781.1 10908.7 10925.2 10927.1 10931.4 19087.1 19183.5 19392.1 19398.1 19459.5 7639.9 7793.3 7837.3 7883.2 7893.6 816.4 939.9 966.9 986.9 1079.1 25952.1 26057.0 26161.2 28035.3 30107.0 936.6 969.6 971.6 975.2 1037.6 12673.1 13027.7 13086.2 13120.8 13322.1 305639.0 311450.0 312859.0 312946.0 314038.0 44222.3 44638.3 44690.3 44725.3 44845.3 1240.2 1243.7 1246.3 1250.1 1251.8 24948.6 25013.0 25102.6 25413.0 25486.9 38684.0 39292.0 39398.2 39410.6 39512.8 246868.0 249360.0 249399.0 249507.0 249653.0 28738.6 38206.4 38630.4 38980.6 39115.2 35073.3 37858.4 37990.8 38371.4 38624.4 31786.7 32088.0 32562.3 32841.5 33091.7 29665.9 29688.3 29785.9 29870.0 36694.8 32335.2 32829.7 32834.8 33136.0 33137.2 29047.0 29351.4 29621.9 29628.3 29921.3 23369.5 23607.9 24542.3 24673.0 27123.9 03:21:03 INFO - 2015-12-17 03:21:03,320 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,320 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25664.53 Median:18053.91 stddev:78119.57 (432.7%) stddev-sans-first:78315.57 03:21:03 INFO - 2015-12-17 03:21:03,320 DEBUG : BROWSER_OUTPUT: Values: 339.6 341.4 343.1 344.0 344.2 14836.9 14922.0 15764.4 15817.0 16324.8 14082.2 14091.4 14128.0 14466.6 15046.7 4445.5 4763.8 4970.3 4985.9 5000.2 4188.0 4885.1 4908.0 4911.7 5611.5 5536.4 5540.3 5561.7 5565.1 5582.3 4668.1 4669.3 4669.7 4679.6 4922.1 4924.8 4958.4 5045.0 5056.1 5059.2 12701.0 18419.3 18764.3 18871.6 18969.3 1818.4 1875.7 1889.6 1934.5 1961.5 8809.0 9035.0 9123.2 11102.0 12688.8 1732.9 1765.1 1785.4 1922.7 1985.4 53270.5 56186.0 56967.1 57018.9 57362.4 10033.4 10067.6 10093.3 10110.9 10188.5 11870.5 12073.5 12080.3 12120.8 12705.9 7153.4 7369.8 7390.0 7431.2 7489.3 7204.9 7228.1 7302.1 7359.1 7363.4 3938.2 4093.1 4211.5 4283.9 4336.7 1743.9 1773.6 1779.0 1803.8 1811.8 826.0 867.6 872.4 874.2 948.6 15065.7 15261.5 15522.5 15785.8 15889.8 863.5 892.6 909.4 937.9 942.7 8895.5 8944.7 8956.0 9002.0 9140.8 455201.2 455679.0 457625.0 503447.0 518471.0 59677.0 64543.4 69530.3 69985.0 70993.6 1054.8 1063.9 1065.8 1107.5 1110.8 13843.2 13872.4 14037.0 14041.9 14195.2 28092.7 30622.7 31020.5 32527.2 32945.5 34176.7 35763.6 35946.3 36193.8 36804.3 8551.3 8624.2 9135.6 9302.5 9311.3 10410.4 10560.8 13598.9 16266.3 16627.3 13511.1 13872.8 13980.2 14056.0 14208.4 13406.5 13682.3 13749.2 13852.2 14038.6 14036.5 14138.0 14326.6 14470.1 14473.3 8681.2 8696.3 8714.1 8759.6 8960.0 9321.5 9323.0 12629.2 13633.4 13997.1 03:21:03 INFO - 2015-12-17 03:21:03,320 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,320 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5037.20 Median:6435.47 stddev:2671.00 (41.5%) stddev-sans-first:2665.22 03:21:03 INFO - 2015-12-17 03:21:03,321 DEBUG : BROWSER_OUTPUT: Values: 1493.8 1660.4 1732.2 1739.2 1753.9 6936.8 7201.2 7484.4 7562.8 7585.7 7533.5 7569.7 7628.5 7679.5 7682.4 1946.9 1964.7 1965.0 1972.2 1978.1 2023.9 2027.5 2036.7 2070.8 2071.7 2043.3 2086.4 2089.3 2112.0 2136.9 1997.3 2018.2 2019.0 2020.2 2027.2 2038.9 2094.2 2095.7 2097.8 2102.1 7237.7 7301.7 7309.4 7315.6 7316.5 4206.6 4246.9 4251.5 4256.5 4278.3 2723.4 2733.7 2765.1 2771.0 2777.6 847.5 865.6 874.4 889.4 892.9 9617.0 9672.7 9696.3 9699.5 9700.0 3736.6 3781.9 3831.2 3861.8 3869.6 7986.7 7989.7 7991.7 8005.9 8017.1 4200.7 4211.7 4239.9 4250.1 4258.9 3870.9 3884.9 3891.0 3907.6 3912.0 3116.2 3205.0 3208.3 3225.0 3234.0 944.4 957.4 965.9 975.0 975.5 829.6 831.2 991.0 1035.3 1237.5 6867.9 6923.4 6941.8 6954.5 6974.0 539.9 546.1 553.2 554.2 705.4 5314.5 5315.4 5412.6 5425.5 5428.6 8641.9 8907.0 8920.2 8959.1 8975.9 8619.5 8841.2 8850.8 8856.6 8939.2 6883.5 6891.2 6903.2 6971.3 6973.1 6384.8 6443.1 6491.4 6527.1 6531.6 7648.8 7845.9 7894.3 7914.9 7976.5 8002.5 8014.4 8049.7 8055.7 8174.8 6018.6 6026.8 6029.2 6062.0 6077.1 6723.3 6873.0 7024.3 7061.9 7063.5 6319.5 6419.6 6504.2 6506.2 6613.0 6427.8 6453.0 6458.6 6499.1 6564.9 6296.7 6505.9 6514.5 6524.5 6594.9 5999.0 6070.8 6071.8 6078.8 6085.2 6082.9 6130.6 6158.2 6167.8 6184.7 03:21:03 INFO - 2015-12-17 03:21:03,321 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,321 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4880.02 Median:5605.95 stddev:1466.38 (26.2%) stddev-sans-first:1429.60 03:21:03 INFO - 2015-12-17 03:21:03,321 DEBUG : BROWSER_OUTPUT: Values: 298.0 304.1 307.0 308.2 310.9 5481.9 5638.2 5640.7 5665.5 5683.2 5417.2 5604.4 5607.5 5608.6 5629.1 4325.4 4331.6 4332.2 4337.8 4340.7 4328.7 4329.1 4339.7 4344.7 4347.0 4086.6 4180.2 4310.3 4313.2 4314.5 4157.8 4158.2 4164.7 4188.4 4202.7 3609.7 3614.5 3617.6 3624.1 3625.4 5251.2 5412.1 5423.4 5424.1 5440.3 4867.1 4879.0 4886.0 4890.5 4896.1 5900.6 5903.8 5915.2 5922.2 5927.2 3877.3 4015.5 4031.0 4033.0 4038.4 6049.4 6182.6 6188.8 6189.8 6207.4 4122.3 4141.6 4167.0 4167.8 4179.3 4220.8 4225.2 4226.9 4233.7 4247.2 4694.3 4870.9 4871.5 4875.1 4877.3 5882.9 5883.4 5883.8 5889.7 5897.9 1468.7 1495.2 1497.1 1497.3 1498.0 971.7 995.0 1001.6 1002.0 1002.2 5116.1 5120.6 5133.8 5138.1 5138.4 6048.4 6099.6 6115.1 6121.4 6123.8 5138.3 5145.8 5146.2 5148.7 5158.5 3202.9 3207.9 3236.8 3310.8 3317.2 5682.4 5769.3 5781.7 5860.7 5861.4 6359.0 6363.0 6365.5 6393.4 6394.7 5854.8 5855.6 5861.0 5865.6 5878.0 6178.2 6183.0 6184.7 6200.3 6214.9 5831.8 6016.2 6040.9 6063.0 6066.3 5807.1 5830.8 5840.0 5858.9 5861.3 4120.7 4147.8 4188.4 4191.1 4198.0 6020.7 6153.2 6160.4 6167.4 6183.4 5868.7 5872.2 5918.0 5929.0 5938.7 5945.3 5956.3 5960.5 5963.9 5970.8 5623.3 5817.1 5822.6 5836.0 5842.4 6010.1 6010.5 6014.8 6024.3 6035.9 5825.9 5848.5 5850.7 5855.4 5871.5 03:21:03 INFO - 2015-12-17 03:21:03,322 DEBUG : BROWSER_OUTPUT: 03:21:03 INFO - 2015-12-17 03:21:03,322 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12051.45 Median:41632.08 stddev:13344.83 (32.1%) stddev-sans-first:13355.25 03:21:03 INFO - 2015-12-17 03:21:03,323 DEBUG : BROWSER_OUTPUT: Values: 744.6 750.7 776.8 780.8 806.1 11656.4 11711.3 12018.9 12022.2 12047.5 11726.9 11839.6 11849.7 11922.6 11946.5 796.5 810.2 814.8 818.2 825.5 813.1 816.8 819.8 823.1 823.3 833.6 841.6 841.8 842.4 844.1 830.3 834.2 834.5 836.5 837.8 618.3 621.5 627.4 628.4 629.5 11177.4 11218.4 11279.9 11334.9 11339.5 10606.7 10904.3 10921.8 10979.9 11455.5 9037.4 9202.7 9313.7 9317.1 9403.7 3149.3 3156.2 3161.2 3163.0 3179.8 37725.8 38445.4 38524.0 38539.4 38641.8 8834.5 9056.6 9062.0 9193.1 9210.9 15499.9 15566.2 15813.1 15818.5 15864.5 5964.0 5965.9 6174.0 6253.1 6309.3 3427.8 3449.7 3463.6 3499.2 3506.8 2503.9 2504.8 2516.4 2526.9 2533.9 467.4 468.6 472.9 477.2 478.1 565.3 584.4 607.9 615.3 622.4 7396.6 7541.5 7662.1 7740.2 7812.6 441.5 506.7 585.8 594.7 607.1 3718.7 3750.8 3828.6 3919.6 3963.5 46478.8 47377.3 47517.3 47549.5 48172.8 40966.0 41145.4 41385.6 41878.6 43224.1 38968.0 39474.0 39808.0 39810.6 40416.2 8126.9 8168.6 8214.2 8329.2 8549.7 29917.7 29998.7 30098.5 30146.0 31309.5 39298.2 39573.2 39607.8 43452.8 44448.3 10541.9 10869.0 11074.8 11143.8 11263.5 11278.9 11407.6 11555.9 11556.8 11643.8 10833.5 10919.0 11043.8 11275.3 11628.5 10398.4 10788.9 10824.8 10928.3 11044.5 10671.8 11036.8 11084.8 11128.2 11364.1 9088.9 9291.6 9405.2 9429.0 9509.6 8642.6 8898.7 8952.8 8964.6 8969.4 03:21:03 INFO - 2015-12-17 03:21:03,323 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:21:03 INFO - 2015-12-17 03:21:03,323 DEBUG : BROWSER_OUTPUT: 03:21:04 INFO - 2015-12-17 03:21:04,035 INFO : Browser exited with error code: 0 03:21:04 INFO - 2015-12-17 03:21:04,054 INFO : Completed test dromaeo_css (00:18:34) 03:21:04 INFO - 2015-12-17 03:21:04,054 INFO : Starting test kraken 03:21:04 INFO - 2015-12-17 03:21:04,054 DEBUG : operating with platform_type : linux_ 03:21:04 INFO - 2015-12-17 03:21:04,054 INFO : Initialising browser for kraken test... 03:21:04 INFO - 2015-12-17 03:21:04,060 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqsm_e2/profile http://localhost:46595/getInfo.html 03:21:08 INFO - 2015-12-17 03:21:08,911 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:21:08 INFO - 2015-12-17 03:21:08,911 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:21:08 INFO - 2015-12-17 03:21:08,911 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:21:08 INFO - 2015-12-17 03:21:08,911 DEBUG : BROWSER_OUTPUT: __metrics 03:21:09 INFO - 2015-12-17 03:21:09,019 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:21:10 INFO - 2015-12-17 03:21:10,051 INFO : Browser initialized. 03:21:10 INFO - 2015-12-17 03:21:10,051 INFO : Running cycle 1/1 for kraken test... 03:21:10 INFO - 2015-12-17 03:21:10,052 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqsm_e2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:21:22 INFO - 2015-12-17 03:21:22,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 143572992 03:21:22 INFO - 2015-12-17 03:21:22,132 DEBUG : BROWSER_OUTPUT: 03:21:24 INFO - 2015-12-17 03:21:24,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46595/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:25 INFO - 2015-12-17 03:21:25,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 145043456 03:21:25 INFO - 2015-12-17 03:21:25,333 DEBUG : BROWSER_OUTPUT: 03:21:28 INFO - 2015-12-17 03:21:28,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46595/tests/kraken/driver.html?testName=audio-dft) 03:21:28 INFO - 2015-12-17 03:21:28,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 144388096 03:21:28 INFO - 2015-12-17 03:21:28,694 DEBUG : BROWSER_OUTPUT: 03:21:31 INFO - 2015-12-17 03:21:31,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46595/tests/kraken/driver.html?testName=audio-fft) 03:21:32 INFO - 2015-12-17 03:21:32,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 138043392 03:21:32 INFO - 2015-12-17 03:21:32,180 DEBUG : BROWSER_OUTPUT: 03:21:34 INFO - 2015-12-17 03:21:34,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46595/tests/kraken/driver.html?testName=audio-oscillator) 03:21:34 INFO - 2015-12-17 03:21:34,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 03:21:34 INFO - 2015-12-17 03:21:34,940 DEBUG : BROWSER_OUTPUT: 03:21:37 INFO - 2015-12-17 03:21:37,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:37 INFO - 2015-12-17 03:21:37,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 139108352 03:21:37 INFO - 2015-12-17 03:21:37,814 DEBUG : BROWSER_OUTPUT: 03:21:40 INFO - 2015-12-17 03:21:40,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46595/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:41 INFO - 2015-12-17 03:21:41,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 139595776 03:21:41 INFO - 2015-12-17 03:21:41,446 DEBUG : BROWSER_OUTPUT: 03:21:44 INFO - 2015-12-17 03:21:44,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46595/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:45 INFO - 2015-12-17 03:21:45,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 137981952 03:21:45 INFO - 2015-12-17 03:21:45,514 DEBUG : BROWSER_OUTPUT: 03:21:48 INFO - 2015-12-17 03:21:48,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46595/tests/kraken/driver.html?testName=json-parse-financial) 03:21:49 INFO - 2015-12-17 03:21:49,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 138915840 03:21:49 INFO - 2015-12-17 03:21:49,059 DEBUG : BROWSER_OUTPUT: 03:21:50 INFO - 2015-12-17 03:21:50,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:51 INFO - 2015-12-17 03:21:51,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 140746752 03:21:51 INFO - 2015-12-17 03:21:51,435 DEBUG : BROWSER_OUTPUT: 03:21:53 INFO - 2015-12-17 03:21:53,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:53 INFO - 2015-12-17 03:21:53,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 139657216 03:21:53 INFO - 2015-12-17 03:21:53,915 DEBUG : BROWSER_OUTPUT: 03:21:56 INFO - 2015-12-17 03:21:56,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:56 INFO - 2015-12-17 03:21:56,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 140124160 03:21:56 INFO - 2015-12-17 03:21:56,681 DEBUG : BROWSER_OUTPUT: 03:21:59 INFO - 2015-12-17 03:21:59,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:59 INFO - 2015-12-17 03:21:59,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 140185600 03:21:59 INFO - 2015-12-17 03:21:59,854 DEBUG : BROWSER_OUTPUT: 03:22:02 INFO - 2015-12-17 03:22:02,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:03 INFO - 2015-12-17 03:22:03,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 140300288 03:22:03 INFO - 2015-12-17 03:22:03,092 DEBUG : BROWSER_OUTPUT: 03:22:04 INFO - 2015-12-17 03:22:04,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46595/tests/kraken/driver.html?testName=ai-astar) 03:22:05 INFO - 2015-12-17 03:22:05,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 141041664 03:22:05 INFO - 2015-12-17 03:22:05,096 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,097 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:22:05 INFO - 2015-12-17 03:22:05,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:22:05 INFO - 2015-12-17 03:22:05,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:22:05 INFO - 2015-12-17 03:22:05,099 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:22:05 INFO - 2015-12-17 03:22:05,099 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;107;114;115;118;128;115;116;114;114 03:22:05 INFO - 2015-12-17 03:22:05,100 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;158;165;135;161;158;140;172;133 03:22:05 INFO - 2015-12-17 03:22:05,100 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;173;165;163;164;167;163;165;163 03:22:05 INFO - 2015-12-17 03:22:05,100 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;72;72;73;140;73;72;73 03:22:05 INFO - 2015-12-17 03:22:05,100 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;139;95;95;94;134;94;95;129 03:22:05 INFO - 2015-12-17 03:22:05,100 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;110;110;110;109;109;110 03:22:05 INFO - 2015-12-17 03:22:05,100 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;149;148;149;148;149;147;147 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;82;74;74;77;75;73;71;72 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;68;69;70;69;68;68 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;88;87;85;87;86;87;96;86;86 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;127;137;131;127;121;129;126;126;129 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;157;154;151;153;141;152;151;140;139 03:22:05 INFO - 2015-12-17 03:22:05,101 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;69;71;72;72;70;70;71;73 03:22:05 INFO - 2015-12-17 03:22:05,102 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:22:05 INFO - 2015-12-17 03:22:05,102 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:22:05 INFO - 2015-12-17 03:22:05,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,806 03:22:05 INFO - 2015-12-17 03:22:05,102 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:22:05 INFO - 2015-12-17 03:22:05,102 DEBUG : BROWSER_OUTPUT: __startTimestamp1450351325097__endTimestamp 03:22:05 INFO - 2015-12-17 03:22:05,102 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.70 Median:115.50 stddev:5.19 (4.5%) stddev-sans-first:5.50 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: Values: 116.0 107.0 114.0 115.0 118.0 128.0 115.0 116.0 114.0 114.0 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.90 Median:158.00 stddev:14.76 (9.3%) stddev-sans-first:15.54 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 158.0 165.0 135.0 161.0 158.0 140.0 172.0 133.0 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.09 (1.9%) stddev-sans-first:3.26 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 173.0 165.0 163.0 164.0 167.0 163.0 165.0 163.0 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:73.00 stddev:21.33 (29.2%) stddev-sans-first:22.51 03:22:05 INFO - 2015-12-17 03:22:05,106 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 72.0 73.0 140.0 73.0 72.0 73.0 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:19.13 (20.1%) stddev-sans-first:19.83 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 139.0 95.0 95.0 94.0 134.0 94.0 95.0 129.0 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 149.0 148.0 149.0 148.0 149.0 147.0 147.0 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,107 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.50 Median:74.00 stddev:3.10 (4.2%) stddev-sans-first:3.28 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 82.0 74.0 74.0 77.0 75.0 73.0 71.0 72.0 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 68.0 69.0 70.0 69.0 68.0 68.0 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:3.20 (3.7%) stddev-sans-first:3.28 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 87.0 85.0 87.0 86.0 87.0 96.0 86.0 86.0 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:4.67 (3.6%) stddev-sans-first:4.34 03:22:05 INFO - 2015-12-17 03:22:05,108 DEBUG : BROWSER_OUTPUT: Values: 121.0 127.0 137.0 131.0 127.0 121.0 129.0 126.0 126.0 129.0 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:151.50 stddev:7.07 (4.7%) stddev-sans-first:6.76 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: Values: 139.0 157.0 154.0 151.0 153.0 141.0 152.0 151.0 140.0 139.0 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 71.0 72.0 72.0 70.0 70.0 71.0 73.0 03:22:05 INFO - 2015-12-17 03:22:05,109 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:22:05 INFO - 2015-12-17 03:22:05,110 DEBUG : BROWSER_OUTPUT: 03:22:06 INFO - 2015-12-17 03:22:06,023 INFO : Browser exited with error code: 0 03:22:06 INFO - 2015-12-17 03:22:06,079 INFO : Completed test kraken (00:01:02) 03:22:06 INFO - 2015-12-17 03:22:06,079 INFO : Starting test v8_7 03:22:06 INFO - 2015-12-17 03:22:06,080 DEBUG : operating with platform_type : linux_ 03:22:06 INFO - 2015-12-17 03:22:06,080 INFO : Initialising browser for v8_7 test... 03:22:06 INFO - 2015-12-17 03:22:06,086 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLzOVPd/profile http://localhost:46595/getInfo.html 03:22:10 INFO - 2015-12-17 03:22:10,953 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:22:10 INFO - 2015-12-17 03:22:10,953 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:22:10 INFO - 2015-12-17 03:22:10,953 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:22:10 INFO - 2015-12-17 03:22:10,953 DEBUG : BROWSER_OUTPUT: __metrics 03:22:11 INFO - 2015-12-17 03:22:11,114 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:22:12 INFO - 2015-12-17 03:22:12,115 INFO : Browser initialized. 03:22:12 INFO - 2015-12-17 03:22:12,115 INFO : Running cycle 1/1 for v8_7 test... 03:22:12 INFO - 2015-12-17 03:22:12,116 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLzOVPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:22:24 INFO - 2015-12-17 03:22:24,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 143511552 03:22:24 INFO - 2015-12-17 03:22:24,097 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46595/tests/v8_7/run.html (next: http://localhost:46595/tests/v8_7/run.html) 03:22:45 INFO - 2015-12-17 03:22:45,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 138035200 03:22:45 INFO - 2015-12-17 03:22:45,841 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,841 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: |0;Richards;167.53224995811695 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.97731076808628 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 03:22:45 INFO - 2015-12-17 03:22:45,842 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 03:22:45 INFO - 2015-12-17 03:22:45,843 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.322033898305 03:22:45 INFO - 2015-12-17 03:22:45,843 DEBUG : BROWSER_OUTPUT: |5;Earley;712.2507122507122 03:22:45 INFO - 2015-12-17 03:22:45,843 DEBUG : BROWSER_OUTPUT: |6;Boyer;12395.061728395061 03:22:45 INFO - 2015-12-17 03:22:45,843 DEBUG : BROWSER_OUTPUT: |7;RegExp;26973.684210526317 03:22:45 INFO - 2015-12-17 03:22:45,843 DEBUG : BROWSER_OUTPUT: |8;Splay;685.8710562414266 03:22:45 INFO - 2015-12-17 03:22:45,844 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 03:22:45 INFO - 2015-12-17 03:22:45,844 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:22:45 INFO - 2015-12-17 03:22:45,844 DEBUG : BROWSER_OUTPUT: __startTimestamp1450351365833__endTimestamp 03:22:45 INFO - 2015-12-17 03:22:45,844 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,845 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:22:45 INFO - 2015-12-17 03:22:45,845 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:22:45 INFO - 2015-12-17 03:22:45,845 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,845 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,845 DEBUG : BROWSER_OUTPUT: Values: 167.5 03:22:45 INFO - 2015-12-17 03:22:45,846 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,846 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.98 Median:185.98 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,846 DEBUG : BROWSER_OUTPUT: Values: 186.0 03:22:45 INFO - 2015-12-17 03:22:45,846 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,847 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,847 DEBUG : BROWSER_OUTPUT: Values: 278.4 03:22:45 INFO - 2015-12-17 03:22:45,847 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,847 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,848 DEBUG : BROWSER_OUTPUT: Values: 5170.1 03:22:45 INFO - 2015-12-17 03:22:45,848 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,848 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,848 DEBUG : BROWSER_OUTPUT: Values: 1059.3 03:22:45 INFO - 2015-12-17 03:22:45,848 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,849 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:712.25 Median:712.25 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,849 DEBUG : BROWSER_OUTPUT: Values: 712.3 03:22:45 INFO - 2015-12-17 03:22:45,849 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,849 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,849 DEBUG : BROWSER_OUTPUT: Values: 12395.1 03:22:45 INFO - 2015-12-17 03:22:45,850 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,850 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26973.68 Median:26973.68 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,850 DEBUG : BROWSER_OUTPUT: Values: 26973.7 03:22:45 INFO - 2015-12-17 03:22:45,850 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,851 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:685.87 Median:685.87 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,851 DEBUG : BROWSER_OUTPUT: Values: 685.9 03:22:45 INFO - 2015-12-17 03:22:45,851 DEBUG : BROWSER_OUTPUT: 03:22:45 INFO - 2015-12-17 03:22:45,851 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 03:22:45 INFO - 2015-12-17 03:22:45,851 DEBUG : BROWSER_OUTPUT: Values: 4859.2 03:22:45 INFO - 2015-12-17 03:22:45,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:22:45 INFO - 2015-12-17 03:22:45,852 DEBUG : BROWSER_OUTPUT: 03:22:46 INFO - 2015-12-17 03:22:46,751 INFO : Browser exited with error code: 0 03:22:46 INFO - 2015-12-17 03:22:46,768 INFO : Completed test v8_7 (00:00:40) 03:22:46 INFO - 2015-12-17 03:22:46,805 INFO : Completed test suite (00:20:17) 03:22:46 INFO - 2015-12-17 03:22:46,806 DEBUG : Working with test: dromaeo_css 03:22:46 INFO - 2015-12-17 03:22:46,806 DEBUG : Generating results file: dromaeo_css 03:22:46 INFO - 2015-12-17 03:22:46,807 DEBUG : Working with test: kraken 03:22:46 INFO - 2015-12-17 03:22:46,807 DEBUG : Generating results file: kraken 03:22:46 INFO - 2015-12-17 03:22:46,807 INFO : javascript benchmark 03:22:46 INFO - 2015-12-17 03:22:46,807 DEBUG : Working with test: v8_7 03:22:46 INFO - 2015-12-17 03:22:46,807 DEBUG : Generating results file: v8_7 03:22:46 INFO - 2015-12-17 03:22:46,808 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:46 INFO - 2015-12-17 03:22:46,859 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:22:46 INFO - 2015-12-17 03:22:46,859 DEBUG : process_Request line: dromaeo_css 6371.97 graph.html#tests=[[72,132,43]] 03:22:46 INFO - 2015-12-17 03:22:46,859 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:46 INFO - 2015-12-17 03:22:46,891 DEBUG : process_Request line: kraken 1547.60 graph.html#tests=[[232,132,43]] 03:22:46 INFO - 2015-12-17 03:22:46,891 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:46 INFO - 2015-12-17 03:22:46,919 DEBUG : process_Request line: v8_7 20985.45 graph.html#tests=[[230,132,43]] 03:22:46 INFO - 2015-12-17 03:22:46,921 INFO : javascript benchmark 03:22:46 INFO - 2015-12-17 03:22:46,924 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2668.6130511075894, 2697.946041079177, 2725.291424229701, 2729.263098963279, 2746.862656867156, 4629.884252893679, 4734.502877197892, 4766.928496072562, 4789.688670236432, 4857.805687772489, 4718.834840780573, 4780.617550595953, 4788.64085193611, 4828.661993660445, 4831.565159135677, 4343.239933011726, 4413.646908247349, 4445.466544014723, 4452.7996240169105, 4495.527969563198, 4391.9121617567625, 4459.977700111495, 4472.642188624918, 4509.594136527712, 4549.09018196362, 4275.572442755731, 4344.022594916119, 4372.803223854934, 4410.316400957857, 4464.553544645542, 4359.237133501656, 4361.258586040349, 4363.498197707241, 4370.2570563004365, 4396.9886926006875, 4394.4946331172005, 4395.406620106277, 4404.775588327906, 4424.137293227822, 4456.93314600278, 4498.122866041123, 4592.931106033412, 4665.766711664403, 4802.807887684488, 4842.782074806642, 5119.974400127976, 5189.117849965515, 5193.688378697252, 5195.662281951699, 5243.370795504564, 4911.140550403701, 5216.60875434344, 5229.660072095302, 5232.7122008289525, 5240.082985477527, 4692.085043416535, 4721.811127554894, 4758.500357462486, 4779.737114458738, 4834.105690447279, 5218.399884013311, 5361.597880159004, 5367.624266301322, 5384.488473595002, 5411.161270003156, 4828.03439312139, 4942.283368911488, 5106.617003724661, 5146.845594632167, 5153.484651534892, 5048.924266136011, 5136.5890728741615, 5153.3815942087185, 5175.585953123741, 5209.166533354645, 5059.038782631288, 5068.822591209364, 5070.923936140961, 5096.592272618256, 5102.515261050195, 4825.348577942003, 4953.1332016896895, 4981.526754958273, 5044.596432285409, 5054.82308119214, 4276.444062271885, 4289.056407590325, 4296.677749168824, 4300.78496075195, 4342.08816148606, 3767.0, 3780.5085338905765, 3782.3759079751535, 3806.923861522754, 3817.9045523862123, 4178.623923846869, 4331.545187755303, 4369.628581570539, 4479.193745125908, 4485.0805584855025, 5193.870153246124, 5226.451222621646, 5229.555487783581, 5260.473952604709, 5292.391374991848, 4471.5528447155675, 4475.70907890986, 4476.35092911526, 4479.932801007987, 4519.683622146484, 4353.869383918487, 4452.9554704453185, 4458.197524445631, 4513.5486451355255, 4548.727076375362, 4824.445188803333, 4917.557419832232, 4942.728149951859, 4957.950420495749, 5039.420466646236, 4883.755812209304, 5242.0, 5267.236250743697, 5269.0, 5276.841694749163, 4715.669903106749, 4875.68308059975, 4937.185364414831, 4942.4316203637045, 5019.698818070928, 5044.495550444926, 5077.238414237894, 5086.931744333731, 5087.516685914832, 5142.717150556755, 4915.311856340187, 5045.217991211368, 5154.175331946871, 5157.406898206755, 5157.510036546522, 4955.801767929387, 5006.949930500648, 5027.296178534935, 5030.9245361320345, 5092.643514954066, 4951.752412379438, 4952.950470495249, 4953.133201689618, 4958.479359667327, 5006.274090256965, 4622.05247924168, 4738.644601654959, 4828.155072862165, 4867.099586576494, 4895.657303988686, 5019.372578427697, 5035.697858128524, 5046.823361182341, 5051.545360917388, 5056.0, 4916.11509928202, 4927.901441971212, 4951.331570238116, 4954.5788607968725, 4965.602751779921], "unit": "score", "name": "dojo.html", "value": 4704.62279252853}, {"lowerIsBetter": false, "replicates": [552.507534193648, 571.2459553389527, 579.7565022690472, 583.2942140010588, 591.3554225893777, 33670.32659346812, 34255.31489370214, 34270.31459370811, 34306.0, 34439.655603443956, 37977.620223797756, 38533.0, 38649.61350386495, 38724.41913371302, 38762.80618596903, 7726.381889448859, 7859.331956783681, 7880.093789214227, 7882.60586970652, 7892.960535197316, 7727.806804829868, 7727.9613601931915, 7790.104138024115, 7802.024746906637, 7817.1791961843755, 7810.453268271223, 7947.08608510023, 7951.880721789178, 7956.04527456706, 7965.203479652017, 7764.611769411506, 7871.448998570102, 7922.207779222089, 7928.207179282083, 7931.048274207074, 7769.456138070337, 7916.485428447132, 7916.920830791676, 7929.286364227247, 7930.246626570467, 35482.64517354819, 35916.64083359159, 35972.280554388766, 35991.64008359909, 36022.0, 2871.7415432611165, 3033.0, 3038.1645047612083, 3102.90691279262, 3434.8797792077407, 27055.729442705713, 27546.0, 27709.86145069282, 27985.30036749077, 28070.719292807014, 3426.297608990151, 3504.316658251642, 3530.5939816921127, 3562.768420052714, 3562.982185089084, 213274.0, 214276.0, 214348.0, 215535.0, 216206.99999999843, 54116.188257176174, 54873.0, 55005.44994550003, 55184.44815551793, 55247.72376138174, 49132.0, 49314.0, 65074.0, 66426.33573664201, 66573.0, 14351.712965740626, 14611.0, 14635.121892686473, 14656.780148297785, 14689.853101469062, 10781.137508999262, 10908.672739817817, 10925.180611454172, 10927.071198948179, 10931.398773067558, 19087.141078651493, 19183.52041198953, 19392.12735426909, 19398.12708428124, 19459.51351216231, 7639.923600764032, 7793.2596403341595, 7837.275799324254, 7883.2116788321855, 7893.644785984645, 816.4366587055032, 939.9342046056711, 966.8984756600596, 986.9259805514615, 1079.082779637302, 25952.09167679122, 26057.0, 26161.215163545123, 28035.299117522227, 30107.0, 936.6113063078882, 969.6121551379505, 971.5676523946776, 975.2441857560306, 1037.6057098302597, 12673.09945894728, 13027.739445211042, 13086.214827110214, 13120.803187952188, 13322.134061285986, 305639.0, 311450.0, 312859.0, 312946.0, 314038.0, 44222.33666495005, 44638.33042504365, 44690.32964505535, 44725.32912006322, 44845.327320090226, 1240.1938739819009, 1243.7325974915436, 1246.2584762066556, 1250.112420181663, 1251.8372611560621, 24948.625770613093, 25013.0, 25102.62346064847, 25413.0, 25486.87256563705, 38684.03289917774, 39292.0, 39398.212035759694, 39410.605893940694, 39512.802435988786, 246868.0, 249360.0, 249399.0, 249507.0, 249653.0, 28738.568921465776, 38206.42690359702, 38630.42054369243, 38980.6101938977, 39115.2176956465, 35073.29853402867, 37858.43212351762, 37990.81004594959, 38371.42442863415, 38624.42063369108, 31786.682133179296, 32088.0, 32562.348753025282, 32841.50737738888, 33091.66908330982, 29665.851670741507, 29688.25779355447, 29785.85107074451, 29870.0, 36694.8165259172, 32335.191620209684, 32829.671703282664, 32834.835825820715, 33136.0, 33137.171570710925, 29047.0, 29351.412971740872, 29621.851890740407, 29628.259293517833, 29921.251968700086, 23369.532609348058, 23607.881960590086, 24542.32553499334, 24673.0, 27123.86438067797], "unit": "score", "name": "ext.html", "value": 16997.96806684495}, {"lowerIsBetter": false, "replicates": [339.5941849489861, 341.44856057467183, 343.0685688356113, 344.02812055941956, 344.177415975818, 14836.851631483682, 14922.0, 15764.369425222978, 15817.0, 16324.83675163248, 14082.225477598728, 14091.436342546285, 14128.011039227258, 14466.638334041654, 15046.699066018673, 4445.510993790688, 4763.809447622091, 4970.279309500138, 4985.875353116183, 5000.224965130393, 4187.979060104695, 4885.0718363511, 4908.0429316283335, 4911.729854857981, 5611.466910643482, 5536.446355364452, 5540.307461567304, 5561.694106824123, 5565.109582466806, 5582.330120385559, 4668.136394766962, 4669.2529195328925, 4669.7431641259545, 4679.578837904605, 4922.089413458504, 4924.753762311906, 4958.429780575208, 5045.016221836743, 5056.064628043787, 5059.241113832918, 12701.047421443336, 18419.263229470806, 18764.34324798639, 18871.62256754871, 18969.33607323737, 1818.436284751718, 1875.6717574424558, 1889.5653999580175, 1934.4680212941553, 1961.4900125967208, 8809.0, 9034.954825225897, 9123.224525915306, 11102.0, 12688.80966785499, 1732.9220185091701, 1765.082157278221, 1785.3572713823014, 1922.6539222939866, 1985.3547597031022, 53270.467295327326, 56186.0, 56967.145492818054, 57018.85962280773, 57362.426375736126, 10033.444816053523, 10067.647632332833, 10093.343932644355, 10110.949445252727, 10188.490575471196, 11870.525178992917, 12073.517059317528, 12080.335581542924, 12120.81818772719, 12705.872941270654, 7153.3561979421065, 7369.77890663281, 7390.03929489163, 7431.2197219292275, 7489.28851759082, 7204.855902881913, 7228.096487939008, 7302.123745150509, 7359.062901347753, 7363.374113200438, 3938.1926705025976, 4093.099518106012, 4211.494620645481, 4283.871483855427, 4336.6530677545725, 1743.9040852752967, 1773.645270945816, 1779.0, 1803.8376546110912, 1811.791643960935, 826.0129145670866, 867.5878957495139, 872.358816270041, 874.152072489684, 948.5968463403026, 15065.698686026437, 15261.47385261465, 15522.456714015181, 15785.763213551805, 15889.761653575206, 863.5121156546531, 892.5938697892443, 909.3634455880909, 937.9484128373005, 942.6606421688186, 8895.510746908982, 8944.73165805014, 8955.955220223988, 9001.954990225138, 9140.771480712903, 455201.2399380018, 455679.0, 457625.0, 503447.0, 518471.0, 59677.0, 64543.35456645468, 69530.26174345682, 69985.0, 70993.6450317745, 1054.8048611006989, 1063.941483218415, 1065.7974984752873, 1107.4905543450104, 1110.7833972375308, 13843.238621875893, 13872.445102196203, 14037.0, 14041.929790350983, 14195.219262940638, 28092.71907280983, 30622.693773061983, 31020.53469198009, 32527.18682032968, 32945.505817412275, 34176.65823341834, 35763.64236357603, 35946.28107437889, 36193.81903090468, 36804.26391472102, 8551.33249016436, 8624.18070283322, 9135.583984482415, 9302.534873256445, 9311.348205625813, 10410.427426491615, 10560.788784224118, 13598.93200533991, 16266.268017939457, 16627.25177366997, 13511.05422620407, 13872.791908121184, 13980.231087290296, 14056.0, 14208.431662733788, 13406.463741450232, 13682.31588420555, 13749.175049497062, 13852.238126903118, 14038.578842634737, 14036.508722195083, 14138.02067710542, 14326.641833953818, 14470.059446135967, 14473.276336182938, 8681.175288347597, 8696.260817830555, 8714.128587141235, 8759.562021899006, 8959.955200224218, 9321.533923303943, 9323.02108278621, 12629.2422454653, 13633.386497607433, 13997.090189137674], "unit": "score", "name": "jquery.html", "value": 8213.755824137965}, {"lowerIsBetter": false, "replicates": [1493.7759336099577, 1660.377358490566, 1732.1685590916359, 1739.1652007036623, 1753.8947663140204, 6936.826579335513, 7201.207867134624, 7484.390855965966, 7562.810929726759, 7585.658645360952, 7533.547987120776, 7569.735059272926, 7628.50414723044, 7679.462437629368, 7682.385409167267, 1946.8929208893505, 1964.6758284882976, 1964.99017504913, 1972.1914015253749, 1978.139509313446, 2023.8988050597484, 2027.523531969986, 2036.65376885929, 2070.7515098188237, 2071.6685330347145, 2043.3359158273547, 2086.415803574994, 2089.300084471704, 2112.0, 2136.914523419069, 1997.3109277299309, 2018.222984151105, 2018.9798102019013, 2020.2222144474335, 2027.2296527319525, 2038.9286374976953, 2094.1623350659856, 2095.6646936490088, 2097.842661800371, 2102.096098677568, 7237.674304656303, 7301.744438944665, 7309.415246780245, 7315.634218289064, 7316.524425912352, 4206.579342065799, 4246.851360202409, 4251.4685664291965, 4256.4679415073115, 4278.336857787048, 2723.4144658898235, 2733.685626152998, 2765.14280573023, 2771.016289217339, 2777.5694767310897, 847.5211505499435, 865.5888452984844, 874.3922973533397, 889.4352086425102, 892.9151730585584, 9617.0, 9672.661456848977, 9696.272779541563, 9699.466529340883, 9699.951500242454, 3736.570294416177, 3781.941056504183, 3831.1571454280015, 3861.768293902375, 3869.6130386961077, 7986.720464783704, 7989.7203597873795, 7991.68033278674, 8005.919940800634, 8017.078036025931, 4200.663946884242, 4211.7472951623, 4239.936400953989, 4250.086231460189, 4258.914821703549, 3870.8838734838, 3884.864029758945, 3891.0, 3907.628775266345, 3912.0, 3116.2209447638093, 3204.967950320467, 3208.326251487167, 3224.951625725616, 3233.951490727641, 944.4097439100562, 957.3729207369184, 965.9082387173207, 974.9707508774748, 975.5024937281895, 829.5520418973807, 831.193742070191, 990.9801803964025, 1035.2649618770606, 1237.5111830826772, 6867.862642747117, 6923.446124310043, 6941.791746247621, 6954.547954382949, 6974.0, 539.8866238090045, 546.0825812634812, 553.2061491759338, 554.1798138754666, 705.3651713457826, 5314.468553144655, 5315.388730296066, 5412.56699464042, 5425.511703946664, 5428.6199966002005, 8641.870371944426, 8907.0, 8920.24177944869, 8959.148880856308, 8975.865362019575, 8619.525926074, 8841.248493877963, 8850.822983540422, 8856.64573417069, 8939.240164585954, 6883.483738719616, 6891.173059232824, 6903.171619405603, 6971.337722916315, 6973.093497845248, 6384.808455746335, 6443.097966284818, 6491.350864913471, 6527.11883895687, 6531.608103513614, 7648.847023059397, 7845.882311765214, 7894.250046245597, 7914.920850791418, 7976.521408715495, 8002.51984880909, 8014.398920081134, 8049.678012879419, 8055.677772889018, 8174.754757357289, 6018.608790428608, 6026.849328766816, 6029.186059881859, 6062.0, 6077.149199112039, 6723.294054124247, 6872.965635171992, 7024.26245244242, 7061.929380706127, 7063.540869843444, 6319.494440444661, 6419.614823110628, 6504.1869766279215, 6506.219253689587, 6613.0, 6427.839304017437, 6453.0, 6458.580192287486, 6499.122618446449, 6564.934350656432, 6296.748130074929, 6505.8698826024165, 6514.54398192122, 6524.5432819704065, 6594.934050659624, 5999.0, 6070.7875224366935, 6071.817845464643, 6078.787242446493, 6085.2393450818645, 6082.878342433215, 6130.63216207029, 6158.199434073542, 6167.814965550861, 6184.690765461799], "unit": "score", "name": "mootools.html", "value": 4052.0991489105354}, {"lowerIsBetter": false, "replicates": [297.97914146009776, 304.14383510418173, 306.99999999999994, 308.1787037544943, 310.9471389863722, 5481.945180548193, 5638.238837756901, 5640.661560306379, 5665.490105890464, 5683.204351390804, 5417.187421886719, 5604.41153678864, 5607.495325420711, 5608.635438696492, 5629.099344104944, 4325.416068830699, 4331.631811296028, 4332.155229730204, 4337.848175313865, 4340.717853339539, 4328.718633288826, 4329.090890912912, 4339.717918335314, 4344.674149438789, 4347.043650396908, 4086.6322031017203, 4180.184863951531, 4310.331898555729, 4313.2451820931365, 4314.460692413449, 4157.792110394484, 4158.2307273154565, 4164.666826653891, 4188.350805625133, 4202.726822756511, 3609.6824658999276, 3614.548181477315, 3617.6382361763876, 3624.0577449863226, 3625.365561026836, 5251.159814429711, 5412.134058550613, 5423.430539793304, 5424.077906755861, 5440.347158341025, 4867.050925069613, 4879.0, 4885.975570122127, 4890.535399137077, 4896.1186986342445, 5900.616459930091, 5903.79336723217, 5915.1718759373725, 5922.230110085704, 5927.229460170193, 3877.2827027000094, 4015.5181378234797, 4030.9596904031173, 4033.0, 4038.374052021941, 6049.425304596057, 6182.629042257479, 6188.783392581283, 6189.814305570795, 6207.410296021916, 4122.299209134454, 4141.627253547135, 4167.041580436517, 4167.812448439767, 4179.26862799009, 4220.810063547086, 4225.176090662353, 4226.915461690811, 4233.724807887477, 4247.214265360918, 4694.342792009122, 4870.878228044327, 4871.464138944713, 4875.122477953932, 4877.341558889575, 5882.882342353129, 5883.441073098049, 5883.794067207713, 5889.676067816225, 5897.882042359129, 1468.6768910839598, 1495.2224843081538, 1497.0867770659888, 1497.2962707527445, 1497.9700405992037, 971.7279161834698, 994.9801003979879, 1001.6494227020485, 1002.013017178079, 1002.1932344462778, 5116.104681680691, 5120.641555091108, 5133.845984620468, 5138.126518491866, 5138.3833939927445, 6048.425399587032, 6099.573029887865, 6115.113308570232, 6121.4490695837585, 6123.846903827351, 5138.2806407103035, 5145.845624631267, 5146.176611742103, 5148.6910785353, 5158.45836187195, 3202.9359412811614, 3207.903762887117, 3236.838158092086, 3310.784798988058, 3317.2038710709257, 5682.374938756733, 5769.278840144982, 5781.739821708034, 5860.736266868002, 5861.41385861419, 6359.046143078575, 6363.0, 6365.49076073913, 6393.424591786668, 6394.71223794921, 5854.765809367577, 5855.560832937546, 5861.032929566659, 5865.589408741433, 5878.0, 6178.196834411498, 6182.969085154546, 6184.721687524162, 6200.3179650237535, 6214.9067763982675, 5831.79588714393, 6016.187814644967, 6040.879182416239, 6063.0, 6066.332703402534, 5807.0998995155815, 5830.76676932918, 5840.0, 5858.853528661817, 5861.267341582302, 4120.670346372223, 4147.813348399269, 4188.434561334181, 4191.11986482842, 4198.034452075978, 6020.729067192075, 6153.2000839890525, 6160.353162917829, 6167.383261673976, 6183.350748171377, 5868.67722275279, 5872.207252020922, 5917.993941030121, 5928.970355148197, 5938.732757025858, 5945.256842894638, 5956.285245770535, 5960.493358064613, 5963.91054134197, 5970.76116955317, 5623.268975033219, 5817.069268916953, 5822.563307752021, 5835.9708201458725, 5842.38654941242, 6010.068439391901, 6010.459058684739, 6014.766972770659, 6024.307204671343, 6035.939640603538, 5825.883482330414, 5848.502877255481, 5850.678212698343, 5855.414458554281, 5871.4715675589405], "unit": "score", "name": "prototype.html", "value": 4402.604019356054}, {"lowerIsBetter": false, "replicates": [744.6165224909173, 750.7259850154695, 776.798032511547, 780.839927814798, 806.0649646410166, 11656.417179141052, 11711.297322160677, 12018.939905300473, 12022.218555793866, 12047.518099276018, 11726.882731172685, 11839.585614503472, 11849.703757406069, 11922.582709605165, 11946.462409191585, 796.5340275938554, 810.1736229046369, 814.7881550796806, 818.1981657975188, 825.5088222507628, 813.0609146435846, 816.8162163513192, 819.778659761864, 823.127484866041, 823.3289868756974, 833.5790425834945, 841.5665932045001, 841.8232171244047, 842.4187310755559, 844.0588743550927, 830.3191383065888, 834.1866679986964, 834.5159807311744, 836.5148214035875, 837.811492414208, 618.279704144671, 621.5027977617933, 627.3632263252802, 628.4187126907592, 629.515273239603, 11177.441127943652, 11218.382988935606, 11279.887201128047, 11334.886651133465, 11339.546418143264, 10606.681799546026, 10904.291221070684, 10921.781564368748, 10979.890201097967, 11455.541778328858, 9037.412568183046, 9202.677906273248, 9313.720588382359, 9317.11487408695, 9403.717888463358, 3149.2599239178776, 3156.2425017995747, 3161.2254997525524, 3162.9683703162905, 3179.77741558091, 37725.81137094297, 38445.42331864996, 38524.0, 38539.42190867139, 38641.806790965864, 8834.514101724339, 9056.592453339616, 9061.95469022664, 9193.126652967958, 9210.907890921006, 15499.922500387425, 15566.22168891551, 15813.1302778346, 15818.525444236691, 15864.52406427809, 5963.970180149072, 5965.850853728604, 6174.0, 6253.093301471261, 6309.337519560472, 3427.7600567960003, 3449.6722811332884, 3463.631865413148, 3499.230169362736, 3506.8246587670515, 2503.8873250703764, 2504.8497090174646, 2516.446381796002, 2526.886290116949, 2533.949321013606, 467.43440437071524, 468.5642352612035, 472.9314249433813, 477.21974571575726, 478.0892399978047, 565.2877374508149, 584.3572070722172, 607.8601921558067, 615.2709039787866, 622.3745136138152, 7396.593187374746, 7541.5475071495885, 7662.118856331594, 7740.225977402328, 7812.648430820626, 441.5385921711819, 506.73902939985936, 585.7786515116031, 594.6609146498307, 607.113614123376, 3718.721095917817, 3750.7937063461227, 3828.5979972103087, 3919.627635374635, 3963.504561929759, 46478.76760616243, 47377.28934065992, 47517.28724069142, 47549.5245047552, 48172.7591362048, 40966.0, 41145.382819257735, 41385.586144138775, 41878.581214188074, 43224.13551728948, 38967.99999999943, 39474.0, 39808.0, 39810.60189398127, 40416.19167616631, 8126.918730812617, 8168.550729709923, 8214.178582141738, 8329.167083291622, 8549.658013679384, 29917.70082299149, 29998.700013000464, 30098.548521772627, 30146.0, 31309.53035704421, 39298.214035718556, 39573.2085358297, 39607.801960991164, 43452.78273608612, 44448.33327500025, 10541.947290263499, 10869.0, 11074.833877492005, 11143.777124457303, 11263.493142808757, 11278.943605281922, 11407.600733974272, 11555.942220288845, 11556.826647600461, 11643.767124657628, 10833.51249193804, 10919.0, 11043.834342484708, 11275.267107638305, 11628.534858605899, 10398.428086455318, 10788.892111078789, 10824.783504329711, 10928.289661171999, 11044.502997365298, 10671.786564268516, 11036.779264414827, 11084.833727493933, 11128.221024528206, 11364.090872729996, 9088.863667045132, 9291.581878815334, 9405.24758019343, 9428.95285523568, 9509.572069256761, 8642.567871606268, 8898.73303800887, 8952.820943580962, 8964.641414343354, 8969.416987895765], "unit": "score", "name": "yui.html", "value": 5711.4187636164115}], "name": "dromaeo_css", "value": 6371.966594263918}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 107.0, 114.0, 115.0, 118.0, 128.0, 115.0, 116.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 158.0, 165.0, 135.0, 161.0, 158.0, 140.0, 172.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 173.0, 165.0, 163.0, 164.0, 167.0, 163.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 72.0, 73.0, 140.0, 73.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 139.0, 95.0, 95.0, 94.0, 134.0, 94.0, 95.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 82.0, 74.0, 74.0, 77.0, 75.0, 73.0, 71.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 74.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 87.0, 85.0, 87.0, 86.0, 87.0, 96.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [121.0, 127.0, 137.0, 131.0, 127.0, 121.0, 129.0, 126.0, 126.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.4}, {"lowerIsBetter": true, "replicates": [139.0, 157.0, 154.0, 151.0, 153.0, 141.0, 152.0, 151.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 71.0, 72.0, 72.0, 70.0, 70.0, 71.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1547.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [185.97731076808628], "unit": "score", "name": "DeltaBlue", "value": 355.5164860000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [712.2507122507122], "unit": "score", "name": "Earley", "value": 935.7140519999998}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26973.684210526317], "unit": "score", "name": "RegExp", "value": 33.77310243902437}, {"lowerIsBetter": false, "replicates": [685.8710562414266], "unit": "score", "name": "Splay", "value": 118.81387800000003}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 20985.454177774427}]} 03:22:46 INFO - RETURN: dromaeo_css: 6371.97 03:22:46 INFO - RETURN: kraken: 1547.60 03:22:46 INFO - RETURN: v8_7: 20985.45 03:22:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20985.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6371.97"}}} 03:22:46 INFO - Return code: 0 03:22:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:22:47 INFO - # TBPL SUCCESS # 03:22:47 INFO - Running post-action listener: _resource_record_post_action 03:22:47 INFO - Running post-run listener: _resource_record_post_run 03:22:48 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 516292608; Read time: 240; Write time: 533684 03:22:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243478528; Read time: 0; Write time: 388764 03:22:48 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 272814080; Read time: 240; Write time: 144920 03:22:48 INFO - Running post-run listener: _upload_blobber_files 03:22:48 INFO - Blob upload gear active. 03:22:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:22:48 INFO - Copying logs to upload dir... 03:22:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.895039 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-17 03:22:47.212633) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:47.215888) ========= 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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010003 build_url: 'https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:47.267654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:47.268320) ========= 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=3cd289541638898829117e0a000001bd-1450346830.11201-2077122040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:47.319583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 03:22:47.319944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 03:22:47.320284) ========= ========= Total master_lag: 0.44 =========