builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1462871861.55 results: success (0) buildid: 20160510014205 builduid: 2b9ef505fdaf4b6dba114cbc4a6d89fd revision: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.551465) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.552072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.552504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.595753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.596046) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 02:17:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-05-10 02:17:42 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.758751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.759085) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017091 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.814525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 02:17:41.814904) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 --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 f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 --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=8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 02:17:42,624 truncating revision to first 12 chars 2016-05-10 02:17:42,624 Setting DEBUG logging. 2016-05-10 02:17:42,624 attempt 1/10 2016-05-10 02:17:42,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f612200731ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 02:17:43,888 unpacking tar archive at: fx-team-f612200731ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.539686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 02:17:43.370540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:43.370934) ========= script_repo_revision: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:43.371673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:43.372005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:43.383876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-10 02:17:43.384310) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:44 INFO - MultiFileLogger online at 20160510 02:17:44 in /builds/slave/test 02:17:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:17:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:44 INFO - {'append_to_log': False, 02:17:44 INFO - 'base_work_dir': '/builds/slave/test', 02:17:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:17:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:44 INFO - 'branch': 'Fx-Team-Non-PGO', 02:17:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:44 INFO - 'config_files': ('talos/linux_config.py',), 02:17:44 INFO - 'default_actions': ('clobber', 02:17:44 INFO - 'read-buildbot-config', 02:17:44 INFO - 'download-and-extract', 02:17:44 INFO - 'populate-webroot', 02:17:44 INFO - 'create-virtualenv', 02:17:44 INFO - 'install', 02:17:44 INFO - 'run-tests'), 02:17:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:44 INFO - 'download_minidump_stackwalk': True, 02:17:44 INFO - 'download_symbols': 'ondemand', 02:17:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:44 INFO - 'installer_path': 'installer.exe', 02:17:44 INFO - 'log_level': 'info', 02:17:44 INFO - 'log_name': 'talos', 02:17:44 INFO - 'log_to_console': True, 02:17:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:44 INFO - 'opt_config_files': (), 02:17:44 INFO - 'pip_index': False, 02:17:44 INFO - 'sps_profile': False, 02:17:44 INFO - 'sps_profile_interval': 0, 02:17:44 INFO - 'suite': 'dromaeojs-e10s', 02:17:44 INFO - 'system_bits': '32', 02:17:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:44 INFO - 'title': 'talos-linux64-ix-049', 02:17:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:44 INFO - 'use_talos_json': True, 02:17:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:44 INFO - 'work_dir': 'build'} 02:17:44 INFO - ##### 02:17:44 INFO - ##### Running clobber step. 02:17:44 INFO - ##### 02:17:44 INFO - Running pre-action listener: _resource_record_pre_action 02:17:44 INFO - Running main action method: clobber 02:17:44 INFO - rmtree: /builds/slave/test/build 02:17:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:44 INFO - Running post-action listener: _resource_record_post_action 02:17:44 INFO - ##### 02:17:44 INFO - ##### Finished clobber step (success) 02:17:44 INFO - ##### 02:17:44 INFO - ##### 02:17:44 INFO - ##### Running read-buildbot-config step. 02:17:44 INFO - ##### 02:17:44 INFO - Running pre-action listener: _resource_record_pre_action 02:17:44 INFO - Running main action method: read_buildbot_config 02:17:44 INFO - Using buildbot properties: 02:17:44 INFO - { 02:17:44 INFO - "project": "", 02:17:44 INFO - "product": "firefox", 02:17:44 INFO - "script_repo_revision": "production", 02:17:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:17:44 INFO - "repository": "", 02:17:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:17:44 INFO - "buildid": "20160510014205", 02:17:44 INFO - "pgo_build": "False", 02:17:44 INFO - "basedir": "/builds/slave/test", 02:17:44 INFO - "buildnumber": 1495, 02:17:44 INFO - "slavename": "talos-linux64-ix-049", 02:17:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:17:44 INFO - "platform": "ubuntu64_hw", 02:17:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:17:44 INFO - "branch": "fx-team", 02:17:44 INFO - "repo_path": "integration/fx-team", 02:17:44 INFO - "revision": "f612200731ad2e125e9ae23ecc4f4a6e7110d8d7", 02:17:44 INFO - "stage_platform": "linux64", 02:17:44 INFO - "builduid": "2b9ef505fdaf4b6dba114cbc4a6d89fd", 02:17:44 INFO - "slavebuilddir": "test" 02:17:44 INFO - } 02:17:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:17:44 INFO - Running post-action listener: _resource_record_post_action 02:17:44 INFO - ##### 02:17:44 INFO - ##### Finished read-buildbot-config step (success) 02:17:44 INFO - ##### 02:17:44 INFO - ##### 02:17:44 INFO - ##### Running download-and-extract step. 02:17:44 INFO - ##### 02:17:44 INFO - Running pre-action listener: _resource_record_pre_action 02:17:44 INFO - Running main action method: download_and_extract 02:17:44 INFO - mkdir: /builds/slave/test/build/tests 02:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:44 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:17:51 INFO - Downloaded 1361 bytes. 02:17:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:51 INFO - Using the following test package requirements: 02:17:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:17:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:17:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'jsshell-linux-x86_64.zip'], 02:17:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:17:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:17:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:17:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:17:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:17:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:51 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:17:57 INFO - Downloaded 22322863 bytes. 02:17:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:17:58 INFO - Return code: 0 02:17:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:58 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:17:59 INFO - Downloaded 22322863 bytes. 02:17:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:18:00 INFO - Return code: 0 02:18:00 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')]} 02:18:00 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:18:02 INFO - Downloaded 10840152 bytes. 02:18:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:18:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:18:02 INFO - Return code: 0 02:18:02 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')]} 02:18:02 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:18:06 INFO - Downloaded 54863255 bytes. 02:18:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:06 INFO - mkdir: /builds/slave/test/properties 02:18:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:18:06 INFO - Writing to file /builds/slave/test/properties/build_url 02:18:06 INFO - Contents: 02:18:06 INFO - build_url:https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:07 INFO - Running post-action listener: _resource_record_post_action 02:18:07 INFO - Running post-action listener: set_extra_try_arguments 02:18:07 INFO - ##### 02:18:07 INFO - ##### Finished download-and-extract step (success) 02:18:07 INFO - ##### 02:18:07 INFO - ##### 02:18:07 INFO - ##### Running populate-webroot step. 02:18:07 INFO - ##### 02:18:07 INFO - Running pre-action listener: _resource_record_pre_action 02:18:07 INFO - Running main action method: populate_webroot 02:18:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:18:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:18:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:18:07 INFO - '--tppagecycles', 02:18:07 INFO - '7'], 02:18:07 INFO - 'tests': ['tsvgm']}}, 02:18:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:18:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:18:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:18:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:18:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['damp', 'tps']}, 02:18:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'tests': ['damp', 'tps']}, 02:18:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['dromaeo_dom']}, 02:18:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:18:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['a11yr', 02:18:07 INFO - 'ts_paint', 02:18:07 INFO - 'tpaint', 02:18:07 INFO - 'sessionrestore', 02:18:07 INFO - 'sessionrestore_no_auto_restore', 02:18:07 INFO - 'tabpaint']}, 02:18:07 INFO - 'other-e10s': {'tests': ['a11yr', 02:18:07 INFO - 'ts_paint', 02:18:07 INFO - 'tpaint', 02:18:07 INFO - 'sessionrestore', 02:18:07 INFO - 'sessionrestore_no_auto_restore', 02:18:07 INFO - 'tabpaint']}, 02:18:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:18:07 INFO - 'ts_paint', 02:18:07 INFO - 'tpaint', 02:18:07 INFO - 'sessionrestore', 02:18:07 INFO - 'sessionrestore_no_auto_restore', 02:18:07 INFO - 'tabpaint']}, 02:18:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:18:07 INFO - 'ts_paint', 02:18:07 INFO - 'tpaint', 02:18:07 INFO - 'sessionrestore', 02:18:07 INFO - 'sessionrestore_no_auto_restore', 02:18:07 INFO - 'tabpaint']}, 02:18:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['a11yr', 02:18:07 INFO - 'ts_paint', 02:18:07 INFO - 'tpaint', 02:18:07 INFO - 'sessionrestore', 02:18:07 INFO - 'sessionrestore_no_auto_restore', 02:18:07 INFO - 'tabpaint']}, 02:18:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['a11yr', 02:18:07 INFO - 'ts_paint', 02:18:07 INFO - 'tpaint', 02:18:07 INFO - 'sessionrestore', 02:18:07 INFO - 'sessionrestore_no_auto_restore', 02:18:07 INFO - 'tabpaint']}, 02:18:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['tsvgx', 02:18:07 INFO - 'tsvgr_opacity', 02:18:07 INFO - 'tart', 02:18:07 INFO - 'tscrollx', 02:18:07 INFO - 'cart']}, 02:18:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:18:07 INFO - 'tsvgr_opacity', 02:18:07 INFO - 'tart', 02:18:07 INFO - 'tscrollx', 02:18:07 INFO - 'cart']}, 02:18:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'talos_options': ['--disable-e10s'], 02:18:07 INFO - 'tests': ['tp5o']}, 02:18:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'tests': ['tp5o']}, 02:18:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'talos_options': ['--disable-e10s', 02:18:07 INFO - '--xperf_path', 02:18:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:07 INFO - 'tests': ['tp5n']}, 02:18:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:07 INFO - 'talos_options': ['--xperf_path', 02:18:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:07 INFO - 'tests': ['tp5n']}}, 02:18:07 INFO - 'talos.zip': {'path': '', 02:18:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:18:07 INFO - Running post-action listener: _resource_record_post_action 02:18:07 INFO - ##### 02:18:07 INFO - ##### Finished populate-webroot step (success) 02:18:07 INFO - ##### 02:18:07 INFO - ##### 02:18:07 INFO - ##### Running create-virtualenv step. 02:18:07 INFO - ##### 02:18:07 INFO - Running pre-action listener: _resource_record_pre_action 02:18:07 INFO - Running main action method: create_virtualenv 02:18:07 INFO - Creating virtualenv /builds/slave/test/build/venv 02:18:07 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 02:18:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:18:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:18:07 INFO - Using real prefix '/usr' 02:18:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:18:08 INFO - Installing distribute.............................................................................................................................................................................................done. 02:18:10 INFO - Installing pip.................done. 02:18:10 INFO - Return code: 0 02:18:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:18:10 INFO - Using env: {'DISPLAY': ':0', 02:18:10 INFO - 'HOME': '/home/cltbld', 02:18:10 INFO - 'LANG': 'en_US.UTF-8', 02:18:10 INFO - 'LANGUAGE': 'en_US:en', 02:18:10 INFO - 'LOGNAME': 'cltbld', 02:18:10 INFO - 'MAIL': '/var/mail/cltbld', 02:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:10 INFO - 'MOZ_NO_REMOTE': '1', 02:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:10 INFO - 'NO_EM_RESTART': '1', 02:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:10 INFO - 'PWD': '/builds/slave/test', 02:18:10 INFO - 'SHELL': '/bin/bash', 02:18:10 INFO - 'SHLVL': '1', 02:18:10 INFO - 'TERM': 'linux', 02:18:10 INFO - 'TMOUT': '86400', 02:18:10 INFO - 'USER': 'cltbld', 02:18:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:10 INFO - '_': '/tools/buildbot/bin/python'} 02:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:10 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 02:18:10 INFO - Cleaning up... 02:18:10 INFO - Return code: 0 02:18:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:18:10 INFO - Using env: {'DISPLAY': ':0', 02:18:10 INFO - 'HOME': '/home/cltbld', 02:18:10 INFO - 'LANG': 'en_US.UTF-8', 02:18:10 INFO - 'LANGUAGE': 'en_US:en', 02:18:10 INFO - 'LOGNAME': 'cltbld', 02:18:10 INFO - 'MAIL': '/var/mail/cltbld', 02:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:10 INFO - 'MOZ_NO_REMOTE': '1', 02:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:10 INFO - 'NO_EM_RESTART': '1', 02:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:10 INFO - 'PWD': '/builds/slave/test', 02:18:10 INFO - 'SHELL': '/bin/bash', 02:18:10 INFO - 'SHLVL': '1', 02:18:10 INFO - 'TERM': 'linux', 02:18:10 INFO - 'TMOUT': '86400', 02:18:10 INFO - 'USER': 'cltbld', 02:18:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:10 INFO - '_': '/tools/buildbot/bin/python'} 02:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:10 INFO - Downloading/unpacking psutil>=0.7.1 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:18:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:12 INFO - Installing collected packages: psutil 02:18:12 INFO - Running setup.py install for psutil 02:18:12 INFO - building 'psutil._psutil_linux' extension 02:18:12 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 02:18:12 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 02:18:12 INFO - building 'psutil._psutil_posix' extension 02:18:12 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 02:18:13 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 02:18:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:13 INFO - Successfully installed psutil 02:18:13 INFO - Cleaning up... 02:18:13 INFO - Return code: 0 02:18:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:18:13 INFO - Using env: {'DISPLAY': ':0', 02:18:13 INFO - 'HOME': '/home/cltbld', 02:18:13 INFO - 'LANG': 'en_US.UTF-8', 02:18:13 INFO - 'LANGUAGE': 'en_US:en', 02:18:13 INFO - 'LOGNAME': 'cltbld', 02:18:13 INFO - 'MAIL': '/var/mail/cltbld', 02:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:13 INFO - 'MOZ_NO_REMOTE': '1', 02:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:13 INFO - 'NO_EM_RESTART': '1', 02:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:13 INFO - 'PWD': '/builds/slave/test', 02:18:13 INFO - 'SHELL': '/bin/bash', 02:18:13 INFO - 'SHLVL': '1', 02:18:13 INFO - 'TERM': 'linux', 02:18:13 INFO - 'TMOUT': '86400', 02:18:13 INFO - 'USER': 'cltbld', 02:18:13 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:13 INFO - '_': '/tools/buildbot/bin/python'} 02:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:18:13 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 02:18:13 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 02:18:13 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 02:18:13 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 02:18:13 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 02:18:13 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 02:18:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:18:15 INFO - Installing collected packages: mozsystemmonitor 02:18:15 INFO - Running setup.py install for mozsystemmonitor 02:18:15 INFO - Successfully installed mozsystemmonitor 02:18:15 INFO - Cleaning up... 02:18:15 INFO - Return code: 0 02:18:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:18:15 INFO - Using env: {'DISPLAY': ':0', 02:18:15 INFO - 'HOME': '/home/cltbld', 02:18:15 INFO - 'LANG': 'en_US.UTF-8', 02:18:15 INFO - 'LANGUAGE': 'en_US:en', 02:18:15 INFO - 'LOGNAME': 'cltbld', 02:18:15 INFO - 'MAIL': '/var/mail/cltbld', 02:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:15 INFO - 'MOZ_NO_REMOTE': '1', 02:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:15 INFO - 'NO_EM_RESTART': '1', 02:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:15 INFO - 'PWD': '/builds/slave/test', 02:18:15 INFO - 'SHELL': '/bin/bash', 02:18:15 INFO - 'SHLVL': '1', 02:18:15 INFO - 'TERM': 'linux', 02:18:15 INFO - 'TMOUT': '86400', 02:18:15 INFO - 'USER': 'cltbld', 02:18:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:15 INFO - '_': '/tools/buildbot/bin/python'} 02:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:18:15 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 02:18:15 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 02:18:15 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 02:18:15 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 02:18:15 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 02:18:15 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 02:18:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:18:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:18:17 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 02:18:17 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 02:18:17 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 02:18:17 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 02:18:17 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 02:18:17 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 02:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 INFO - Downloading docopt-0.6.1.tar.gz 02:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:18 INFO - Running setup.py install for blobuploader 02:18:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:18 INFO - Running setup.py install for requests 02:18:18 INFO - Running setup.py install for docopt 02:18:18 INFO - Successfully installed blobuploader requests docopt 02:18:18 INFO - Cleaning up... 02:18:18 INFO - Return code: 0 02:18:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:18:18 INFO - Using env: {'DISPLAY': ':0', 02:18:18 INFO - 'HOME': '/home/cltbld', 02:18:18 INFO - 'LANG': 'en_US.UTF-8', 02:18:18 INFO - 'LANGUAGE': 'en_US:en', 02:18:18 INFO - 'LOGNAME': 'cltbld', 02:18:18 INFO - 'MAIL': '/var/mail/cltbld', 02:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:18 INFO - 'MOZ_NO_REMOTE': '1', 02:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:18 INFO - 'NO_EM_RESTART': '1', 02:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:18 INFO - 'PWD': '/builds/slave/test', 02:18:18 INFO - 'SHELL': '/bin/bash', 02:18:18 INFO - 'SHLVL': '1', 02:18:18 INFO - 'TERM': 'linux', 02:18:18 INFO - 'TMOUT': '86400', 02:18:18 INFO - 'USER': 'cltbld', 02:18:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:18 INFO - '_': '/tools/buildbot/bin/python'} 02:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:19 INFO - Running setup.py (path:/tmp/pip-GstZx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:19 INFO - Running setup.py (path:/tmp/pip-E4E2UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:19 INFO - Running setup.py (path:/tmp/pip-Gzq0ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:19 INFO - Running setup.py (path:/tmp/pip-2v3116-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:19 INFO - Running setup.py (path:/tmp/pip-Uznjyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:19 INFO - Running setup.py (path:/tmp/pip-PSajDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:19 INFO - Running setup.py (path:/tmp/pip-081KTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:19 INFO - Running setup.py (path:/tmp/pip-8UU9xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:19 INFO - Running setup.py (path:/tmp/pip-19lTZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:19 INFO - Running setup.py (path:/tmp/pip-TiOfZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:19 INFO - Running setup.py (path:/tmp/pip-jhYmaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:19 INFO - Running setup.py (path:/tmp/pip-2rGKXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:20 INFO - Running setup.py (path:/tmp/pip-18CMYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:20 INFO - Running setup.py (path:/tmp/pip-Ddm700-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:20 INFO - Running setup.py (path:/tmp/pip-wXp_5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:20 INFO - Running setup.py (path:/tmp/pip-5Anaet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:20 INFO - Running setup.py (path:/tmp/pip-PTiVEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:20 INFO - Running setup.py install for manifestparser 02:18:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Running setup.py install for mozcrash 02:18:20 INFO - Running setup.py install for mozdebug 02:18:20 INFO - Running setup.py install for mozdevice 02:18:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Running setup.py install for mozfile 02:18:20 INFO - Running setup.py install for mozhttpd 02:18:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozinfo 02:18:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozInstall 02:18:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozleak 02:18:21 INFO - Running setup.py install for mozlog 02:18:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for moznetwork 02:18:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozprocess 02:18:21 INFO - Running setup.py install for mozprofile 02:18:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozrunner 02:18:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozscreenshot 02:18:21 INFO - Running setup.py install for moztest 02:18:22 INFO - Running setup.py install for mozversion 02:18:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:22 INFO - Cleaning up... 02:18:22 INFO - Return code: 0 02:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:22 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')]} 02:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:22 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')]} 02:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:18:22 INFO - Using env: {'DISPLAY': ':0', 02:18:22 INFO - 'HOME': '/home/cltbld', 02:18:22 INFO - 'LANG': 'en_US.UTF-8', 02:18:22 INFO - 'LANGUAGE': 'en_US:en', 02:18:22 INFO - 'LOGNAME': 'cltbld', 02:18:22 INFO - 'MAIL': '/var/mail/cltbld', 02:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:22 INFO - 'MOZ_NO_REMOTE': '1', 02:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:22 INFO - 'NO_EM_RESTART': '1', 02:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:22 INFO - 'PWD': '/builds/slave/test', 02:18:22 INFO - 'SHELL': '/bin/bash', 02:18:22 INFO - 'SHLVL': '1', 02:18:22 INFO - 'TERM': 'linux', 02:18:22 INFO - 'TMOUT': '86400', 02:18:22 INFO - 'USER': 'cltbld', 02:18:22 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:22 INFO - '_': '/tools/buildbot/bin/python'} 02:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:22 INFO - Running setup.py (path:/tmp/pip-1ZEz5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:22 INFO - Running setup.py (path:/tmp/pip-cCIztw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:22 INFO - Running setup.py (path:/tmp/pip-Vuu30B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:22 INFO - Running setup.py (path:/tmp/pip-_q8Lk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:22 INFO - Running setup.py (path:/tmp/pip-IfNMQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:22 INFO - Running setup.py (path:/tmp/pip-s4Fbm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:22 INFO - Running setup.py (path:/tmp/pip-tU0aHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:22 INFO - Running setup.py (path:/tmp/pip-QDNCZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:22 INFO - Running setup.py (path:/tmp/pip-29gd7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:23 INFO - Running setup.py (path:/tmp/pip-vgPbjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:23 INFO - Running setup.py (path:/tmp/pip-kmztFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:23 INFO - Running setup.py (path:/tmp/pip-15PsIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:23 INFO - Running setup.py (path:/tmp/pip-FhH9rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:23 INFO - Running setup.py (path:/tmp/pip-h_nH0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:23 INFO - Running setup.py (path:/tmp/pip-XNKUAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:23 INFO - Running setup.py (path:/tmp/pip-5TnKbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:23 INFO - Running setup.py (path:/tmp/pip-cRRE60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:23 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)) 02:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:23 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)) 02:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18:23 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 02:18:23 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 02:18:23 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 02:18:23 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 02:18:23 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 02:18:23 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 02:18:25 INFO - Downloading blessings-1.6.tar.gz 02:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:25 INFO - Installing collected packages: blessings 02:18:25 INFO - Running setup.py install for blessings 02:18:25 INFO - Successfully installed blessings 02:18:25 INFO - Cleaning up... 02:18:25 INFO - Return code: 0 02:18:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:25 INFO - Reading from file tmpfile_stdout 02:18:25 INFO - Current package versions: 02:18:25 INFO - argparse == 1.2.1 02:18:25 INFO - blessings == 1.6 02:18:25 INFO - blobuploader == 1.2.4 02:18:25 INFO - docopt == 0.6.1 02:18:25 INFO - manifestparser == 1.1 02:18:25 INFO - mozInstall == 1.12 02:18:25 INFO - mozcrash == 0.17 02:18:25 INFO - mozdebug == 0.1 02:18:25 INFO - mozdevice == 0.48 02:18:25 INFO - mozfile == 1.2 02:18:25 INFO - mozhttpd == 0.7 02:18:25 INFO - mozinfo == 0.9 02:18:25 INFO - mozleak == 0.1 02:18:25 INFO - mozlog == 3.1 02:18:25 INFO - moznetwork == 0.27 02:18:25 INFO - mozprocess == 0.22 02:18:25 INFO - mozprofile == 0.28 02:18:25 INFO - mozrunner == 6.11 02:18:25 INFO - mozscreenshot == 0.1 02:18:25 INFO - mozsystemmonitor == 0.0 02:18:25 INFO - moztest == 0.7 02:18:25 INFO - mozversion == 1.4 02:18:25 INFO - psutil == 3.1.1 02:18:25 INFO - requests == 1.2.3 02:18:25 INFO - wsgiref == 0.1.2 02:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:18:25 INFO - Using env: {'DISPLAY': ':0', 02:18:25 INFO - 'HOME': '/home/cltbld', 02:18:25 INFO - 'LANG': 'en_US.UTF-8', 02:18:25 INFO - 'LANGUAGE': 'en_US:en', 02:18:25 INFO - 'LOGNAME': 'cltbld', 02:18:25 INFO - 'MAIL': '/var/mail/cltbld', 02:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:25 INFO - 'MOZ_NO_REMOTE': '1', 02:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:25 INFO - 'NO_EM_RESTART': '1', 02:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:25 INFO - 'PWD': '/builds/slave/test', 02:18:25 INFO - 'SHELL': '/bin/bash', 02:18:25 INFO - 'SHLVL': '1', 02:18:25 INFO - 'TERM': 'linux', 02:18:25 INFO - 'TMOUT': '86400', 02:18:25 INFO - 'USER': 'cltbld', 02:18:25 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:25 INFO - '_': '/tools/buildbot/bin/python'} 02:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:18:26 INFO - Cleaning up... 02:18:26 INFO - Return code: 0 02:18:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:18:26 INFO - Using env: {'DISPLAY': ':0', 02:18:26 INFO - 'HOME': '/home/cltbld', 02:18:26 INFO - 'LANG': 'en_US.UTF-8', 02:18:26 INFO - 'LANGUAGE': 'en_US:en', 02:18:26 INFO - 'LOGNAME': 'cltbld', 02:18:26 INFO - 'MAIL': '/var/mail/cltbld', 02:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:26 INFO - 'MOZ_NO_REMOTE': '1', 02:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:26 INFO - 'NO_EM_RESTART': '1', 02:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:26 INFO - 'PWD': '/builds/slave/test', 02:18:26 INFO - 'SHELL': '/bin/bash', 02:18:26 INFO - 'SHLVL': '1', 02:18:26 INFO - 'TERM': 'linux', 02:18:26 INFO - 'TMOUT': '86400', 02:18:26 INFO - 'USER': 'cltbld', 02:18:26 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:26 INFO - '_': '/tools/buildbot/bin/python'} 02:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:26 INFO - Downloading/unpacking jsonschema 02:18:26 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 02:18:26 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 02:18:26 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 02:18:26 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 02:18:26 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 02:18:26 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 02:18:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:28 INFO - Downloading/unpacking functools32 (from jsonschema) 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:28 INFO - warning: no files found matching '*.txt' 02:18:28 INFO - no previously-included directories found matching 'build' 02:18:28 INFO - no previously-included directories found matching 'dist' 02:18:28 INFO - no previously-included directories found matching '.git*' 02:18:28 INFO - Installing collected packages: jsonschema, functools32 02:18:28 INFO - Running setup.py install for functools32 02:18:28 INFO - warning: no files found matching '*.txt' 02:18:28 INFO - no previously-included directories found matching 'build' 02:18:28 INFO - no previously-included directories found matching 'dist' 02:18:28 INFO - no previously-included directories found matching '.git*' 02:18:28 INFO - Successfully installed jsonschema functools32 02:18:28 INFO - Cleaning up... 02:18:28 INFO - Return code: 0 02:18:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff00e368f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', '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 02:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:18:28 INFO - Using env: {'DISPLAY': ':0', 02:18:28 INFO - 'HOME': '/home/cltbld', 02:18:28 INFO - 'LANG': 'en_US.UTF-8', 02:18:28 INFO - 'LANGUAGE': 'en_US:en', 02:18:28 INFO - 'LOGNAME': 'cltbld', 02:18:28 INFO - 'MAIL': '/var/mail/cltbld', 02:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:28 INFO - 'MOZ_NO_REMOTE': '1', 02:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:28 INFO - 'NO_EM_RESTART': '1', 02:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:28 INFO - 'PWD': '/builds/slave/test', 02:18:28 INFO - 'SHELL': '/bin/bash', 02:18:28 INFO - 'SHLVL': '1', 02:18:28 INFO - 'TERM': 'linux', 02:18:28 INFO - 'TMOUT': '86400', 02:18:28 INFO - 'USER': 'cltbld', 02:18:28 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:28 INFO - '_': '/tools/buildbot/bin/python'} 02:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:29 INFO - Downloading/unpacking flake8 02:18:29 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 02:18:29 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 02:18:29 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 02:18:29 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 02:18:29 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 02:18:29 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 02:18:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:18:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:18:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:18:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:31 INFO - no previously-included directories found matching 'docs/_build' 02:18:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:18:31 INFO - Running setup.py install for pep8 02:18:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:31 INFO - no previously-included directories found matching 'docs/_build' 02:18:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:18:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:18:31 INFO - Cleaning up... 02:18:31 INFO - Return code: 0 02:18:31 INFO - Running post-action listener: _resource_record_post_action 02:18:31 INFO - Running post-action listener: _start_resource_monitoring 02:18:31 INFO - Starting resource monitoring. 02:18:31 INFO - ##### 02:18:31 INFO - ##### Finished create-virtualenv step (success) 02:18:31 INFO - ##### 02:18:31 INFO - ##### 02:18:31 INFO - ##### Running install step. 02:18:31 INFO - ##### 02:18:31 INFO - Running pre-action listener: _resource_record_pre_action 02:18:31 INFO - Running main action method: install 02:18:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:32 INFO - Reading from file tmpfile_stdout 02:18:32 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:32 INFO - Reading from file tmpfile_stdout 02:18:32 INFO - Output received: 02:18:32 INFO - Usage: mozinstall [options] installer 02:18:32 INFO - Options: 02:18:32 INFO - -h, --help show this help message and exit 02:18:32 INFO - -d DEST, --destination=DEST 02:18:32 INFO - Directory to install application into. [default: 02:18:32 INFO - "/builds/slave/test"] 02:18:32 INFO - --app=APP Application being installed. [default: firefox] 02:18:32 INFO - mkdir: /builds/slave/test/build/application 02:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:18:47 INFO - Reading from file tmpfile_stdout 02:18:47 INFO - Output received: 02:18:47 INFO - /builds/slave/test/build/application/firefox/firefox 02:18:47 INFO - Running post-action listener: _resource_record_post_action 02:18:48 INFO - ##### 02:18:48 INFO - ##### Finished install step (success) 02:18:48 INFO - ##### 02:18:48 INFO - ##### 02:18:48 INFO - ##### Running run-tests step. 02:18:48 INFO - ##### 02:18:48 INFO - Running pre-action listener: _resource_record_pre_action 02:18:48 INFO - Running main action method: run_tests 02:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:18:48 INFO - Python 2.7.3 02:18:48 INFO - Return code: 0 02:18:48 INFO - grabbing minidump binary from tooltool 02:18: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')]} 02:18:48 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 0x13779c0>, '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 0x13788c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1378d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:18:48 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 02:18:48 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 02:18:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:18:48 INFO - Return code: 0 02:18:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:18:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:18:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:18:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:18:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:18:48 INFO - Return code: 0 02:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:18:48 INFO - Using env: {'DISPLAY': ':0', 02:18:48 INFO - 'HOME': '/home/cltbld', 02:18:48 INFO - 'LANG': 'en_US.UTF-8', 02:18:48 INFO - 'LANGUAGE': 'en_US:en', 02:18:48 INFO - 'LOGNAME': 'cltbld', 02:18:48 INFO - 'MAIL': '/var/mail/cltbld', 02:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:48 INFO - 'MOZ_NO_REMOTE': '1', 02:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:48 INFO - 'NO_EM_RESTART': '1', 02:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:48 INFO - 'PWD': '/builds/slave/test', 02:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:48 INFO - 'SHELL': '/bin/bash', 02:18:48 INFO - 'SHLVL': '1', 02:18:48 INFO - 'TERM': 'linux', 02:18:48 INFO - 'TMOUT': '86400', 02:18:48 INFO - 'USER': 'cltbld', 02:18:48 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958', 02:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:48 INFO - '_': '/tools/buildbot/bin/python'} 02:18:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:18:49 INFO - mozversion application_buildid: 20160510014205 02:18:49 INFO - mozversion application_changeset: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 02:18:49 INFO - mozversion application_display_name: Nightly 02:18:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:18:49 INFO - mozversion application_name: Firefox 02:18:49 INFO - mozversion application_remotingname: firefox 02:18:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:18:49 INFO - mozversion application_vendor: Mozilla 02:18:49 INFO - mozversion application_version: 49.0a1 02:18:49 INFO - mozversion platform_buildid: 20160510014205 02:18:49 INFO - mozversion platform_changeset: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 02:18:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:18:49 INFO - mozversion platform_version: 49.0a1 02:18:49 INFO - using testdate: 1462871929 02:18:49 INFO - actual date: 1462871929 02:18:49 INFO - starting webserver on 'localhost:48775' 02:18:49 INFO - SUITE-START | Running 2 tests 02:18:49 INFO - TEST-START | dromaeo_css 02:18:49 INFO - operating with platform_type : linux_ 02:18:49 INFO - Initialising browser for dromaeo_css test... 02:18:49 INFO - TEST-INFO | started process 3387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxrahH/profile http://localhost:48775/getInfo.html) 02:18:52 INFO - PROCESS | 3387 | 02:18:52 INFO - PROCESS | 3387 | (process:3454): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:18:53 INFO - PROCESS | 3387 | __metrics Screen width/height:1600/1200 02:18:53 INFO - PROCESS | 3387 | colorDepth:24 02:18:53 INFO - PROCESS | 3387 | Browser inner width/height: 1024/697 02:18:53 INFO - PROCESS | 3387 | __metrics 02:18:54 ERROR - PROCESS | 3387 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 02:18:55 INFO - TEST-INFO | 3387: exit 0 02:18:55 INFO - Browser initialized. 02:18:55 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:55 INFO - TEST-INFO | started process 3505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxrahH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:57 INFO - PROCESS | 3505 | 02:18:57 INFO - PROCESS | 3505 | (process:3567): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:19:07 INFO - PROCESS | 3505 | RSS: Main: 164159488 02:19:07 INFO - PROCESS | 3505 | 02:19:57 INFO - PROCESS | 3505 | 1462871997274 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] 02:22:08 INFO - PROCESS | 3505 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48775/tests/dromaeo/cssquery-ext.html) 02:22:09 INFO - PROCESS | 3505 | RSS: Main: 166596608 02:22:09 INFO - PROCESS | 3505 | 02:25:11 INFO - PROCESS | 3505 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-ext.html (next: http://localhost:48775/tests/dromaeo/cssquery-jquery.html) 02:25:12 INFO - PROCESS | 3505 | RSS: Main: 167018496 02:25:12 INFO - PROCESS | 3505 | 02:28:14 INFO - PROCESS | 3505 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48775/tests/dromaeo/cssquery-mootools.html) 02:28:15 INFO - PROCESS | 3505 | RSS: Main: 166891520 02:28:15 INFO - PROCESS | 3505 | 02:31:17 INFO - PROCESS | 3505 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48775/tests/dromaeo/cssquery-prototype.html) 02:31:17 INFO - PROCESS | 3505 | RSS: Main: 165507072 02:31:17 INFO - PROCESS | 3505 | 02:34:20 INFO - PROCESS | 3505 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48775/tests/dromaeo/cssquery-yui.html) 02:34:21 INFO - PROCESS | 3505 | RSS: Main: 165888000 02:34:21 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-yui.html (next: http://localhost:48775/tests/dromaeo/cssquery-dojo.html) 02:37:23 INFO - PROCESS | 3505 | RSS: Main: 167288832 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | __start_tp_report 02:37:23 INFO - PROCESS | 3505 | _x_x_mozilla_page_load 02:37:23 INFO - PROCESS | 3505 | _x_x_mozilla_page_load_details 02:37:23 INFO - PROCESS | 3505 | |i|pagename|runs| 02:37:23 INFO - PROCESS | 3505 | |0;dojo.html;2647.060293595773;2681.222445490808;2685.95971060434;2690.6502154719883;2696.487667343206;4600.217962946303;4629.8148074077035;4683.953160468394;4745.833895813647;4770.379850619414;4659.836905708301;4827;4843.104025755238;4874.805007799684;4879.3656824612835;4430.822767089313;4446.133004064209;4576.931346029795;4578.97710511447;4599.586037256646;482.49923438138023;4311.439512863323;4344.044310251739;4432.180046691373;4473.888152796174;4387.4296341475565;4403.339499075132;4417.447819022622;4441.111777644452;4507.887302817423;4481.551844815493;4486.192485352635;4493.370928070073;4497.168023915586;4534.433195850519;4298.032942587924;4405.8237670493145;4463.375127482155;4466.196084704752;4485.887852803673;4689.8358557450665;4745.572898439123;4747;4748.145333839908;4759.547842954914;5197.376314842243;5214.348206474191;5224.582033437354;5224.634275600672;5260.500252476008;5073.492650734934;5170.922436163461;5192.1952097424955;5227.50338717825;5253.238280449352;4894.143524883167;4916.852494425173;4922.680025798311;4922.8769280768265;4959.950400495985;5350.51845333914;5353.491418315254;5354.866128346823;5383.5423988961375;5404.189371594292;4942.777575009061;5068.4424713281505;5104.055749686246;5127.179651255781;5160.148575485078;5236.476352364809;5243.030039442715;5261.631685782035;5262.10544207478;5270.683758974397;5194.246834209019;5198.012377648235;5199.272101905736;5200.245964335226;5251.921221181686;4915.336429581961;5125.692458452505;5152.3044389007;5177.430482646906;5186.325777648957;4442.089371678798;4467.86596402102;4484.39460672805;4490.663200259994;4517.638588912879;3769.9434508482395;3893.3965235387996;3913;3930.1746633206776;3949;4283.1005488847695;4405.867823965286;4423.380726698265;4444.133393988206;4492.101579684077;5229.47705229474;5255.894882102413;5265.473452654781;5277.8416647500635;5290.391604965478;4329;4448.221561226773;4469.08383781324;4484.910301793946;4508.030773383673;4693.5775780179265;4712.03403302329;4732.976335118303;4733.5266473352385;4755.904881902343;4847.248676455155;4915.557599816034;4917.311576379381;4935;4996.925046124311;5007.924881126859;5080.364954380702;5243.868903277296;5258.158694608845;5321.7073060980465;4828.975855120702;4835.20219163834;4861.027794441055;4865.878353041061;4920.778564964657;5090.567301779242;5092.388913330424;5102.209157580581;5114.411842638145;5168.966206758739;5015.949840501548;5068.797248110034;5155.072087024371;5184.714840683799;5195.064888320138;4990.6506544541535;5023.045621331935;5024.748762561931;5025.824096156617;5065.898682026413;4999.800007999639;5027.522385373383;5040.672356296829;5041.571466425395;5049.469805670498;4809.495003024632;4953.18272485036;4961.007798440254;4997.100521906092;5037.96721672049;5118.923216151835;5133.3326667534475;5160.277561141518;5168.560672342893;5169.431362550192;5039.84880453587;5042.042012017705;5043.722595257149;5055.7472126392795;5090.261912022662 02:37:23 INFO - PROCESS | 3505 | |1;ext.html;578.8379253808935;604.5586721693164;611.2390074357426;616.3713012727019;631.5484428633526;36283.81858090709;40146.39780403289;40348.19303613926;40381;40455.59544404555;40849.387259191135;41079.794601027024;41119.79440102795;41425.378619320734;41547;7784.922150778476;7867.6459559319965;7882.645280962371;7903.881441778378;7914;7719.150893401721;7727.72952946647;7781.144074151867;7793.2596403341595;7819.218078192163;7845.058592968823;7877.842443151134;7878.1334053254095;7880;7883.448158628898;7818.06183258007;7833.295003449717;7836;7837.059552853637;7838.568878711669;7664.73173438927;7761.650725717356;7768.223177682243;7770.067591888953;7793.688252469894;29261.70738292611;36871.262574748354;37606.43590346147;37622.623773762185;37660.05849853748;3079.9230019249476;3118.2672072063046;3279.212988882675;3691.187938653492;3851.499305090348;27607.585886211724;28092.43815123686;28192.295192620142;29020.564691529646;29161.708382916113;3367.9494807577908;3377.662233776627;3432.7253819694365;3454.9117028136056;3467.1678797088516;213237;214164;214475.92762036246;216319;216988;33085;33443.49834752481;33457.665423345454;33500.66499335024;33939;33359.49960750591;35329.8233508836;35537.64462355343;35627.82186089105;35779;12163.878361216275;12275.202111862878;12281.93859030699;12285.69285767863;12303.138780285473;9836;9977.800443991226;9978.650747223957;10063.19494440443;10076.3954162749;8271.296939760068;8289.544075075808;8311.459755115899;8325.875111873327;8398.790030249293;3246.204679853451;3305.9008229753144;3313.519539666735;3335.1328654549507;3350.765446418727;939.1125386509683;973.6786860336072;994.4977786217913;1021.2646894236138;1066.2802608239408;28838.134855954355;29318.976102767563;29413.26466838346;29427.411451770844;29713.25716857096;988.6391467114452;1020.637673625867;1040.7606250562412;1046.842973553973;1060.9681709548727;15358.923205383902;15580.766288505682;15721.044888871318;15722.685546289238;15742.449014284444;371021;371691;375801;376549;377365;49589.75205124023;50711.239331410055;51081.74459127755;51226.487735122915;51281.48718512842;1240.0637518673343;1243.359669770069;1259.106034715344;1270.7204415028864;1276.6744480157686;26780.330491737863;27694.04578015736;28265.858670706515;28432;28471.572926406534;43273;43533;43558.34662480002;43710.344344834215;43714.56285437105;311785;311856;312152;314659;314809;25092.99628014932;25620.743792561836;25651.486970260863;25698.743012570383;25713.35716607025;41089.38365924573;42567;43299.7835010823;43552;44378;36142;36942.815285923396;37003.629963701096;37564;37566.43650345302;37060;37495.25009499849;37932.43101353427;38155.618443815205;38804;37483.625163748016;38320.80839595784;39054;39233.803830980665;41869.58130418657;31162.68837311598;33482.330353393285;34192.82903585466;34654.653453465144;34689.30621387609;25887.61168582435;25963.350916227246;26381.604275935493;26428.73571264263;26663.600045999712 02:37:23 INFO - PROCESS | 3505 | |2;jquery.html;376.71369758983167;378.84467368378967;388.34563760064293;388.7997681194184;401.9035431496442;16067.919660401696;17297.39459118931;17344.219510122042;17972.550686232833;17994.640107197847;16790.244439000242;17113.40103096392;17480.3007879685;17507.212175452103;17521.386751463702;5118.692878427306;5250.3699556053325;5272.156454967206;5299.920501192485;5300.575953923696;3709.313776951259;5750.827475175731;6108.633481991073;6111.144439778413;6134.04922237054;5194.974025129869;6091.2690477142805;6099.420555047263;6100.725467353957;6121.296050954153;5459.3994660587505;5506.174073888908;5543.6119471637;5551.694656793875;5567.749451274662;5268.710220937847;5554.250176226198;5562.888742225174;5572.832815015556;5583.441655834425;12551.372431378395;12712.6821829455;12808;19483.512912177168;20599.588008239753;1897.6394485047797;2037.1240366642337;2078.1375729072415;2110.8311335093154;2117.7035215069905;9098.818023639556;9207.355485116044;9588.376755510939;9715.757106072404;9975.950120249425;1777.9555511112196;1784.2149454240223;1810.6626806178376;1814.3831097426805;1866.7386565880788;72317.63841180813;72466.275337247;72836.27163728348;73347;73408;10168.847467287997;10196.592136314464;10377.9481102594;10387.428691422045;10788.514516846604;14394;14590.708185836223;14602.269886505845;14614.196219207834;14618.926905365404;6757.831054223586;6924.58452492852;7078.433725301964;7155;7181.102362204724;6405.647689377129;6406.967965160145;6409.487241020707;6574.309697481791;6602.405783479414;4419.1382680377665;4431.62331201845;4434.357018232338;4459.264221403497;4579.885502862455;1738.765266689006;1791.5073354827528;1915.367928583564;1918.7026010968323;1924.3264857299832;788.5623478969112;884.566562384427;896.0770406481334;914.6204325204966;943.7074506902882;16400.507984760476;16610.58473538147;16689.582760430843;16791.07649079288;16862.24119914607;893.9240164585952;911.794846159622;933.7012156110115;1011.4993078426226;1017.2116609627598;9220.7694807629;9325.906740932503;9530.094641009093;9552.42685438876;9799.216062714966;402972;410136.3411378251;413994;419933;420051;80321;84621;84741;84953.57523212345;85110.5744471286;974.6783561424713;996.7508122969258;997.4314640654757;1019.7705516258783;1025.1235193909101;14862.702745944804;14908.854489778889;14926.701465970402;14988.65471696228;15138.924305378403;33554.49668255027;34038.3192336147;34073;34778;34982.47526287159;46886.531134688215;52025;52104.218436722724;52260.738696306275;52386.214206786164;7561.848763024599;7631.1987241341085;7713.498622589514;7773.727919522789;8096.866438698469;11074.5570177192;11483.712907177052;11566.768664626828;11933.880661193623;11960.102992275788;7354.558726476428;9997.150242229201;10299.485025748832;10327.48362581883;10685.786284274427;10095.798084038424;10596.31123976939;10599.788004240027;10656.84014739795;10668.253222274676;10265.435401053013;10364.792704146026;10662.200334974752;10722.678319650424;10755.300905441121;7876.6061696913775;7918.960405197937;7941.722039728582;8027.357811374959;8126.024877014796;9445.291603129655;10713.464556696115;10732.678019659423;10759.946200268949;10912.890871091187 02:37:23 INFO - PROCESS | 3505 | |3;mootools.html;1458.9580724190066;1490.0538158269499;1639.3442622950818;1751.4482937874561;1761.8766686331953;6492.837679058026;7070.752523661673;7118.537295075829;7613.7335193268245;7633.6946522139115;6899.65501724913;7048.682809273582;7138.964305178467;7169.354758071786;7217.350438460538;2175.2495389090736;2221.8222542196586;2236.686863839064;2240.9663855042186;2241.3500084975417;2225.8330625203093;2262.8529145605567;2272.681824544565;2276.8520046197027;2278.737945136306;2224.043661225672;2242.3048854854965;2249.167807911075;2250.6624006399006;2256.1088370093803;1975.654260504413;1980.2178139634764;1983.9107240174226;1991.8506112041582;1994.5711671990446;2118.8410869184872;2141.9785802141937;2143.046344376753;2153.676948457728;2169.3275084723628;7333.266673332624;7416.332530072265;7419.924111003874;7457.776266712007;7474.065741782278;4406.162829062468;4504;4516.322551617251;4520.367148599199;4523.592876641118;2870.4833130036586;2917.124862541229;2994.2215024093675;3000.729934305901;3021.486347320939;915.6200176926568;947.209080417852;958.4728399380313;964.392432767352;990.6527123112561;9535.666251681158;9691.854622180674;9791.216702663842;9834.360766550151;9958.800823983553;4144.5026596807975;4190.161967606491;4227.365895115696;4245.80893859777;4326.264535029052;8527.18991695788;8628.22345988864;8629.913700863037;8645.870311945326;8681.04508504064;4470.485894122217;4547.545245475492;4585.564371384713;4588.357629931812;4589.563991420877;3519.665631764978;3938.6652134568308;4039.2527382434346;4058.776767277769;4064.227796718614;3653.725970552219;3671.8531258749886;3776.4335349697767;3783.697304215656;3907.492026036597;1192.2190964917993;1224.6142465123457;1224.6815827884814;1239.5537606461667;1239.5599562155485;816.2123550773532;817.2971244729528;892.5135800988477;903.6701603914524;906.3066753933247;4984.576311013604;5008.248762685626;5020.2720605511995;5026.623003274769;5050.217216331474;822.6380392627225;828.9419740618099;872.5331947408106;879.4327658660128;900.9459432434074;3514.38498262803;3517.3317069756663;3526.2242306692488;3564.697000754913;3585.8744943926836;8979.326550508607;9214.907850921405;9287.58205880737;9297.860532091889;9301.116393942564;9117.726468205965;9218.400803947721;9241.21449676785;9266.629334826532;9283.39657922233;6481.837954051187;6781.321867813278;6799.184097908283;6940.028396024561;6980.092587963633;4937.259411088366;4991.276264941491;5058.215976523645;5173.198154286091;5190.844274671766;8154.918450815416;8359.791005224917;8493.830123397374;8607.354448416268;8687.782805429662;8439.240468357877;8529.275011624082;8531.872021919551;8720;8741.169588889044;5926.911096333472;6239.719212635533;6454.67726613658;6459.773907913201;6604.570702904296;7174.139103307636;7187.892181617384;7202.603856787718;7221.241769614115;7224.674889630084;6285.59143655661;6315.842103947254;6337.65142917144;6527;6565.638889861103;6083.7870674526175;6245.5628106033955;6246.656433896179;6291.370862913672;6378.617282963037;6106.816795496142;6138.294096178996;6179.81460556184;6200.379962003944;6221.3156552778255;4281.636060934731;4378;4430.291153415438;4437.445319335083;4510.842120525897;4404.273294906305;4407.228734971432;4541.3188021797;4617.2381557044055;4666.34671146033 02:37:23 INFO - PROCESS | 3505 | |4;prototype.html;309.554241891676;316.08650998614;316.9160172554275;321.44069319384266;321.9227385427495;5022.372203474566;5023.844515761377;5031.773570189341;5060.822871199509;5065.290859279699;4948.529889660485;4954.761309672582;4966.6275029372855;4972.651914365996;4974.8258810941625;3920.4511368408375;3948.9407658884998;3959.1289916218384;3965.2243429599253;3978.4629075074927;3674.1916778308864;3901.458923725141;3915.7454765440298;3921.5490218624936;4002.6797856171584;3841.6926645868402;3861.2856621524966;3875.399313106459;3883.718372936924;3889.4749208856724;3686.654371154536;3870.593587673282;3882.9611703882883;3889.4943657324648;3889.8249578769023;3296.8516416761304;3358.513015612747;3360.7311415086733;3364.3103163851597;3381.6956473917467;4780.920299669655;4792.952070479286;4807.807687692488;4808.990112076468;4829.879253018667;4356.847510337155;4373.956260437387;4376;4391.451068616423;4402.889927751832;5136.897262054776;5136.899464533451;5173.611979101583;5217.58259339252;5239.476052394768;3632.673059424638;3668.413053911361;3669.8899033028783;3678.9448158277646;3682.963170368289;5448.591355648303;5507.476789704971;5507.917381239245;5523.861903452405;5559.360673522557;3691.9446208306895;3694.8152592370275;3709.8145092745253;3726.4410338448906;3767.7362584618813;3773.8490460381827;3802.5627052888717;3804.353259945816;3823.935075059492;3832.0994566276904;4361.738295702268;4363.80362883671;4368.7815609219415;4382.444232297552;4430.534793846664;4964.3298154748645;5239;5259.60552958522;5263.578753773307;5282.600110970596;1268.2834198677717;1275.6109386637165;1290.329028904983;1290.8317972235143;1297.7534268488957;868.5787393114334;887.4320434921656;897.1432282170512;901.5266984832884;909.745271324017;4417.624501917308;4420.248557745191;4437.247287321555;4449.755263460541;4451.821927122944;5255;5310.468953104659;5341.973290133525;5348.438413966555;5362.463753624685;4346.261135606955;4443.200223959654;4461.018575913359;4467.865964021084;4497.527759585197;2714.524958132319;2734.603482495027;2827.8469506500514;2847.2312475631466;2850.572414137896;4925.9655472351205;4973.776180071905;4987.326710893983;4990.151674215392;4993.325901003318;5433;5446.346438427335;5471.206675032098;5479.315085614298;5487.835364939058;4821.662483626113;4930.2851086592245;4958.553730164303;4958.57852082577;4964.453910069889;5215.374155101412;5249.396319423163;5290.201331547292;5330.2804121443105;5374.6506477078865;4942.406911170682;5188.481151884781;5195.92206116901;5202.583793296603;5260;4941.357623508921;4948.950510494849;4956.553910148104;4956.686478083383;4970.229614409773;3617.963820361763;3635.7454978151277;3643.0710168906758;3651.940937128203;3653.6529029742132;5144.438471799225;5272.525472707474;5286.233496142961;5293.232481290268;5314.4951229633125;4901.852944411673;5031.949680503149;5038.647294689336;5102.387713474407;5172.499975007357;5114.15616423286;5153.974230128825;5157.329547158845;5161.200013997836;5175.611829112907;4791.754143922535;5039.672421292605;5060.1903695408555;5102.923456148086;5104.897902041864;5035.521625445577;5110.361204849394;5125.205593133071;5135.460776618401;5157;5017.924731129109;5035.546800787946;5048.66787919971;5053.862880851779;5072.391313042459 02:37:23 INFO - PROCESS | 3505 | |5;yui.html;708.8334241453259;718.2853061204103;742.3170682971669;774.6243072110026;820.6512232301272;11262;11697.649070527876;11821.527138914433;11827.881721182786;11837.348945807998;12049.819252711217;12060.336681482515;12291.508339666425;12299.754004919896;12327.383630818467;673.282953654359;864.8659457784022;874.6719980007481;882.9293656507464;889.7820034091657;881.6781874615751;881.7002219245455;882.3646974178581;883.9160279773444;886.1448702002566;908.1281969309438;913.7715571107224;917.9862302065475;919.0120620333136;919.8896132464114;900.5677274908015;901.792587704825;904.4573256046352;904.9411788233776;905.6377449020379;667.5794249622755;668.7091115364783;669.5079116849112;671.1409395973113;672.4149989509158;11868.228565143325;11949.64151075469;12075;12075.09436792244;12095.637130886;12910.612681619567;12943.805842912363;13054.934725326408;13055.804162937564;13186.472541098345;9788.510574471247;9954.303198776088;10022.198224142052;10054.798904021878;10164.390136591828;2844.416894536615;2853.885844566215;2878.3667593129476;2879.1218678303107;2885.7258560436726;44573.77713111414;44790;44835;44945.550544494465;44980.3252951206;10099.646512372032;10177.18582513397;10180.338278011906;10220.642277520252;10238.795224095476;18604.44186674402;18614.255429782927;18642.44072677822;18744.718829217574;18761.530961726065;6312.147860038836;6407.935920640734;6415;6474.12599299098;6627.5029372797235;3560.6973407260675;3623.5651721793024;3701.2880323028917;3729.850805967785;3776.66010059096;2930.8094973826633;3027.5155975043886;3036.3927214557175;3047.8628461719277;3062.586550815611;516.176698166424;522.9241759944787;523.8140460136597;536.9261477045908;539.0351271224542;475.3084262398202;590.7961753195141;627.4353082226033;631.9778807741707;674.4031532094132;7758.844823103506;8046.879296810553;8077.717279895175;8079.313258372987;8198.180181981754;508.9414717307483;546.4262524349417;594.3937184072222;608.5314307982828;617.607819034916;3504.2641045380756;3689.2990331836863;3764.247150569897;3791.1280405506886;3830.8659196927974;50333.24500132501;50377.99244015173;50614.49385506098;52022.47977520176;52102;44827.10345793066;46029.30956035662;46741.76629116833;47138.29292560614;47233;38695.226095477934;39854.2029159421;41879;42446;42914;7383.446241532014;7735.149133595412;7873.330766884879;7890.250426209731;8045;28026.719732802412;28887.422251555272;28898.85550572234;29389.412211756073;29576.260593485335;33901.15247118743;36880.81559592185;36941.63058369382;37020.629793701715;37095;10344.224183186141;10388.688339349832;10788.946055269673;10799.40603266828;10899.128069754242;11385.487653055467;11583.536658533902;11739;11750.58872939443;11881.287122772661;10402.219833512365;10803.189760768131;10814.675559733221;10816.56733730642;10849.511771970123;10659.786804264026;10813.837792432962;10921.991469685381;10966.670999870017;11254.606088786853;10241;10815.297005694605;10817.621383251548;10855.67432977012;11015.284006539548;8669.962558798803;8743.475391476277;8746.38775285724;9152.542372881462;9198.080191981016;9016;9136.6802161924;9539;9656.95171524138;9664.371815831948 02:37:23 INFO - PROCESS | 3505 | __end_tp_report 02:37:23 INFO - PROCESS | 3505 | __start_cc_report 02:37:23 INFO - PROCESS | 3505 | _x_x_mozilla_cycle_collect,358 02:37:23 INFO - PROCESS | 3505 | __end_cc_report 02:37:23 INFO - PROCESS | 3505 | __startTimestamp1462873043855__endTimestamp 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | ------- Summary: start ------- 02:37:23 INFO - PROCESS | 3505 | Number of tests: 6 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | [#0] dojo.html Cycles:165 Average:4769.81 Median:4922.68 stddev:609.97 (12.4%) stddev-sans-first:588.67 02:37:23 INFO - PROCESS | 3505 | Values: 2647.1 2681.2 2686.0 2690.7 2696.5 4600.2 4629.8 4684.0 4745.8 4770.4 4659.8 4827.0 4843.1 4874.8 4879.4 4430.8 4446.1 4576.9 4579.0 4599.6 482.5 4311.4 4344.0 4432.2 4473.9 4387.4 4403.3 4417.4 4441.1 4507.9 4481.6 4486.2 4493.4 4497.2 4534.4 4298.0 4405.8 4463.4 4466.2 4485.9 4689.8 4745.6 4747.0 4748.1 4759.5 5197.4 5214.3 5224.6 5224.6 5260.5 5073.5 5170.9 5192.2 5227.5 5253.2 4894.1 4916.9 4922.7 4922.9 4960.0 5350.5 5353.5 5354.9 5383.5 5404.2 4942.8 5068.4 5104.1 5127.2 5160.1 5236.5 5243.0 5261.6 5262.1 5270.7 5194.2 5198.0 5199.3 5200.2 5251.9 4915.3 5125.7 5152.3 5177.4 5186.3 4442.1 4467.9 4484.4 4490.7 4517.6 3769.9 3893.4 3913.0 3930.2 3949.0 4283.1 4405.9 4423.4 4444.1 4492.1 5229.5 5255.9 5265.5 5277.8 5290.4 4329.0 4448.2 4469.1 4484.9 4508.0 4693.6 4712.0 4733.0 4733.5 4755.9 4847.2 4915.6 4917.3 4935.0 4996.9 5007.9 5080.4 5243.9 5258.2 5321.7 4829.0 4835.2 4861.0 4865.9 4920.8 5090.6 5092.4 5102.2 5114.4 5169.0 5015.9 5068.8 5155.1 5184.7 5195.1 4990.7 5023.0 5024.7 5025.8 5065.9 4999.8 5027.5 5040.7 5041.6 5049.5 4809.5 4953.2 4961.0 4997.1 5038.0 5118.9 5133.3 5160.3 5168.6 5169.4 5039.8 5042.0 5043.7 5055.7 5090.3 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | [#1] ext.html Cycles:180 Average:44711.66 Median:20317.00 stddev:81181.76 (399.6%) stddev-sans-first:81341.87 02:37:23 INFO - PROCESS | 3505 | Values: 578.8 604.6 611.2 616.4 631.5 36283.8 40146.4 40348.2 40381.0 40455.6 40849.4 41079.8 41119.8 41425.4 41547.0 7784.9 7867.6 7882.6 7903.9 7914.0 7719.2 7727.7 7781.1 7793.3 7819.2 7845.1 7877.8 7878.1 7880.0 7883.4 7818.1 7833.3 7836.0 7837.1 7838.6 7664.7 7761.7 7768.2 7770.1 7793.7 29261.7 36871.3 37606.4 37622.6 37660.1 3079.9 3118.3 3279.2 3691.2 3851.5 27607.6 28092.4 28192.3 29020.6 29161.7 3367.9 3377.7 3432.7 3454.9 3467.2 213237.0 214164.0 214475.9 216319.0 216988.0 33085.0 33443.5 33457.7 33500.7 33939.0 33359.5 35329.8 35537.6 35627.8 35779.0 12163.9 12275.2 12281.9 12285.7 12303.1 9836.0 9977.8 9978.7 10063.2 10076.4 8271.3 8289.5 8311.5 8325.9 8398.8 3246.2 3305.9 3313.5 3335.1 3350.8 939.1 973.7 994.5 1021.3 1066.3 28838.1 29319.0 29413.3 29427.4 29713.3 988.6 1020.6 1040.8 1046.8 1061.0 15358.9 15580.8 15721.0 15722.7 15742.4 371021.0 371691.0 375801.0 376549.0 377365.0 49589.8 50711.2 51081.7 51226.5 51281.5 1240.1 1243.4 1259.1 1270.7 1276.7 26780.3 27694.0 28265.9 28432.0 28471.6 43273.0 43533.0 43558.3 43710.3 43714.6 311785.0 311856.0 312152.0 314659.0 314809.0 25093.0 25620.7 25651.5 25698.7 25713.4 41089.4 42567.0 43299.8 43552.0 44378.0 36142.0 36942.8 37003.6 37564.0 37566.4 37060.0 37495.3 37932.4 38155.6 38804.0 37483.6 38320.8 39054.0 39233.8 41869.6 31162.7 33482.3 34192.8 34654.7 34689.3 25887.6 25963.4 26381.6 26428.7 26663.6 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | [#2] jquery.html Cycles:180 Average:25134.23 Median:419992.00 stddev:68339.77 (16.3%) stddev-sans-first:68506.20 02:37:23 INFO - PROCESS | 3505 | Values: 376.7 378.8 388.3 388.8 401.9 16067.9 17297.4 17344.2 17972.6 17994.6 16790.2 17113.4 17480.3 17507.2 17521.4 5118.7 5250.4 5272.2 5299.9 5300.6 3709.3 5750.8 6108.6 6111.1 6134.0 5195.0 6091.3 6099.4 6100.7 6121.3 5459.4 5506.2 5543.6 5551.7 5567.7 5268.7 5554.3 5562.9 5572.8 5583.4 12551.4 12712.7 12808.0 19483.5 20599.6 1897.6 2037.1 2078.1 2110.8 2117.7 9098.8 9207.4 9588.4 9715.8 9976.0 1778.0 1784.2 1810.7 1814.4 1866.7 72317.6 72466.3 72836.3 73347.0 73408.0 10168.8 10196.6 10377.9 10387.4 10788.5 14394.0 14590.7 14602.3 14614.2 14618.9 6757.8 6924.6 7078.4 7155.0 7181.1 6405.6 6407.0 6409.5 6574.3 6602.4 4419.1 4431.6 4434.4 4459.3 4579.9 1738.8 1791.5 1915.4 1918.7 1924.3 788.6 884.6 896.1 914.6 943.7 16400.5 16610.6 16689.6 16791.1 16862.2 893.9 911.8 933.7 1011.5 1017.2 9220.8 9325.9 9530.1 9552.4 9799.2 402972.0 410136.3 413994.0 419933.0 420051.0 80321.0 84621.0 84741.0 84953.6 85110.6 974.7 996.8 997.4 1019.8 1025.1 14862.7 14908.9 14926.7 14988.7 15138.9 33554.5 34038.3 34073.0 34778.0 34982.5 46886.5 52025.0 52104.2 52260.7 52386.2 7561.8 7631.2 7713.5 7773.7 8096.9 11074.6 11483.7 11566.8 11933.9 11960.1 7354.6 9997.2 10299.5 10327.5 10685.8 10095.8 10596.3 10599.8 10656.8 10668.3 10265.4 10364.8 10662.2 10722.7 10755.3 7876.6 7919.0 7941.7 8027.4 8126.0 9445.3 10713.5 10732.7 10759.9 10912.9 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | [#3] mootools.html Cycles:180 Average:4933.78 Median:6005.35 stddev:2660.23 (44.3%) stddev-sans-first:2654.88 02:37:23 INFO - PROCESS | 3505 | Values: 1459.0 1490.1 1639.3 1751.4 1761.9 6492.8 7070.8 7118.5 7613.7 7633.7 6899.7 7048.7 7139.0 7169.4 7217.4 2175.2 2221.8 2236.7 2241.0 2241.4 2225.8 2262.9 2272.7 2276.9 2278.7 2224.0 2242.3 2249.2 2250.7 2256.1 1975.7 1980.2 1983.9 1991.9 1994.6 2118.8 2142.0 2143.0 2153.7 2169.3 7333.3 7416.3 7419.9 7457.8 7474.1 4406.2 4504.0 4516.3 4520.4 4523.6 2870.5 2917.1 2994.2 3000.7 3021.5 915.6 947.2 958.5 964.4 990.7 9535.7 9691.9 9791.2 9834.4 9958.8 4144.5 4190.2 4227.4 4245.8 4326.3 8527.2 8628.2 8629.9 8645.9 8681.0 4470.5 4547.5 4585.6 4588.4 4589.6 3519.7 3938.7 4039.3 4058.8 4064.2 3653.7 3671.9 3776.4 3783.7 3907.5 1192.2 1224.6 1224.7 1239.6 1239.6 816.2 817.3 892.5 903.7 906.3 4984.6 5008.2 5020.3 5026.6 5050.2 822.6 828.9 872.5 879.4 900.9 3514.4 3517.3 3526.2 3564.7 3585.9 8979.3 9214.9 9287.6 9297.9 9301.1 9117.7 9218.4 9241.2 9266.6 9283.4 6481.8 6781.3 6799.2 6940.0 6980.1 4937.3 4991.3 5058.2 5173.2 5190.8 8154.9 8359.8 8493.8 8607.4 8687.8 8439.2 8529.3 8531.9 8720.0 8741.2 5926.9 6239.7 6454.7 6459.8 6604.6 7174.1 7187.9 7202.6 7221.2 7224.7 6285.6 6315.8 6337.7 6527.0 6565.6 6083.8 6245.6 6246.7 6291.4 6378.6 6106.8 6138.3 6179.8 6200.4 6221.3 4281.6 4378.0 4430.3 4437.4 4510.8 4404.3 4407.2 4541.3 4617.2 4666.3 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | [#4] prototype.html Cycles:180 Average:4280.62 Median:4941.88 stddev:1246.29 (25.2%) stddev-sans-first:1213.63 02:37:23 INFO - PROCESS | 3505 | Values: 309.6 316.1 316.9 321.4 321.9 5022.4 5023.8 5031.8 5060.8 5065.3 4948.5 4954.8 4966.6 4972.7 4974.8 3920.5 3948.9 3959.1 3965.2 3978.5 3674.2 3901.5 3915.7 3921.5 4002.7 3841.7 3861.3 3875.4 3883.7 3889.5 3686.7 3870.6 3883.0 3889.5 3889.8 3296.9 3358.5 3360.7 3364.3 3381.7 4780.9 4793.0 4807.8 4809.0 4829.9 4356.8 4374.0 4376.0 4391.5 4402.9 5136.9 5136.9 5173.6 5217.6 5239.5 3632.7 3668.4 3669.9 3678.9 3683.0 5448.6 5507.5 5507.9 5523.9 5559.4 3691.9 3694.8 3709.8 3726.4 3767.7 3773.8 3802.6 3804.4 3823.9 3832.1 4361.7 4363.8 4368.8 4382.4 4430.5 4964.3 5239.0 5259.6 5263.6 5282.6 1268.3 1275.6 1290.3 1290.8 1297.8 868.6 887.4 897.1 901.5 909.7 4417.6 4420.2 4437.2 4449.8 4451.8 5255.0 5310.5 5342.0 5348.4 5362.5 4346.3 4443.2 4461.0 4467.9 4497.5 2714.5 2734.6 2827.8 2847.2 2850.6 4926.0 4973.8 4987.3 4990.2 4993.3 5433.0 5446.3 5471.2 5479.3 5487.8 4821.7 4930.3 4958.6 4958.6 4964.5 5215.4 5249.4 5290.2 5330.3 5374.7 4942.4 5188.5 5195.9 5202.6 5260.0 4941.4 4949.0 4956.6 4956.7 4970.2 3618.0 3635.7 3643.1 3651.9 3653.7 5144.4 5272.5 5286.2 5293.2 5314.5 4901.9 5031.9 5038.6 5102.4 5172.5 5114.2 5154.0 5157.3 5161.2 5175.6 4791.8 5039.7 5060.2 5102.9 5104.9 5035.5 5110.4 5125.2 5135.5 5157.0 5017.9 5035.5 5048.7 5053.9 5072.4 02:37:23 INFO - PROCESS | 3505 | 02:37:23 INFO - PROCESS | 3505 | [#5] yui.html Cycles:180 Average:12550.61 Median:42162.50 stddev:14081.24 (33.4%) stddev-sans-first:14092.66 02:37:23 INFO - PROCESS | 3505 | Values: 708.8 718.3 742.3 774.6 820.7 11262.0 11697.6 11821.5 11827.9 11837.3 12049.8 12060.3 12291.5 12299.8 12327.4 673.3 864.9 874.7 882.9 889.8 881.7 881.7 882.4 883.9 886.1 908.1 913.8 918.0 919.0 919.9 900.6 901.8 904.5 904.9 905.6 667.6 668.7 669.5 671.1 672.4 11868.2 11949.6 12075.0 12075.1 12095.6 12910.6 12943.8 13054.9 13055.8 13186.5 9788.5 9954.3 10022.2 10054.8 10164.4 2844.4 2853.9 2878.4 2879.1 2885.7 44573.8 44790.0 44835.0 44945.6 44980.3 10099.6 10177.2 10180.3 10220.6 10238.8 18604.4 18614.3 18642.4 18744.7 18761.5 6312.1 6407.9 6415.0 6474.1 6627.5 3560.7 3623.6 3701.3 3729.9 3776.7 2930.8 3027.5 3036.4 3047.9 3062.6 516.2 522.9 523.8 536.9 539.0 475.3 590.8 627.4 632.0 674.4 7758.8 8046.9 8077.7 8079.3 8198.2 508.9 546.4 594.4 608.5 617.6 3504.3 3689.3 3764.2 3791.1 3830.9 50333.2 50378.0 50614.5 52022.5 52102.0 44827.1 46029.3 46741.8 47138.3 47233.0 38695.2 39854.2 41879.0 42446.0 42914.0 7383.4 7735.1 7873.3 7890.3 8045.0 28026.7 28887.4 28898.9 29389.4 29576.3 33901.2 36880.8 36941.6 37020.6 37095.0 10344.2 10388.7 10788.9 10799.4 10899.1 11385.5 11583.5 11739.0 11750.6 11881.3 10402.2 10803.2 10814.7 10816.6 10849.5 10659.8 10813.8 10922.0 10966.7 11254.6 10241.0 10815.3 10817.6 10855.7 11015.3 8670.0 8743.5 8746.4 9152.5 9198.1 9016.0 9136.7 9539.0 9657.0 9664.4 02:37:23 INFO - PROCESS | 3505 | -------- Summary: end -------- 02:37:23 INFO - PROCESS | 3505 | 02:37:24 INFO - TEST-INFO | 3505: exit 0 02:37:24 INFO - TEST-OK | dromaeo_css | took 1115504ms 02:37:24 INFO - TEST-START | kraken 02:37:24 INFO - operating with platform_type : linux_ 02:37:24 INFO - Initialising browser for kraken test... 02:37:24 INFO - TEST-INFO | started process 3740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVIHlm2/profile http://localhost:48775/getInfo.html) 02:37:28 INFO - PROCESS | 3740 | 02:37:28 INFO - PROCESS | 3740 | (process:3806): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:37:29 INFO - PROCESS | 3740 | __metrics Screen width/height:1600/1200 02:37:29 INFO - PROCESS | 3740 | colorDepth:24 02:37:29 INFO - PROCESS | 3740 | Browser inner width/height: 1024/697 02:37:29 INFO - PROCESS | 3740 | __metrics 02:37:29 ERROR - PROCESS | 3740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 02:37:30 INFO - TEST-INFO | 3740: exit 0 02:37:30 INFO - Browser initialized. 02:37:30 INFO - Running cycle 1/1 for kraken test... 02:37:30 INFO - TEST-INFO | started process 3857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVIHlm2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:32 INFO - PROCESS | 3857 | 02:37:32 INFO - PROCESS | 3857 | (process:3917): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:37:42 INFO - PROCESS | 3857 | RSS: Main: 164245504 02:37:42 INFO - PROCESS | 3857 | 02:37:45 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-beat-detection) 02:37:46 INFO - PROCESS | 3857 | RSS: Main: 167440384 02:37:46 INFO - PROCESS | 3857 | 02:37:49 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-dft) 02:37:49 INFO - PROCESS | 3857 | RSS: Main: 167505920 02:37:49 INFO - PROCESS | 3857 | 02:37:52 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-fft) 02:37:53 INFO - PROCESS | 3857 | RSS: Main: 163590144 02:37:53 INFO - PROCESS | 3857 | 02:37:55 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-oscillator) 02:37:56 INFO - PROCESS | 3857 | RSS: Main: 163803136 02:37:56 INFO - PROCESS | 3857 | 02:37:58 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:59 INFO - PROCESS | 3857 | RSS: Main: 164167680 02:37:59 INFO - PROCESS | 3857 | 02:38:02 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48775/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:03 INFO - PROCESS | 3857 | RSS: Main: 164204544 02:38:03 INFO - PROCESS | 3857 | 02:38:06 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48775/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:07 INFO - PROCESS | 3857 | RSS: Main: 163504128 02:38:07 INFO - PROCESS | 3857 | 02:38:10 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48775/tests/kraken/driver.html?testName=json-parse-financial) 02:38:11 INFO - PROCESS | 3857 | RSS: Main: 163258368 02:38:11 INFO - PROCESS | 3857 | 02:38:12 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:13 INFO - PROCESS | 3857 | RSS: Main: 163471360 02:38:13 INFO - PROCESS | 3857 | 02:38:15 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:16 INFO - PROCESS | 3857 | RSS: Main: 164749312 02:38:16 INFO - PROCESS | 3857 | 02:38:18 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:38:19 INFO - PROCESS | 3857 | RSS: Main: 163741696 02:38:19 INFO - PROCESS | 3857 | 02:38:22 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:22 INFO - PROCESS | 3857 | RSS: Main: 164364288 02:38:22 INFO - PROCESS | 3857 | 02:38:25 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:26 INFO - PROCESS | 3857 | RSS: Main: 164229120 02:38:26 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48775/tests/kraken/driver.html?testName=ai-astar) 02:38:28 INFO - PROCESS | 3857 | RSS: Main: 166772736 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | __start_tp_report 02:38:28 INFO - PROCESS | 3857 | _x_x_mozilla_page_load 02:38:28 INFO - PROCESS | 3857 | _x_x_mozilla_page_load_details 02:38:28 INFO - PROCESS | 3857 | |i|pagename|runs| 02:38:28 INFO - PROCESS | 3857 | |0;ai-astar;111;115;109;116;116;115;111;118;115;116 02:38:28 INFO - PROCESS | 3857 | |1;audio-beat-detection;165;131;161;231;146;153;163;142;178;133 02:38:28 INFO - PROCESS | 3857 | |2;audio-dft;163;164;179;166;163;160;161;163;164;163 02:38:28 INFO - PROCESS | 3857 | |3;audio-fft;76;76;76;179;77;76;78;76;165;78 02:38:28 INFO - PROCESS | 3857 | |4;audio-oscillator;93;93;178;94;94;93;141;94;94;142 02:38:28 INFO - PROCESS | 3857 | |5;imaging-gaussian-blur;118;118;118;118;118;117;119;117;118;119 02:38:28 INFO - PROCESS | 3857 | |6;imaging-darkroom;149;149;148;148;149;149;149;148;149;148 02:38:28 INFO - PROCESS | 3857 | |7;imaging-desaturate;94;95;95;96;96;96;95;95;96;95 02:38:28 INFO - PROCESS | 3857 | |8;json-parse-financial;65;67;67;66;67;65;68;66;68;67 02:38:28 INFO - PROCESS | 3857 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;66;65;66 02:38:28 INFO - PROCESS | 3857 | |10;stanford-crypto-aes;83;83;87;82;83;81;83;81;134;82 02:38:28 INFO - PROCESS | 3857 | |11;stanford-crypto-ccm;134;141;140;142;136;135;144;147;158;136 02:38:28 INFO - PROCESS | 3857 | |12;stanford-crypto-pbkdf2;174;176;174;180;176;173;172;171;184;171 02:38:28 INFO - PROCESS | 3857 | |13;stanford-crypto-sha256-iterative;71;68;71;69;70;68;70;66;71;68 02:38:28 INFO - PROCESS | 3857 | __end_tp_report 02:38:28 INFO - PROCESS | 3857 | __start_cc_report 02:38:28 INFO - PROCESS | 3857 | _x_x_mozilla_cycle_collect,906 02:38:28 INFO - PROCESS | 3857 | __end_cc_report 02:38:28 INFO - PROCESS | 3857 | __startTimestamp1462873108354__endTimestamp 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | ------- Summary: start ------- 02:38:28 INFO - PROCESS | 3857 | Number of tests: 14 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:2.86 (2.5%) stddev-sans-first:2.79 02:38:28 INFO - PROCESS | 3857 | Values: 111.0 115.0 109.0 116.0 116.0 115.0 111.0 118.0 115.0 116.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#1] audio-beat-detection Cycles:10 Average:160.30 Median:162.00 stddev:28.94 (17.9%) stddev-sans-first:30.65 02:38:28 INFO - PROCESS | 3857 | Values: 165.0 131.0 161.0 231.0 146.0 153.0 163.0 142.0 178.0 133.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:5.32 (3.3%) stddev-sans-first:5.61 02:38:28 INFO - PROCESS | 3857 | Values: 163.0 164.0 179.0 166.0 163.0 160.0 161.0 163.0 164.0 163.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:40.36 (53.1%) stddev-sans-first:42.17 02:38:28 INFO - PROCESS | 3857 | Values: 76.0 76.0 76.0 179.0 77.0 76.0 78.0 76.0 165.0 78.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:93.50 stddev:30.69 (32.8%) stddev-sans-first:31.80 02:38:28 INFO - PROCESS | 3857 | Values: 93.0 93.0 178.0 94.0 94.0 93.0 141.0 94.0 94.0 142.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 02:38:28 INFO - PROCESS | 3857 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 119.0 117.0 118.0 119.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 02:38:28 INFO - PROCESS | 3857 | Values: 149.0 149.0 148.0 148.0 149.0 149.0 149.0 148.0 149.0 148.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 02:38:28 INFO - PROCESS | 3857 | Values: 94.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 02:38:28 INFO - PROCESS | 3857 | Values: 65.0 67.0 67.0 66.0 67.0 65.0 68.0 66.0 68.0 67.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:38:28 INFO - PROCESS | 3857 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 65.0 66.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:83.00 stddev:16.29 (19.6%) stddev-sans-first:17.18 02:38:28 INFO - PROCESS | 3857 | Values: 83.0 83.0 87.0 82.0 83.0 81.0 83.0 81.0 134.0 82.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:141.50 stddev:7.23 (5.1%) stddev-sans-first:7.17 02:38:28 INFO - PROCESS | 3857 | Values: 134.0 141.0 140.0 142.0 136.0 135.0 144.0 147.0 158.0 136.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:175.00 stddev:4.15 (2.4%) stddev-sans-first:4.38 02:38:28 INFO - PROCESS | 3857 | Values: 174.0 176.0 174.0 180.0 176.0 173.0 172.0 171.0 184.0 171.0 02:38:28 INFO - PROCESS | 3857 | 02:38:28 INFO - PROCESS | 3857 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:70.00 stddev:1.69 (2.4%) stddev-sans-first:1.66 02:38:28 INFO - PROCESS | 3857 | Values: 71.0 68.0 71.0 69.0 70.0 68.0 70.0 66.0 71.0 68.0 02:38:28 INFO - PROCESS | 3857 | -------- Summary: end -------- 02:38:28 INFO - PROCESS | 3857 | 02:38:29 INFO - TEST-INFO | 3857: exit 0 02:38:29 INFO - TEST-OK | kraken | took 64893ms 02:38:29 INFO - SUITE-END | took 1180s 02:38:30 INFO - Completed test suite (00:19:40) 02:38:30 INFO - javascript benchmark 02:38:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.060293595773, 2681.222445490808, 2685.95971060434, 2690.6502154719883, 2696.487667343206, 4600.217962946303, 4629.8148074077035, 4683.953160468394, 4745.833895813647, 4770.379850619414, 4659.836905708301, 4827.0, 4843.104025755238, 4874.805007799684, 4879.3656824612835, 4430.822767089313, 4446.133004064209, 4576.931346029795, 4578.97710511447, 4599.586037256646, 482.49923438138023, 4311.439512863323, 4344.044310251739, 4432.180046691373, 4473.888152796174, 4387.4296341475565, 4403.339499075132, 4417.447819022622, 4441.111777644452, 4507.887302817423, 4481.551844815493, 4486.192485352635, 4493.370928070073, 4497.168023915586, 4534.433195850519, 4298.032942587924, 4405.8237670493145, 4463.375127482155, 4466.196084704752, 4485.887852803673, 4689.8358557450665, 4745.572898439123, 4747.0, 4748.145333839908, 4759.547842954914, 5197.376314842243, 5214.348206474191, 5224.582033437354, 5224.634275600672, 5260.500252476008, 5073.492650734934, 5170.922436163461, 5192.1952097424955, 5227.50338717825, 5253.238280449352, 4894.143524883167, 4916.852494425173, 4922.680025798311, 4922.8769280768265, 4959.950400495985, 5350.51845333914, 5353.491418315254, 5354.866128346823, 5383.5423988961375, 5404.189371594292, 4942.777575009061, 5068.4424713281505, 5104.055749686246, 5127.179651255781, 5160.148575485078, 5236.476352364809, 5243.030039442715, 5261.631685782035, 5262.10544207478, 5270.683758974397, 5194.246834209019, 5198.012377648235, 5199.272101905736, 5200.245964335226, 5251.921221181686, 4915.336429581961, 5125.692458452505, 5152.3044389007, 5177.430482646906, 5186.325777648957, 4442.089371678798, 4467.86596402102, 4484.39460672805, 4490.663200259994, 4517.638588912879, 3769.9434508482395, 3893.3965235387996, 3913.0, 3930.1746633206776, 3949.0, 4283.1005488847695, 4405.867823965286, 4423.380726698265, 4444.133393988206, 4492.101579684077, 5229.47705229474, 5255.894882102413, 5265.473452654781, 5277.8416647500635, 5290.391604965478, 4329.0, 4448.221561226773, 4469.08383781324, 4484.910301793946, 4508.030773383673, 4693.5775780179265, 4712.03403302329, 4732.976335118303, 4733.5266473352385, 4755.904881902343, 4847.248676455155, 4915.557599816034, 4917.311576379381, 4935.0, 4996.925046124311, 5007.924881126859, 5080.364954380702, 5243.868903277296, 5258.158694608845, 5321.7073060980465, 4828.975855120702, 4835.20219163834, 4861.027794441055, 4865.878353041061, 4920.778564964657, 5090.567301779242, 5092.388913330424, 5102.209157580581, 5114.411842638145, 5168.966206758739, 5015.949840501548, 5068.797248110034, 5155.072087024371, 5184.714840683799, 5195.064888320138, 4990.6506544541535, 5023.045621331935, 5024.748762561931, 5025.824096156617, 5065.898682026413, 4999.800007999639, 5027.522385373383, 5040.672356296829, 5041.571466425395, 5049.469805670498, 4809.495003024632, 4953.18272485036, 4961.007798440254, 4997.100521906092, 5037.96721672049, 5118.923216151835, 5133.3326667534475, 5160.277561141518, 5168.560672342893, 5169.431362550192, 5039.84880453587, 5042.042012017705, 5043.722595257149, 5055.7472126392795, 5090.261912022662], "value": 4732.266146211382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8379253808935, 604.5586721693164, 611.2390074357426, 616.3713012727019, 631.5484428633526, 36283.81858090709, 40146.39780403289, 40348.19303613926, 40381.0, 40455.59544404555, 40849.387259191135, 41079.794601027024, 41119.79440102795, 41425.378619320734, 41547.0, 7784.922150778476, 7867.6459559319965, 7882.645280962371, 7903.881441778378, 7914.0, 7719.150893401721, 7727.72952946647, 7781.144074151867, 7793.2596403341595, 7819.218078192163, 7845.058592968823, 7877.842443151134, 7878.1334053254095, 7880.0, 7883.448158628898, 7818.06183258007, 7833.295003449717, 7836.0, 7837.059552853637, 7838.568878711669, 7664.73173438927, 7761.650725717356, 7768.223177682243, 7770.067591888953, 7793.688252469894, 29261.70738292611, 36871.262574748354, 37606.43590346147, 37622.623773762185, 37660.05849853748, 3079.9230019249476, 3118.2672072063046, 3279.212988882675, 3691.187938653492, 3851.499305090348, 27607.585886211724, 28092.43815123686, 28192.295192620142, 29020.564691529646, 29161.708382916113, 3367.9494807577908, 3377.662233776627, 3432.7253819694365, 3454.9117028136056, 3467.1678797088516, 213237.0, 214164.0, 214475.92762036246, 216319.0, 216988.0, 33085.0, 33443.49834752481, 33457.665423345454, 33500.66499335024, 33939.0, 33359.49960750591, 35329.8233508836, 35537.64462355343, 35627.82186089105, 35779.0, 12163.878361216275, 12275.202111862878, 12281.93859030699, 12285.69285767863, 12303.138780285473, 9836.0, 9977.800443991226, 9978.650747223957, 10063.19494440443, 10076.3954162749, 8271.296939760068, 8289.544075075808, 8311.459755115899, 8325.875111873327, 8398.790030249293, 3246.204679853451, 3305.9008229753144, 3313.519539666735, 3335.1328654549507, 3350.765446418727, 939.1125386509683, 973.6786860336072, 994.4977786217913, 1021.2646894236138, 1066.2802608239408, 28838.134855954355, 29318.976102767563, 29413.26466838346, 29427.411451770844, 29713.25716857096, 988.6391467114452, 1020.637673625867, 1040.7606250562412, 1046.842973553973, 1060.9681709548727, 15358.923205383902, 15580.766288505682, 15721.044888871318, 15722.685546289238, 15742.449014284444, 371021.0, 371691.0, 375801.0, 376549.0, 377365.0, 49589.75205124023, 50711.239331410055, 51081.74459127755, 51226.487735122915, 51281.48718512842, 1240.0637518673343, 1243.359669770069, 1259.106034715344, 1270.7204415028864, 1276.6744480157686, 26780.330491737863, 27694.04578015736, 28265.858670706515, 28432.0, 28471.572926406534, 43273.0, 43533.0, 43558.34662480002, 43710.344344834215, 43714.56285437105, 311785.0, 311856.0, 312152.0, 314659.0, 314809.0, 25092.99628014932, 25620.743792561836, 25651.486970260863, 25698.743012570383, 25713.35716607025, 41089.38365924573, 42567.0, 43299.7835010823, 43552.0, 44378.0, 36142.0, 36942.815285923396, 37003.629963701096, 37564.0, 37566.43650345302, 37060.0, 37495.25009499849, 37932.43101353427, 38155.618443815205, 38804.0, 37483.625163748016, 38320.80839595784, 39054.0, 39233.803830980665, 41869.58130418657, 31162.68837311598, 33482.330353393285, 34192.82903585466, 34654.653453465144, 34689.30621387609, 25887.61168582435, 25963.350916227246, 26381.604275935493, 26428.73571264263, 26663.600045999712], "value": 16500.086272712226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.71369758983167, 378.84467368378967, 388.34563760064293, 388.7997681194184, 401.9035431496442, 16067.919660401696, 17297.39459118931, 17344.219510122042, 17972.550686232833, 17994.640107197847, 16790.244439000242, 17113.40103096392, 17480.3007879685, 17507.212175452103, 17521.386751463702, 5118.692878427306, 5250.3699556053325, 5272.156454967206, 5299.920501192485, 5300.575953923696, 3709.313776951259, 5750.827475175731, 6108.633481991073, 6111.144439778413, 6134.04922237054, 5194.974025129869, 6091.2690477142805, 6099.420555047263, 6100.725467353957, 6121.296050954153, 5459.3994660587505, 5506.174073888908, 5543.6119471637, 5551.694656793875, 5567.749451274662, 5268.710220937847, 5554.250176226198, 5562.888742225174, 5572.832815015556, 5583.441655834425, 12551.372431378395, 12712.6821829455, 12808.0, 19483.512912177168, 20599.588008239753, 1897.6394485047797, 2037.1240366642337, 2078.1375729072415, 2110.8311335093154, 2117.7035215069905, 9098.818023639556, 9207.355485116044, 9588.376755510939, 9715.757106072404, 9975.950120249425, 1777.9555511112196, 1784.2149454240223, 1810.6626806178376, 1814.3831097426805, 1866.7386565880788, 72317.63841180813, 72466.275337247, 72836.27163728348, 73347.0, 73408.0, 10168.847467287997, 10196.592136314464, 10377.9481102594, 10387.428691422045, 10788.514516846604, 14394.0, 14590.708185836223, 14602.269886505845, 14614.196219207834, 14618.926905365404, 6757.831054223586, 6924.58452492852, 7078.433725301964, 7155.0, 7181.102362204724, 6405.647689377129, 6406.967965160145, 6409.487241020707, 6574.309697481791, 6602.405783479414, 4419.1382680377665, 4431.62331201845, 4434.357018232338, 4459.264221403497, 4579.885502862455, 1738.765266689006, 1791.5073354827528, 1915.367928583564, 1918.7026010968323, 1924.3264857299832, 788.5623478969112, 884.566562384427, 896.0770406481334, 914.6204325204966, 943.7074506902882, 16400.507984760476, 16610.58473538147, 16689.582760430843, 16791.07649079288, 16862.24119914607, 893.9240164585952, 911.794846159622, 933.7012156110115, 1011.4993078426226, 1017.2116609627598, 9220.7694807629, 9325.906740932503, 9530.094641009093, 9552.42685438876, 9799.216062714966, 402972.0, 410136.3411378251, 413994.0, 419933.0, 420051.0, 80321.0, 84621.0, 84741.0, 84953.57523212345, 85110.5744471286, 974.6783561424713, 996.7508122969258, 997.4314640654757, 1019.7705516258783, 1025.1235193909101, 14862.702745944804, 14908.854489778889, 14926.701465970402, 14988.65471696228, 15138.924305378403, 33554.49668255027, 34038.3192336147, 34073.0, 34778.0, 34982.47526287159, 46886.531134688215, 52025.0, 52104.218436722724, 52260.738696306275, 52386.214206786164, 7561.848763024599, 7631.1987241341085, 7713.498622589514, 7773.727919522789, 8096.866438698469, 11074.5570177192, 11483.712907177052, 11566.768664626828, 11933.880661193623, 11960.102992275788, 7354.558726476428, 9997.150242229201, 10299.485025748832, 10327.48362581883, 10685.786284274427, 10095.798084038424, 10596.31123976939, 10599.788004240027, 10656.84014739795, 10668.253222274676, 10265.435401053013, 10364.792704146026, 10662.200334974752, 10722.678319650424, 10755.300905441121, 7876.6061696913775, 7918.960405197937, 7941.722039728582, 8027.357811374959, 8126.024877014796, 9445.291603129655, 10713.464556696115, 10732.678019659423, 10759.946200268949, 10912.890871091187], "value": 8331.616775646584, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.9580724190066, 1490.0538158269499, 1639.3442622950818, 1751.4482937874561, 1761.8766686331953, 6492.837679058026, 7070.752523661673, 7118.537295075829, 7613.7335193268245, 7633.6946522139115, 6899.65501724913, 7048.682809273582, 7138.964305178467, 7169.354758071786, 7217.350438460538, 2175.2495389090736, 2221.8222542196586, 2236.686863839064, 2240.9663855042186, 2241.3500084975417, 2225.8330625203093, 2262.8529145605567, 2272.681824544565, 2276.8520046197027, 2278.737945136306, 2224.043661225672, 2242.3048854854965, 2249.167807911075, 2250.6624006399006, 2256.1088370093803, 1975.654260504413, 1980.2178139634764, 1983.9107240174226, 1991.8506112041582, 1994.5711671990446, 2118.8410869184872, 2141.9785802141937, 2143.046344376753, 2153.676948457728, 2169.3275084723628, 7333.266673332624, 7416.332530072265, 7419.924111003874, 7457.776266712007, 7474.065741782278, 4406.162829062468, 4504.0, 4516.322551617251, 4520.367148599199, 4523.592876641118, 2870.4833130036586, 2917.124862541229, 2994.2215024093675, 3000.729934305901, 3021.486347320939, 915.6200176926568, 947.209080417852, 958.4728399380313, 964.392432767352, 990.6527123112561, 9535.666251681158, 9691.854622180674, 9791.216702663842, 9834.360766550151, 9958.800823983553, 4144.5026596807975, 4190.161967606491, 4227.365895115696, 4245.80893859777, 4326.264535029052, 8527.18991695788, 8628.22345988864, 8629.913700863037, 8645.870311945326, 8681.04508504064, 4470.485894122217, 4547.545245475492, 4585.564371384713, 4588.357629931812, 4589.563991420877, 3519.665631764978, 3938.6652134568308, 4039.2527382434346, 4058.776767277769, 4064.227796718614, 3653.725970552219, 3671.8531258749886, 3776.4335349697767, 3783.697304215656, 3907.492026036597, 1192.2190964917993, 1224.6142465123457, 1224.6815827884814, 1239.5537606461667, 1239.5599562155485, 816.2123550773532, 817.2971244729528, 892.5135800988477, 903.6701603914524, 906.3066753933247, 4984.576311013604, 5008.248762685626, 5020.2720605511995, 5026.623003274769, 5050.217216331474, 822.6380392627225, 828.9419740618099, 872.5331947408106, 879.4327658660128, 900.9459432434074, 3514.38498262803, 3517.3317069756663, 3526.2242306692488, 3564.697000754913, 3585.8744943926836, 8979.326550508607, 9214.907850921405, 9287.58205880737, 9297.860532091889, 9301.116393942564, 9117.726468205965, 9218.400803947721, 9241.21449676785, 9266.629334826532, 9283.39657922233, 6481.837954051187, 6781.321867813278, 6799.184097908283, 6940.028396024561, 6980.092587963633, 4937.259411088366, 4991.276264941491, 5058.215976523645, 5173.198154286091, 5190.844274671766, 8154.918450815416, 8359.791005224917, 8493.830123397374, 8607.354448416268, 8687.782805429662, 8439.240468357877, 8529.275011624082, 8531.872021919551, 8720.0, 8741.169588889044, 5926.911096333472, 6239.719212635533, 6454.67726613658, 6459.773907913201, 6604.570702904296, 7174.139103307636, 7187.892181617384, 7202.603856787718, 7221.241769614115, 7224.674889630084, 6285.59143655661, 6315.842103947254, 6337.65142917144, 6527.0, 6565.638889861103, 6083.7870674526175, 6245.5628106033955, 6246.656433896179, 6291.370862913672, 6378.617282963037, 6106.816795496142, 6138.294096178996, 6179.81460556184, 6200.379962003944, 6221.3156552778255, 4281.636060934731, 4378.0, 4430.291153415438, 4437.445319335083, 4510.842120525897, 4404.273294906305, 4407.228734971432, 4541.3188021797, 4617.2381557044055, 4666.34671146033], "value": 4043.8692459117997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.554241891676, 316.08650998614, 316.9160172554275, 321.44069319384266, 321.9227385427495, 5022.372203474566, 5023.844515761377, 5031.773570189341, 5060.822871199509, 5065.290859279699, 4948.529889660485, 4954.761309672582, 4966.6275029372855, 4972.651914365996, 4974.8258810941625, 3920.4511368408375, 3948.9407658884998, 3959.1289916218384, 3965.2243429599253, 3978.4629075074927, 3674.1916778308864, 3901.458923725141, 3915.7454765440298, 3921.5490218624936, 4002.6797856171584, 3841.6926645868402, 3861.2856621524966, 3875.399313106459, 3883.718372936924, 3889.4749208856724, 3686.654371154536, 3870.593587673282, 3882.9611703882883, 3889.4943657324648, 3889.8249578769023, 3296.8516416761304, 3358.513015612747, 3360.7311415086733, 3364.3103163851597, 3381.6956473917467, 4780.920299669655, 4792.952070479286, 4807.807687692488, 4808.990112076468, 4829.879253018667, 4356.847510337155, 4373.956260437387, 4376.0, 4391.451068616423, 4402.889927751832, 5136.897262054776, 5136.899464533451, 5173.611979101583, 5217.58259339252, 5239.476052394768, 3632.673059424638, 3668.413053911361, 3669.8899033028783, 3678.9448158277646, 3682.963170368289, 5448.591355648303, 5507.476789704971, 5507.917381239245, 5523.861903452405, 5559.360673522557, 3691.9446208306895, 3694.8152592370275, 3709.8145092745253, 3726.4410338448906, 3767.7362584618813, 3773.8490460381827, 3802.5627052888717, 3804.353259945816, 3823.935075059492, 3832.0994566276904, 4361.738295702268, 4363.80362883671, 4368.7815609219415, 4382.444232297552, 4430.534793846664, 4964.3298154748645, 5239.0, 5259.60552958522, 5263.578753773307, 5282.600110970596, 1268.2834198677717, 1275.6109386637165, 1290.329028904983, 1290.8317972235143, 1297.7534268488957, 868.5787393114334, 887.4320434921656, 897.1432282170512, 901.5266984832884, 909.745271324017, 4417.624501917308, 4420.248557745191, 4437.247287321555, 4449.755263460541, 4451.821927122944, 5255.0, 5310.468953104659, 5341.973290133525, 5348.438413966555, 5362.463753624685, 4346.261135606955, 4443.200223959654, 4461.018575913359, 4467.865964021084, 4497.527759585197, 2714.524958132319, 2734.603482495027, 2827.8469506500514, 2847.2312475631466, 2850.572414137896, 4925.9655472351205, 4973.776180071905, 4987.326710893983, 4990.151674215392, 4993.325901003318, 5433.0, 5446.346438427335, 5471.206675032098, 5479.315085614298, 5487.835364939058, 4821.662483626113, 4930.2851086592245, 4958.553730164303, 4958.57852082577, 4964.453910069889, 5215.374155101412, 5249.396319423163, 5290.201331547292, 5330.2804121443105, 5374.6506477078865, 4942.406911170682, 5188.481151884781, 5195.92206116901, 5202.583793296603, 5260.0, 4941.357623508921, 4948.950510494849, 4956.553910148104, 4956.686478083383, 4970.229614409773, 3617.963820361763, 3635.7454978151277, 3643.0710168906758, 3651.940937128203, 3653.6529029742132, 5144.438471799225, 5272.525472707474, 5286.233496142961, 5293.232481290268, 5314.4951229633125, 4901.852944411673, 5031.949680503149, 5038.647294689336, 5102.387713474407, 5172.499975007357, 5114.15616423286, 5153.974230128825, 5157.329547158845, 5161.200013997836, 5175.611829112907, 4791.754143922535, 5039.672421292605, 5060.1903695408555, 5102.923456148086, 5104.897902041864, 5035.521625445577, 5110.361204849394, 5125.205593133071, 5135.460776618401, 5157.0, 5017.924731129109, 5035.546800787946, 5048.66787919971, 5053.862880851779, 5072.391313042459], "value": 3888.25977524704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.8334241453259, 718.2853061204103, 742.3170682971669, 774.6243072110026, 820.6512232301272, 11262.0, 11697.649070527876, 11821.527138914433, 11827.881721182786, 11837.348945807998, 12049.819252711217, 12060.336681482515, 12291.508339666425, 12299.754004919896, 12327.383630818467, 673.282953654359, 864.8659457784022, 874.6719980007481, 882.9293656507464, 889.7820034091657, 881.6781874615751, 881.7002219245455, 882.3646974178581, 883.9160279773444, 886.1448702002566, 908.1281969309438, 913.7715571107224, 917.9862302065475, 919.0120620333136, 919.8896132464114, 900.5677274908015, 901.792587704825, 904.4573256046352, 904.9411788233776, 905.6377449020379, 667.5794249622755, 668.7091115364783, 669.5079116849112, 671.1409395973113, 672.4149989509158, 11868.228565143325, 11949.64151075469, 12075.0, 12075.09436792244, 12095.637130886, 12910.612681619567, 12943.805842912363, 13054.934725326408, 13055.804162937564, 13186.472541098345, 9788.510574471247, 9954.303198776088, 10022.198224142052, 10054.798904021878, 10164.390136591828, 2844.416894536615, 2853.885844566215, 2878.3667593129476, 2879.1218678303107, 2885.7258560436726, 44573.77713111414, 44790.0, 44835.0, 44945.550544494465, 44980.3252951206, 10099.646512372032, 10177.18582513397, 10180.338278011906, 10220.642277520252, 10238.795224095476, 18604.44186674402, 18614.255429782927, 18642.44072677822, 18744.718829217574, 18761.530961726065, 6312.147860038836, 6407.935920640734, 6415.0, 6474.12599299098, 6627.5029372797235, 3560.6973407260675, 3623.5651721793024, 3701.2880323028917, 3729.850805967785, 3776.66010059096, 2930.8094973826633, 3027.5155975043886, 3036.3927214557175, 3047.8628461719277, 3062.586550815611, 516.176698166424, 522.9241759944787, 523.8140460136597, 536.9261477045908, 539.0351271224542, 475.3084262398202, 590.7961753195141, 627.4353082226033, 631.9778807741707, 674.4031532094132, 7758.844823103506, 8046.879296810553, 8077.717279895175, 8079.313258372987, 8198.180181981754, 508.9414717307483, 546.4262524349417, 594.3937184072222, 608.5314307982828, 617.607819034916, 3504.2641045380756, 3689.2990331836863, 3764.247150569897, 3791.1280405506886, 3830.8659196927974, 50333.24500132501, 50377.99244015173, 50614.49385506098, 52022.47977520176, 52102.0, 44827.10345793066, 46029.30956035662, 46741.76629116833, 47138.29292560614, 47233.0, 38695.226095477934, 39854.2029159421, 41879.0, 42446.0, 42914.0, 7383.446241532014, 7735.149133595412, 7873.330766884879, 7890.250426209731, 8045.0, 28026.719732802412, 28887.422251555272, 28898.85550572234, 29389.412211756073, 29576.260593485335, 33901.15247118743, 36880.81559592185, 36941.63058369382, 37020.629793701715, 37095.0, 10344.224183186141, 10388.688339349832, 10788.946055269673, 10799.40603266828, 10899.128069754242, 11385.487653055467, 11583.536658533902, 11739.0, 11750.58872939443, 11881.287122772661, 10402.219833512365, 10803.189760768131, 10814.675559733221, 10816.56733730642, 10849.511771970123, 10659.786804264026, 10813.837792432962, 10921.991469685381, 10966.670999870017, 11254.606088786853, 10241.0, 10815.297005694605, 10817.621383251548, 10855.67432977012, 11015.284006539548, 8669.962558798803, 8743.475391476277, 8746.38775285724, 9152.542372881462, 9198.080191981016, 9016.0, 9136.6802161924, 9539.0, 9656.95171524138, 9664.371815831948], "value": 5934.357006237296, "unit": "score"}], "name": "dromaeo_css", "value": 6269.16340563112, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 109.0, 116.0, 116.0, 115.0, 111.0, 118.0, 115.0, 116.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 161.0, 231.0, 146.0, 153.0, 163.0, 142.0, 178.0, 133.0], "value": 160.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 179.0, 166.0, 163.0, 160.0, 161.0, 163.0, 164.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 179.0, 77.0, 76.0, 78.0, 76.0, 165.0, 78.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 178.0, 94.0, 94.0, 93.0, 141.0, 94.0, 94.0, 142.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 66.0, 67.0, 65.0, 68.0, 66.0, 68.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 87.0, 82.0, 83.0, 81.0, 83.0, 81.0, 134.0, 82.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 140.0, 142.0, 136.0, 135.0, 144.0, 147.0, 158.0, 136.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 174.0, 180.0, 176.0, 173.0, 172.0, 171.0, 184.0, 171.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 71.0, 69.0, 70.0, 68.0, 70.0, 66.0, 71.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1613.8000000000002, "alertThreshold": 2.0}]} 02:38:30 INFO - Return code: 0 02:38:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:38:30 ERROR - # TBPL SUCCESS # 02:38:30 INFO - Running post-action listener: _resource_record_post_action 02:38:30 INFO - ##### 02:38:30 INFO - ##### Finished run-tests step (success) 02:38:30 INFO - ##### 02:38:30 INFO - Running post-run listener: _resource_record_post_run 02:38:31 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 0; Write bytes: 531296256; Read time: 0; Write time: 565408 02:38:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 171073536; Read time: 0; Write time: 249808 02:38:31 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 0; Write bytes: 296034304; Read time: 0; Write time: 277688 02:38:31 INFO - Running post-run listener: _upload_blobber_files 02:38:31 INFO - Blob upload gear active. 02:38:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:38:31 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:32 INFO - (blobuploader) - INFO - Done attempting. 02:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:33 INFO - (blobuploader) - INFO - Done attempting. 02:38:33 INFO - (blobuploader) - INFO - Iteration through files over. 02:38:33 INFO - Return code: 0 02:38:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:38:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:38:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0473a70925ed54ad24a877936ba0a48c95543f31a24520ed2f3675d2c3b4bf86217e97a67ba97f28a643c28e4b739347a520e98a5a1d9c4a1859f05ac860ad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d661b0d811bc7998a589bd1fea156b520d98df4af4d4840e1fb4f4b539128f51eabeab7cae761b3d9e53cbca95245b29973b741c147fe325ed125e88b1f9764f"} 02:38:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:38:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:38:33 INFO - Contents: 02:38:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0473a70925ed54ad24a877936ba0a48c95543f31a24520ed2f3675d2c3b4bf86217e97a67ba97f28a643c28e4b739347a520e98a5a1d9c4a1859f05ac860ad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d661b0d811bc7998a589bd1fea156b520d98df4af4d4840e1fb4f4b539128f51eabeab7cae761b3d9e53cbca95245b29973b741c147fe325ed125e88b1f9764f"} 02:38:33 INFO - Running post-run listener: copy_logs_to_upload_dir 02:38:33 INFO - Copying logs to upload dir... 02:38:33 INFO - mkdir: /builds/slave/test/build/upload/logs 02:38:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.078293 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-10 02:38:32.711592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:32.716084) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0473a70925ed54ad24a877936ba0a48c95543f31a24520ed2f3675d2c3b4bf86217e97a67ba97f28a643c28e4b739347a520e98a5a1d9c4a1859f05ac860ad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d661b0d811bc7998a589bd1fea156b520d98df4af4d4840e1fb4f4b539128f51eabeab7cae761b3d9e53cbca95245b29973b741c147fe325ed125e88b1f9764f"} build_url:https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0473a70925ed54ad24a877936ba0a48c95543f31a24520ed2f3675d2c3b4bf86217e97a67ba97f28a643c28e4b739347a520e98a5a1d9c4a1859f05ac860ad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d661b0d811bc7998a589bd1fea156b520d98df4af4d4840e1fb4f4b539128f51eabeab7cae761b3d9e53cbca95245b29973b741c147fe325ed125e88b1f9764f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:32.743074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:32.743404) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462857624.482350-168969958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:32.792414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 02:38:32.795777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 02:38:32.796107) ========= ========= Total master_lag: 0.38 =========