builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1460963140.33 results: success (0) buildid: 20160417231019 builduid: 52b6d68351e74229a62ddeb853c8a4d7 revision: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.326159) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.326818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.327147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.371101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.371517) ========= 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=db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 00:05:40-- 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% 229M=0s 2016-04-18 00:05:40 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163569 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.557206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.557713) ========= 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=db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.139006 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.709489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:40.709846) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 --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 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 --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=db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 00:05:40,879 truncating revision to first 12 chars 2016-04-18 00:05:40,879 Setting DEBUG logging. 2016-04-18 00:05:40,879 attempt 1/10 2016-04-18 00:05:40,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d5b0cdb72fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 00:05:41,155 unpacking tar archive at: fx-team-4d5b0cdb72fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:41.320558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:41.320884) ========= script_repo_revision: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:41.321329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:41.321622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 00:05:41.330047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-18 00:05:41.330482) ========= /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=db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:05:41 INFO - MultiFileLogger online at 20160418 00:05:41 in /builds/slave/test 00:05:41 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 00:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:05:41 INFO - {'append_to_log': False, 00:05:41 INFO - 'base_work_dir': '/builds/slave/test', 00:05:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:05:41 INFO - 'branch': 'Fx-Team-Non-PGO', 00:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 00:05:41 INFO - 'config_files': ('talos/linux_config.py',), 00:05:41 INFO - 'default_actions': ('clobber', 00:05:41 INFO - 'read-buildbot-config', 00:05:41 INFO - 'download-and-extract', 00:05:41 INFO - 'populate-webroot', 00:05:41 INFO - 'create-virtualenv', 00:05:41 INFO - 'install', 00:05:41 INFO - 'run-tests'), 00:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:05:41 INFO - 'download_minidump_stackwalk': True, 00:05:41 INFO - 'download_symbols': 'ondemand', 00:05:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:05:41 INFO - 'tooltool.py': '/tools/tooltool.py', 00:05:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:05:41 INFO - '/tools/misc-python/virtualenv.py')}, 00:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:05:41 INFO - 'installer_path': 'installer.exe', 00:05:41 INFO - 'log_level': 'info', 00:05:41 INFO - 'log_name': 'talos', 00:05:41 INFO - 'log_to_console': True, 00:05:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:05:41 INFO - 'opt_config_files': (), 00:05:41 INFO - 'pip_index': False, 00:05:41 INFO - 'sps_profile': False, 00:05:41 INFO - 'sps_profile_interval': 0, 00:05:41 INFO - 'suite': 'dromaeojs-e10s', 00:05:41 INFO - 'system_bits': '32', 00:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:05:41 INFO - 'title': 'talos-linux64-ix-031', 00:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:05:41 INFO - 'use_talos_json': True, 00:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:05:41 INFO - 'work_dir': 'build'} 00:05:41 INFO - ##### 00:05:41 INFO - ##### Running clobber step. 00:05:41 INFO - ##### 00:05:41 INFO - Running pre-action listener: _resource_record_pre_action 00:05:41 INFO - Running main action method: clobber 00:05:41 INFO - rmtree: /builds/slave/test/build 00:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:05:46 INFO - Running post-action listener: _resource_record_post_action 00:05:46 INFO - ##### 00:05:46 INFO - ##### Running read-buildbot-config step. 00:05:46 INFO - ##### 00:05:46 INFO - Running pre-action listener: _resource_record_pre_action 00:05:46 INFO - Running main action method: read_buildbot_config 00:05:46 INFO - Using buildbot properties: 00:05:46 INFO - { 00:05:46 INFO - "project": "", 00:05:46 INFO - "product": "firefox", 00:05:46 INFO - "script_repo_revision": "production", 00:05:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:05:46 INFO - "repository": "", 00:05:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:05:46 INFO - "buildid": "20160417231019", 00:05:46 INFO - "pgo_build": "False", 00:05:46 INFO - "basedir": "/builds/slave/test", 00:05:46 INFO - "buildnumber": 1157, 00:05:46 INFO - "slavename": "talos-linux64-ix-031", 00:05:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:05:46 INFO - "platform": "ubuntu64_hw", 00:05:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:05:46 INFO - "branch": "fx-team", 00:05:46 INFO - "repo_path": "integration/fx-team", 00:05:46 INFO - "revision": "4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8", 00:05:46 INFO - "stage_platform": "linux64", 00:05:46 INFO - "builduid": "52b6d68351e74229a62ddeb853c8a4d7", 00:05:46 INFO - "slavebuilddir": "test" 00:05:46 INFO - } 00:05:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 00:05:46 INFO - Running post-action listener: _resource_record_post_action 00:05:46 INFO - ##### 00:05:46 INFO - ##### Running download-and-extract step. 00:05:46 INFO - ##### 00:05:46 INFO - Running pre-action listener: _resource_record_pre_action 00:05:46 INFO - Running main action method: download_and_extract 00:05:46 INFO - mkdir: /builds/slave/test/build/tests 00:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:46 INFO - https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:05:51 INFO - Downloaded 1361 bytes. 00:05:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:05:51 INFO - Using the following test package requirements: 00:05:51 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:05:51 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:05:51 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:05:51 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'jsshell-linux-x86_64.zip'], 00:05:51 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:05:51 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:05:51 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:05:51 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:05:51 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:05:51 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:05:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:05:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:51 INFO - https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:05:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:05:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:05:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:05:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:06:05 INFO - Downloaded 22203703 bytes. 00:06:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:06:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:06:06 INFO - Return code: 0 00:06:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:06 INFO - https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:06:08 INFO - Downloaded 22203703 bytes. 00:06:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:06:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:06:09 INFO - Return code: 0 00:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:09 INFO - https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:06:10 INFO - Downloaded 10841076 bytes. 00:06:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:06:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:06:11 INFO - Return code: 0 00:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:11 INFO - https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:06:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:06:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:06:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:06:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:06:12 INFO - Downloaded 54451802 bytes. 00:06:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:06:12 INFO - mkdir: /builds/slave/test/properties 00:06:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:06:12 INFO - Writing to file /builds/slave/test/properties/build_url 00:06:12 INFO - Contents: 00:06:12 INFO - build_url:https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:06:13 INFO - Running post-action listener: _resource_record_post_action 00:06:13 INFO - Running post-action listener: set_extra_try_arguments 00:06:13 INFO - ##### 00:06:13 INFO - ##### Running populate-webroot step. 00:06:13 INFO - ##### 00:06:13 INFO - Running pre-action listener: _resource_record_pre_action 00:06:13 INFO - Running main action method: populate_webroot 00:06:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:06:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:06:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:06:13 INFO - '--tppagecycles', 00:06:13 INFO - '7'], 00:06:13 INFO - 'tests': ['tsvgm']}}, 00:06:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:06:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:06:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:06:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:06:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:06:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:06:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['damp', 'tps']}, 00:06:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'tests': ['damp', 'tps']}, 00:06:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['dromaeo_dom']}, 00:06:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:06:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['a11yr', 00:06:13 INFO - 'ts_paint', 00:06:13 INFO - 'tpaint', 00:06:13 INFO - 'sessionrestore', 00:06:13 INFO - 'sessionrestore_no_auto_restore', 00:06:13 INFO - 'tabpaint']}, 00:06:13 INFO - 'other-e10s': {'tests': ['a11yr', 00:06:13 INFO - 'ts_paint', 00:06:13 INFO - 'tpaint', 00:06:13 INFO - 'sessionrestore', 00:06:13 INFO - 'sessionrestore_no_auto_restore', 00:06:13 INFO - 'tabpaint']}, 00:06:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:06:13 INFO - 'ts_paint', 00:06:13 INFO - 'tpaint', 00:06:13 INFO - 'sessionrestore', 00:06:13 INFO - 'sessionrestore_no_auto_restore', 00:06:13 INFO - 'tabpaint']}, 00:06:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:06:13 INFO - 'ts_paint', 00:06:13 INFO - 'tpaint', 00:06:13 INFO - 'sessionrestore', 00:06:13 INFO - 'sessionrestore_no_auto_restore', 00:06:13 INFO - 'tabpaint']}, 00:06:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['a11yr', 00:06:13 INFO - 'ts_paint', 00:06:13 INFO - 'tpaint', 00:06:13 INFO - 'sessionrestore', 00:06:13 INFO - 'sessionrestore_no_auto_restore', 00:06:13 INFO - 'tabpaint']}, 00:06:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['a11yr', 00:06:13 INFO - 'ts_paint', 00:06:13 INFO - 'tpaint', 00:06:13 INFO - 'sessionrestore', 00:06:13 INFO - 'sessionrestore_no_auto_restore', 00:06:13 INFO - 'tabpaint']}, 00:06:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['tsvgx', 00:06:13 INFO - 'tsvgr_opacity', 00:06:13 INFO - 'tart', 00:06:13 INFO - 'tscrollx', 00:06:13 INFO - 'cart']}, 00:06:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:06:13 INFO - 'tsvgr_opacity', 00:06:13 INFO - 'tart', 00:06:13 INFO - 'tscrollx', 00:06:13 INFO - 'cart']}, 00:06:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'talos_options': ['--disable-e10s'], 00:06:13 INFO - 'tests': ['tp5o']}, 00:06:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'tests': ['tp5o']}, 00:06:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'talos_options': ['--disable-e10s', 00:06:13 INFO - '--xperf_path', 00:06:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:06:13 INFO - 'tests': ['tp5n']}, 00:06:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:13 INFO - 'talos_options': ['--xperf_path', 00:06:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:06:13 INFO - 'tests': ['tp5n']}}, 00:06:13 INFO - 'talos.zip': {'path': '', 00:06:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:06:13 INFO - Running post-action listener: _resource_record_post_action 00:06:13 INFO - ##### 00:06:13 INFO - ##### Running create-virtualenv step. 00:06:13 INFO - ##### 00:06:13 INFO - Running pre-action listener: _resource_record_pre_action 00:06:13 INFO - Running main action method: create_virtualenv 00:06:13 INFO - Creating virtualenv /builds/slave/test/build/venv 00:06:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:06:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:06:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:06:13 INFO - Using real prefix '/usr' 00:06:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:06:14 INFO - Installing distribute.............................................................................................................................................................................................done. 00:06:16 INFO - Installing pip.................done. 00:06:16 INFO - Return code: 0 00:06:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:16 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:06:16 INFO - Using env: {'DISPLAY': ':0', 00:06:16 INFO - 'HOME': '/home/cltbld', 00:06:16 INFO - 'LANG': 'en_US.UTF-8', 00:06:16 INFO - 'LANGUAGE': 'en_US:en', 00:06:16 INFO - 'LOGNAME': 'cltbld', 00:06:16 INFO - 'MAIL': '/var/mail/cltbld', 00:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:16 INFO - 'MOZ_NO_REMOTE': '1', 00:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:16 INFO - 'NO_EM_RESTART': '1', 00:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:16 INFO - 'PWD': '/builds/slave/test', 00:06:16 INFO - 'SHELL': '/bin/bash', 00:06:16 INFO - 'SHLVL': '1', 00:06:16 INFO - 'TERM': 'linux', 00:06:16 INFO - 'TMOUT': '86400', 00:06:16 INFO - 'USER': 'cltbld', 00:06:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:16 INFO - '_': '/tools/buildbot/bin/python'} 00:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:06:17 INFO - Cleaning up... 00:06:17 INFO - Return code: 0 00:06:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:17 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:06:17 INFO - Using env: {'DISPLAY': ':0', 00:06:17 INFO - 'HOME': '/home/cltbld', 00:06:17 INFO - 'LANG': 'en_US.UTF-8', 00:06:17 INFO - 'LANGUAGE': 'en_US:en', 00:06:17 INFO - 'LOGNAME': 'cltbld', 00:06:17 INFO - 'MAIL': '/var/mail/cltbld', 00:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:17 INFO - 'MOZ_NO_REMOTE': '1', 00:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:17 INFO - 'NO_EM_RESTART': '1', 00:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:17 INFO - 'PWD': '/builds/slave/test', 00:06:17 INFO - 'SHELL': '/bin/bash', 00:06:17 INFO - 'SHLVL': '1', 00:06:17 INFO - 'TERM': 'linux', 00:06:17 INFO - 'TMOUT': '86400', 00:06:17 INFO - 'USER': 'cltbld', 00:06:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:17 INFO - '_': '/tools/buildbot/bin/python'} 00:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:17 INFO - Downloading/unpacking psutil>=0.7.1 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:06:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:06:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:06:19 INFO - Installing collected packages: psutil 00:06:19 INFO - Running setup.py install for psutil 00:06:19 INFO - building 'psutil._psutil_linux' extension 00:06:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:06:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:06:20 INFO - building 'psutil._psutil_posix' extension 00:06:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:06:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:06:20 INFO - Successfully installed psutil 00:06:20 INFO - Cleaning up... 00:06:20 INFO - Return code: 0 00:06:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:20 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:06:20 INFO - Using env: {'DISPLAY': ':0', 00:06:20 INFO - 'HOME': '/home/cltbld', 00:06:20 INFO - 'LANG': 'en_US.UTF-8', 00:06:20 INFO - 'LANGUAGE': 'en_US:en', 00:06:20 INFO - 'LOGNAME': 'cltbld', 00:06:20 INFO - 'MAIL': '/var/mail/cltbld', 00:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:20 INFO - 'MOZ_NO_REMOTE': '1', 00:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:20 INFO - 'NO_EM_RESTART': '1', 00:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:20 INFO - 'PWD': '/builds/slave/test', 00:06:20 INFO - 'SHELL': '/bin/bash', 00:06:20 INFO - 'SHLVL': '1', 00:06:20 INFO - 'TERM': 'linux', 00:06:20 INFO - 'TMOUT': '86400', 00:06:20 INFO - 'USER': 'cltbld', 00:06:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:20 INFO - '_': '/tools/buildbot/bin/python'} 00:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:06:22 INFO - Installing collected packages: mozsystemmonitor 00:06:22 INFO - Running setup.py install for mozsystemmonitor 00:06:23 INFO - Successfully installed mozsystemmonitor 00:06:23 INFO - Cleaning up... 00:06:23 INFO - Return code: 0 00:06:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:23 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:06:23 INFO - Using env: {'DISPLAY': ':0', 00:06:23 INFO - 'HOME': '/home/cltbld', 00:06:23 INFO - 'LANG': 'en_US.UTF-8', 00:06:23 INFO - 'LANGUAGE': 'en_US:en', 00:06:23 INFO - 'LOGNAME': 'cltbld', 00:06:23 INFO - 'MAIL': '/var/mail/cltbld', 00:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:23 INFO - 'MOZ_NO_REMOTE': '1', 00:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:23 INFO - 'NO_EM_RESTART': '1', 00:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:23 INFO - 'PWD': '/builds/slave/test', 00:06:23 INFO - 'SHELL': '/bin/bash', 00:06:23 INFO - 'SHLVL': '1', 00:06:23 INFO - 'TERM': 'linux', 00:06:23 INFO - 'TMOUT': '86400', 00:06:23 INFO - 'USER': 'cltbld', 00:06:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:23 INFO - '_': '/tools/buildbot/bin/python'} 00:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:23 INFO - Downloading/unpacking blobuploader==1.2.4 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06:25 INFO - Downloading blobuploader-1.2.4.tar.gz 00:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:06:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:06:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:25 INFO - Downloading docopt-0.6.1.tar.gz 00:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:06:25 INFO - Installing collected packages: blobuploader, requests, docopt 00:06:25 INFO - Running setup.py install for blobuploader 00:06:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:06:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:06:26 INFO - Running setup.py install for requests 00:06:26 INFO - Running setup.py install for docopt 00:06:26 INFO - Successfully installed blobuploader requests docopt 00:06:26 INFO - Cleaning up... 00:06:26 INFO - Return code: 0 00:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:06: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')]} 00:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06: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')]} 00:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:26 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:06:26 INFO - Using env: {'DISPLAY': ':0', 00:06:26 INFO - 'HOME': '/home/cltbld', 00:06:26 INFO - 'LANG': 'en_US.UTF-8', 00:06:26 INFO - 'LANGUAGE': 'en_US:en', 00:06:26 INFO - 'LOGNAME': 'cltbld', 00:06:26 INFO - 'MAIL': '/var/mail/cltbld', 00:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:26 INFO - 'MOZ_NO_REMOTE': '1', 00:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:26 INFO - 'NO_EM_RESTART': '1', 00:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:26 INFO - 'PWD': '/builds/slave/test', 00:06:26 INFO - 'SHELL': '/bin/bash', 00:06:26 INFO - 'SHLVL': '1', 00:06:26 INFO - 'TERM': 'linux', 00:06:26 INFO - 'TMOUT': '86400', 00:06:26 INFO - 'USER': 'cltbld', 00:06:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:26 INFO - '_': '/tools/buildbot/bin/python'} 00:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:06:26 INFO - Running setup.py (path:/tmp/pip-zyuzdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:06:26 INFO - Running setup.py (path:/tmp/pip-l6EzCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:06:26 INFO - Running setup.py (path:/tmp/pip-2tXLSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:06:26 INFO - Running setup.py (path:/tmp/pip-BQrkNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:06:27 INFO - Running setup.py (path:/tmp/pip-zm7eng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:06:27 INFO - Running setup.py (path:/tmp/pip-21Jbvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:06:27 INFO - Running setup.py (path:/tmp/pip-D64ns9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:06:27 INFO - Running setup.py (path:/tmp/pip-nzfgsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:06:27 INFO - Running setup.py (path:/tmp/pip-c3wXMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:06:27 INFO - Running setup.py (path:/tmp/pip-O_5tRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:06:27 INFO - Running setup.py (path:/tmp/pip-sRrEW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:06:27 INFO - Running setup.py (path:/tmp/pip-o_MANU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:06:27 INFO - Running setup.py (path:/tmp/pip-8LYNhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:06:27 INFO - Running setup.py (path:/tmp/pip-5HAHvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:27 INFO - Running setup.py (path:/tmp/pip-teW_QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:06:27 INFO - Running setup.py (path:/tmp/pip-ljGFwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:06:27 INFO - Running setup.py (path:/tmp/pip-b_4WsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:06:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:06:27 INFO - Running setup.py install for manifestparser 00:06:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Running setup.py install for mozcrash 00:06:28 INFO - Running setup.py install for mozdebug 00:06:28 INFO - Running setup.py install for mozdevice 00:06:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Running setup.py install for mozfile 00:06:28 INFO - Running setup.py install for mozhttpd 00:06:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Running setup.py install for mozinfo 00:06:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Running setup.py install for mozInstall 00:06:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Running setup.py install for mozleak 00:06:28 INFO - Running setup.py install for mozlog 00:06:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:06:28 INFO - Running setup.py install for moznetwork 00:06:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:06:29 INFO - Running setup.py install for mozprocess 00:06:29 INFO - Running setup.py install for mozprofile 00:06:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:06:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:06:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:06:29 INFO - Running setup.py install for mozrunner 00:06:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:06:29 INFO - Running setup.py install for mozscreenshot 00:06:29 INFO - Running setup.py install for moztest 00:06:29 INFO - Running setup.py install for mozversion 00:06:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:06:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:06:29 INFO - Cleaning up... 00:06:29 INFO - Return code: 0 00:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:29 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:06:29 INFO - Using env: {'DISPLAY': ':0', 00:06:29 INFO - 'HOME': '/home/cltbld', 00:06:29 INFO - 'LANG': 'en_US.UTF-8', 00:06:29 INFO - 'LANGUAGE': 'en_US:en', 00:06:29 INFO - 'LOGNAME': 'cltbld', 00:06:29 INFO - 'MAIL': '/var/mail/cltbld', 00:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:29 INFO - 'MOZ_NO_REMOTE': '1', 00:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:29 INFO - 'NO_EM_RESTART': '1', 00:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:29 INFO - 'PWD': '/builds/slave/test', 00:06:29 INFO - 'SHELL': '/bin/bash', 00:06:29 INFO - 'SHLVL': '1', 00:06:29 INFO - 'TERM': 'linux', 00:06:29 INFO - 'TMOUT': '86400', 00:06:29 INFO - 'USER': 'cltbld', 00:06:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:29 INFO - '_': '/tools/buildbot/bin/python'} 00:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:06:29 INFO - Running setup.py (path:/tmp/pip-y9n0EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:06:30 INFO - Running setup.py (path:/tmp/pip-48ED5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:06:30 INFO - Running setup.py (path:/tmp/pip-UpY68q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:06:30 INFO - Running setup.py (path:/tmp/pip-A9a5iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:06:30 INFO - Running setup.py (path:/tmp/pip-CNu0Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:06:30 INFO - Running setup.py (path:/tmp/pip-JVOd8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:06:30 INFO - Running setup.py (path:/tmp/pip-4RW8I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:06:30 INFO - Running setup.py (path:/tmp/pip-k9jl1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:06:30 INFO - Running setup.py (path:/tmp/pip-YutRop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:06:30 INFO - Running setup.py (path:/tmp/pip-V3E2id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:06:30 INFO - Running setup.py (path:/tmp/pip-b2XUqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:06:30 INFO - Running setup.py (path:/tmp/pip-jKG9Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:06:30 INFO - Running setup.py (path:/tmp/pip-Y3tXn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:06:30 INFO - Running setup.py (path:/tmp/pip-YIkCNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:30 INFO - Running setup.py (path:/tmp/pip-s1abqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:06:31 INFO - Running setup.py (path:/tmp/pip-eee2Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:06:31 INFO - Running setup.py (path:/tmp/pip-7HxwC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:06:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06:33 INFO - Downloading blessings-1.6.tar.gz 00:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:06:33 INFO - Installing collected packages: blessings 00:06:33 INFO - Running setup.py install for blessings 00:06:33 INFO - Successfully installed blessings 00:06:33 INFO - Cleaning up... 00:06:33 INFO - Return code: 0 00:06:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:06:33 INFO - Reading from file tmpfile_stdout 00:06:33 INFO - Current package versions: 00:06:33 INFO - argparse == 1.2.1 00:06:33 INFO - blessings == 1.6 00:06:33 INFO - blobuploader == 1.2.4 00:06:33 INFO - docopt == 0.6.1 00:06:33 INFO - manifestparser == 1.1 00:06:33 INFO - mozInstall == 1.12 00:06:33 INFO - mozcrash == 0.17 00:06:33 INFO - mozdebug == 0.1 00:06:33 INFO - mozdevice == 0.48 00:06:33 INFO - mozfile == 1.2 00:06:33 INFO - mozhttpd == 0.7 00:06:33 INFO - mozinfo == 0.9 00:06:33 INFO - mozleak == 0.1 00:06:33 INFO - mozlog == 3.1 00:06:33 INFO - moznetwork == 0.27 00:06:33 INFO - mozprocess == 0.22 00:06:33 INFO - mozprofile == 0.28 00:06:33 INFO - mozrunner == 6.11 00:06:33 INFO - mozscreenshot == 0.1 00:06:33 INFO - mozsystemmonitor == 0.0 00:06:33 INFO - moztest == 0.7 00:06:33 INFO - mozversion == 1.4 00:06:33 INFO - psutil == 3.1.1 00:06:33 INFO - requests == 1.2.3 00:06:33 INFO - wsgiref == 0.1.2 00:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:33 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:06:33 INFO - Using env: {'DISPLAY': ':0', 00:06:33 INFO - 'HOME': '/home/cltbld', 00:06:33 INFO - 'LANG': 'en_US.UTF-8', 00:06:33 INFO - 'LANGUAGE': 'en_US:en', 00:06:33 INFO - 'LOGNAME': 'cltbld', 00:06:33 INFO - 'MAIL': '/var/mail/cltbld', 00:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:33 INFO - 'MOZ_NO_REMOTE': '1', 00:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:33 INFO - 'NO_EM_RESTART': '1', 00:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:33 INFO - 'PWD': '/builds/slave/test', 00:06:33 INFO - 'SHELL': '/bin/bash', 00:06:33 INFO - 'SHLVL': '1', 00:06:33 INFO - 'TERM': 'linux', 00:06:33 INFO - 'TMOUT': '86400', 00:06:33 INFO - 'USER': 'cltbld', 00:06:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:33 INFO - '_': '/tools/buildbot/bin/python'} 00:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:06:33 INFO - Cleaning up... 00:06:33 INFO - Return code: 0 00:06:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:33 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:06:33 INFO - Using env: {'DISPLAY': ':0', 00:06:33 INFO - 'HOME': '/home/cltbld', 00:06:33 INFO - 'LANG': 'en_US.UTF-8', 00:06:33 INFO - 'LANGUAGE': 'en_US:en', 00:06:33 INFO - 'LOGNAME': 'cltbld', 00:06:33 INFO - 'MAIL': '/var/mail/cltbld', 00:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:33 INFO - 'MOZ_NO_REMOTE': '1', 00:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:33 INFO - 'NO_EM_RESTART': '1', 00:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:33 INFO - 'PWD': '/builds/slave/test', 00:06:33 INFO - 'SHELL': '/bin/bash', 00:06:33 INFO - 'SHLVL': '1', 00:06:33 INFO - 'TERM': 'linux', 00:06:33 INFO - 'TMOUT': '86400', 00:06:33 INFO - 'USER': 'cltbld', 00:06:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:33 INFO - '_': '/tools/buildbot/bin/python'} 00:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:34 INFO - Downloading/unpacking jsonschema 00:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:06:35 INFO - Downloading/unpacking functools32 (from jsonschema) 00:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:36 INFO - Downloading functools32-3.2.3-2.tar.gz 00:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:06:36 INFO - warning: no files found matching '*.txt' 00:06:36 INFO - no previously-included directories found matching 'build' 00:06:36 INFO - no previously-included directories found matching 'dist' 00:06:36 INFO - no previously-included directories found matching '.git*' 00:06:36 INFO - Installing collected packages: jsonschema, functools32 00:06:36 INFO - Running setup.py install for functools32 00:06:36 INFO - warning: no files found matching '*.txt' 00:06:36 INFO - no previously-included directories found matching 'build' 00:06:36 INFO - no previously-included directories found matching 'dist' 00:06:36 INFO - no previously-included directories found matching '.git*' 00:06:36 INFO - Successfully installed jsonschema functools32 00:06:36 INFO - Cleaning up... 00:06:36 INFO - Return code: 0 00:06:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:36 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 0x7fbd8eadff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:06:36 INFO - Using env: {'DISPLAY': ':0', 00:06:36 INFO - 'HOME': '/home/cltbld', 00:06:36 INFO - 'LANG': 'en_US.UTF-8', 00:06:36 INFO - 'LANGUAGE': 'en_US:en', 00:06:36 INFO - 'LOGNAME': 'cltbld', 00:06:36 INFO - 'MAIL': '/var/mail/cltbld', 00:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:36 INFO - 'MOZ_NO_REMOTE': '1', 00:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:36 INFO - 'NO_EM_RESTART': '1', 00:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:36 INFO - 'PWD': '/builds/slave/test', 00:06:36 INFO - 'SHELL': '/bin/bash', 00:06:36 INFO - 'SHLVL': '1', 00:06:36 INFO - 'TERM': 'linux', 00:06:36 INFO - 'TMOUT': '86400', 00:06:36 INFO - 'USER': 'cltbld', 00:06:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:36 INFO - '_': '/tools/buildbot/bin/python'} 00:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:36 INFO - Downloading/unpacking flake8 00:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:06:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:06:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:06:39 INFO - no previously-included directories found matching 'docs/_build' 00:06:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:06:39 INFO - Running setup.py install for pep8 00:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:06:39 INFO - no previously-included directories found matching 'docs/_build' 00:06:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:06:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:06:39 INFO - Cleaning up... 00:06:39 INFO - Return code: 0 00:06:39 INFO - Running post-action listener: _resource_record_post_action 00:06:39 INFO - Running post-action listener: _start_resource_monitoring 00:06:39 INFO - Starting resource monitoring. 00:06:39 INFO - ##### 00:06:39 INFO - ##### Running install step. 00:06:39 INFO - ##### 00:06:39 INFO - Running pre-action listener: _resource_record_pre_action 00:06:39 INFO - Running main action method: install 00:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:06:39 INFO - Reading from file tmpfile_stdout 00:06:39 INFO - Detecting whether we're running mozinstall >=1.0... 00:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:06:39 INFO - Reading from file tmpfile_stdout 00:06:39 INFO - Output received: 00:06:39 INFO - Usage: mozinstall [options] installer 00:06:39 INFO - Options: 00:06:39 INFO - -h, --help show this help message and exit 00:06:39 INFO - -d DEST, --destination=DEST 00:06:39 INFO - Directory to install application into. [default: 00:06:39 INFO - "/builds/slave/test"] 00:06:39 INFO - --app=APP Application being installed. [default: firefox] 00:06:39 INFO - mkdir: /builds/slave/test/build/application 00:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:06:55 INFO - Reading from file tmpfile_stdout 00:06:55 INFO - Output received: 00:06:55 INFO - /builds/slave/test/build/application/firefox/firefox 00:06:55 INFO - Running post-action listener: _resource_record_post_action 00:06:55 INFO - ##### 00:06:55 INFO - ##### Running run-tests step. 00:06:55 INFO - ##### 00:06:55 INFO - Running pre-action listener: _resource_record_pre_action 00:06:55 INFO - Running main action method: run_tests 00:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:06:55 INFO - Python 2.7.3 00:06:55 INFO - Return code: 0 00:06:55 INFO - grabbing minidump binary from tooltool 00:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:55 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 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:06:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:06:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:06:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:06:55 INFO - Return code: 0 00:06:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:06:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:06:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:06:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:06:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:06:56 INFO - Return code: 0 00:06:56 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/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 00:06:56 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/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 00:06:56 INFO - Using env: {'DISPLAY': ':0', 00:06:56 INFO - 'HOME': '/home/cltbld', 00:06:56 INFO - 'LANG': 'en_US.UTF-8', 00:06:56 INFO - 'LANGUAGE': 'en_US:en', 00:06:56 INFO - 'LOGNAME': 'cltbld', 00:06:56 INFO - 'MAIL': '/var/mail/cltbld', 00:06:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:06:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:56 INFO - 'MOZ_NO_REMOTE': '1', 00:06:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:56 INFO - 'NO_EM_RESTART': '1', 00:06:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:56 INFO - 'PWD': '/builds/slave/test', 00:06:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:06:56 INFO - 'SHELL': '/bin/bash', 00:06:56 INFO - 'SHLVL': '1', 00:06:56 INFO - 'TERM': 'linux', 00:06:56 INFO - 'TMOUT': '86400', 00:06:56 INFO - 'USER': 'cltbld', 00:06:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271', 00:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:56 INFO - '_': '/tools/buildbot/bin/python'} 00:06:56 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/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 00:06:56 INFO - mozversion application_buildid: 20160417231019 00:06:56 INFO - mozversion application_changeset: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 00:06:56 INFO - mozversion application_display_name: Nightly 00:06:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:06:56 INFO - mozversion application_name: Firefox 00:06:56 INFO - mozversion application_remotingname: firefox 00:06:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:06:56 INFO - mozversion application_vendor: Mozilla 00:06:56 INFO - mozversion application_version: 48.0a1 00:06:56 INFO - mozversion platform_buildid: 20160417231019 00:06:56 INFO - mozversion platform_changeset: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 00:06:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:06:56 INFO - mozversion platform_version: 48.0a1 00:06:56 INFO - using testdate: 1460963216 00:06:56 INFO - actual date: 1460963216 00:06:56 INFO - starting webserver on 'localhost:45294' 00:06:56 INFO - SUITE-START | Running 2 tests 00:06:56 INFO - TEST-START | dromaeo_css 00:06:56 INFO - operating with platform_type : linux_ 00:06:56 INFO - Initialising browser for dromaeo_css test... 00:06:56 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTD9GKd/profile http://localhost:45294/getInfo.html) 00:07:02 INFO - PROCESS | 3316 | 00:07:02 INFO - PROCESS | 3316 | (process:3384): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:07:02 INFO - PROCESS | 3316 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 00:07:03 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 00:07:03 INFO - PROCESS | 3316 | colorDepth:24 00:07:03 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 00:07:03 INFO - PROCESS | 3316 | __metrics 00:07:03 ERROR - PROCESS | 3316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 00:07:04 INFO - TEST-INFO | 3316: exit 0 00:07:04 INFO - Browser initialized. 00:07:04 INFO - Running cycle 1/1 for dromaeo_css test... 00:07:04 INFO - TEST-INFO | started process 3435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTD9GKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:07:06 INFO - PROCESS | 3435 | 00:07:06 INFO - PROCESS | 3435 | (process:3497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:07:16 INFO - PROCESS | 3435 | RSS: Main: 164192256 00:07:16 INFO - PROCESS | 3435 | 00:08:06 INFO - PROCESS | 3435 | 1460963286007 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:10:17 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:45294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45294/tests/dromaeo/cssquery-ext.html) 00:10:18 INFO - PROCESS | 3435 | RSS: Main: 169295872 00:10:18 INFO - PROCESS | 3435 | 00:13:20 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:45294/tests/dromaeo/cssquery-ext.html (next: http://localhost:45294/tests/dromaeo/cssquery-jquery.html) 00:13:21 INFO - PROCESS | 3435 | RSS: Main: 165191680 00:13:21 INFO - PROCESS | 3435 | 00:16:23 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:45294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45294/tests/dromaeo/cssquery-mootools.html) 00:16:23 INFO - PROCESS | 3435 | RSS: Main: 163897344 00:16:23 INFO - PROCESS | 3435 | 00:19:25 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:45294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45294/tests/dromaeo/cssquery-prototype.html) 00:19:26 INFO - PROCESS | 3435 | RSS: Main: 165031936 00:19:26 INFO - PROCESS | 3435 | 00:22:28 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:45294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45294/tests/dromaeo/cssquery-yui.html) 00:22:29 INFO - PROCESS | 3435 | RSS: Main: 164167680 00:22:29 INFO - PROCESS | 3435 | 00:25:31 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:45294/tests/dromaeo/cssquery-yui.html (next: http://localhost:45294/tests/dromaeo/cssquery-dojo.html) 00:25:32 INFO - PROCESS | 3435 | RSS: Main: 166236160 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | __start_tp_report 00:25:32 INFO - PROCESS | 3435 | _x_x_mozilla_page_load 00:25:32 INFO - PROCESS | 3435 | _x_x_mozilla_page_load_details 00:25:32 INFO - PROCESS | 3435 | |i|pagename|runs| 00:25:32 INFO - PROCESS | 3435 | |0;dojo.html;2610.8564028978403;2690.3812123211655;2698.0287096645216;2735.904243351482;2743.7530622244008;4738.170820106485;4754.572088512034;4780.7848646810935;4782.545658162478;4831.5168483151665;4686.859394218171;4799.7360145192;4818.060478206751;4871.12319782439;4901.779419926103;4354;4423.4028406165235;4473.686841921067;4491.034427598066;4517.3224016397635;371.35704145674146;4265.744055356673;4369.847055353063;4385.316339171599;4420.712653677517;4449.599536041739;4478.238699421074;4479.708818926776;4486.214912390335;4524.932126018112;4435.090806384684;4471.932921006188;4473.306637471197;4483.798229079699;4503.369528266046;4277.679174061957;4393.648508119343;4465.9106817863785;4479.3057076153245;4488.483824360175;4653.720776753372;4702.811887524529;4716.9292460613115;4727.621790256771;4752.287156926454;4951.183054795954;5140.665856719339;5142.408623008365;5147.150720131174;5206.453322401131;5040.7731652075745;5103.311053007834;5109.156989096832;5138.897222055538;5152.9484705152845;4757.952420475785;4793.472718001017;4799.496052914464;4803.735794531264;4843.321934929148;5106.897862042739;5262.947370526245;5270.1040823060175;5305.336832895888;5326.866828329323;5038.445770965191;5053.67151135175;5053.974730126326;5068.163752980717;5117.565006974449;5096.108181068298;5109.642325037286;5112.488751124858;5139.486051394831;5190.792368305301;5029.748512574357;5059.038782631288;5090.847274581768;5108.795648174106;5150.150225212873;5048.167052436307;5064.34163558735;5068.670536415121;5077.111505486599;5102.107131252016;4237.745735255895;4278.7860606969525;4300.182965236658;4306.2248795217165;4350.477942646839;3696.796676182782;3726.832292546842;3799.7340186187253;3829.368154254517;3868.052327179803;4299.441072660597;4360.062586543908;4380.014496738272;4410.514843367227;4519.88700282489;5142.04872098663;5150.459201783834;5155.484451554815;5160.612954028463;5196.090684130338;4287.485501739811;4365.934510982338;4421.845235416745;4426.048399594103;4436.778161091933;4570.245909424908;4619.076184763061;4620.052889157714;4643.489216186217;4668;4840.080384726891;4855.441624213261;4855.514448555187;4877.561019508261;4900.338454308623;4985.925211121908;5187.948120518747;5189.818356357509;5195.298634684269;5272.367315921961;4840.927386089282;4857.9028419432125;4871.439784424837;4880.585150262267;4910.386201724785;5072.771725272298;5073.7716802743225;5074.213496907838;5084.720340381166;5090.898182036412;4996.650234483552;5162.97418512905;5184.326037615086;5230.790768369375;5265.420803711665;4934.950650493593;4968.577670898014;4980.950190498049;4987.251912213197;5036.118679231193;4952.925706114339;4955.851324460272;4957.876053098557;4959;5013;4733.928991065206;4955.331030311006;4975.527324904128;5006.799728010838;5038.974805125951;5041.2438134280155;5057.165567681292;5079.593632509316;5090.4655011223285;5151.5106064923775;4784.976075119602;4973.850784476472;4977;4978.950210497848;4988.152014157675 00:25:32 INFO - PROCESS | 3435 | |1;ext.html;568.0882184094528;584.7865529081885;607.565590602719;610.100102349035;634.7175506899432;32426.351472970557;33602.49596256052;33664.4950325745;33797.831010844944;33839.32321353572;33598.32803343931;33746.662533374656;34042.48936265958;34176.316473670515;34290.14274643129;7534.8493030139225;7721.30508254257;7729.690812367498;7735.922640773605;7736.303732664059;7578.507397019176;7803.804904877366;7850.568218747967;7850.646720897574;7872.960635196816;7718.768436946901;7769.339606133485;7853.371730261594;7886.960565197194;7887.645055972466;7815.452918295721;7847.764567062997;7879.921200788005;7884.132745398002;7901.960490197513;7690.384769218449;7744;7767.339776119036;7789.571573563452;7794.571298578576;29485.262868428246;34424;34909;35194.82402587971;35307;2950.439416510856;3059.6175478065243;3083.260017595783;3186.0601122668636;3194.8881789137267;26418.471630567474;26869.865650671818;27378.178654640193;28089.438211235865;28300.292492687848;2883.480973424783;2946.602208701819;2949.601803756487;2983.8209707417623;2984.23901905015;225819;229871;230461;230637;231297;56233.71883140558;56820.71589642108;57274;57308.426915730306;57396.42603573911;61163;61581.69209154015;61728.382716172266;63972.36027639757;64128.679356602916;15577.221138943007;15737.44918927832;15865.20673966297;15903.761443578356;15913.840861591467;11259.09927205838;11333.829992550118;11398.94300528492;11435.714107147387;11483.311001339946;19032.143553540125;19144.138513766913;19535.609287814164;19661.311854085325;19792.50518737014;7392.334689877936;7407.555546667218;7440.85118297631;7455.2172021938;7644.6942122315595;838.308395573642;943.9858402123974;1063.1282348474176;1086.3807629651023;1087.8096333141668;28159.936343743946;28193.295167620563;28419;28474;28821.56767648487;1049.2130901823632;1064.2762921213648;1069.8288273876299;1114.3369695031442;1126.5831642292405;14869;15509.146996915053;15605.843941560666;15749.08641901252;15770.842291577166;582662;600248.9900403935;603104;603922;604058;50582.74708626433;51076.48923510792;51579;51696;51818.74090629523;1276.3873340796283;1283.8074288856747;1294.3657607772125;1319.399673148715;1323.4507679312978;24780.628290575296;25841.612375814755;25877.48245035051;26326.078587249354;28880;46667.299990499494;47510.52489475061;47817.76091119522;47887.60561971957;48117.518824811305;313584;315828;316024;316348;317028;38448.423273650355;39043.609563904;39292;39301;39873;43190.78404607957;43750.78124609357;43824.780876095414;43879.78060109679;44352.556474434845;37046.44430333493;37164;37382.439263410524;37454.62545374512;37626;36160;36237.0940726484;36346.27307453889;36463.27073458463;36712;32558.83720581382;35273.294534109686;36734.44898326581;37424.438633421065;38223.23553528858;29995;32328.676713232566;32615.836920815244;32772.34455310928;32946.17634559155;24027.27918162458;24204.273871783873;24514.264572062868;24895.87552062228;25074.3731406709 00:25:32 INFO - PROCESS | 3435 | |2;jquery.html;381.1424295335495;382.8755654412316;388.62303565541424;397.253164051583;403.16544752362586;13064.281464519448;15319.62123408893;16156.192190390493;17624.82375176248;17768.466945991626;15780.684386312296;15936.760948585752;16252.83747162528;17203.569910752238;17285.30858765651;4982.252662100677;5082.84751457456;5233.816816411427;5271.130263506517;5326.680399176043;5165.509276618715;5193.324867767185;5197.1424714922;5197.688138711689;5210.76551555181;5127.538521533062;5132.589392848582;5168.715720635363;5180.222966555009;5199.038177937075;5066.493350664922;5170.405403378584;5191.896162076775;5200.765965531541;5229.084910140729;4490.775461226958;4575.199340115467;4638.744869032202;4680.859574212745;4690.1557719610455;20140.798592014184;20312.69530957037;20556.28053018137;20720.689189662167;20922.790772092238;1902.838258748008;1960.6862901935622;2145.324222869807;2172.6958225848393;2411.9758802411925;13140.540081097211;13425.530106446227;13596.38816253271;13774;13920.51278205258;1769;1796.254554359939;1813.3562585282166;1824.9324145374972;1869.7943226245102;69485;69824.65087674529;70450.29549704489;70629;71391.28608713899;9552.713418597454;9605.519724013771;9830.230558499396;10006.099451049295;10025.949870250603;11944.223625464318;12721.363931803373;13855.237961912191;13920.721585568232;13944.58166255014;7337.88993165103;7373.29953654402;7666.156722760492;7676.53940763556;7782.610869456505;7261.237570055174;7268.345848873627;7277.89083163753;7344.045274114331;7442.479026468203;6189.597676151036;6226.719797609118;6286.277078135981;6331.240251169889;6396.328385519547;1784.4646606018143;1820.4356649438716;1829.9439935308067;1856.9628607427776;1886.2455017992913;857.9184977427259;859.0893652728129;874.6355685131216;891.2691592893894;928.4243768863213;15163.317650705523;16639.16804159787;16885.32458701663;17219.483415497554;17338.653226935392;876.2683159561838;915.5010519267015;917.8531434970506;953.5708930981086;961.3126614470548;9788.363756355815;9881.75295617601;9919.65281215154;9940.80118397628;9947;383718;394393;400870;400968;403103;71063.2893671067;71319.64340178265;71624.28375716176;71694.28305716877;75219;958.1807554540907;959.0122174160625;979.3095867413457;980.843065109579;983.6852207293597;15049.322780475124;15057.397704091714;15118.395264189308;15204.543863684106;15540.30068646891;31115.066548003597;32130.357392851543;32287.35425291528;33449.49825752664;33536.329273414885;35699.82150089233;40901;43472.56527434812;43725.78137109294;43817.780911095244;7080.787576372717;7371.189169191492;7427.294407031323;7431.628418578941;7463.141738700119;8252.958735206286;10117.949410252902;10397.376157430579;10400.479976001321;10485.26603137773;9561.713148605553;9562.808743825224;9757.21942244633;9759.121679048636;9858.112769850748;9133.178013978773;9481.810363792547;9564.95217523908;9636.71089867305;10178.440185789852;5552.833414997556;9722.319437639297;9770.36492627977;9818.509074546388;9870.309078364446;7418.848583575179;7430.7399241026305;7492.887606685795;7538.54768713857;7565.356944659766;7709.113451953097;9097.49963752;9718.319717619699;9914.851277230702;10015.048570385801 00:25:32 INFO - PROCESS | 3435 | |3;mootools.html;1410.5486244401789;1447.703220839728;1579.3524654891496;1752.4654980231041;1786.6069464717757;7038.894416583743;7617.238276172387;7704.229577042293;7846.921530784698;7893.960530197348;7800.2199780021965;7812.8046798830055;7826.943362646055;7869.9606501967555;7871;2205.184081889703;2222.4332795137216;2245.7529671736097;2246.1015593762545;2250.0662225176534;2216.966745498819;2230.0856648774006;2246;2247.314569056437;2263.151318255654;2187.7921597448217;2188.190369563256;2200.8129309008755;2242.0247192471247;2270.103309192876;2190.87950162741;2199.318211354477;2208.9668654970187;2215.401841502793;2216.822654187661;2154.8922553872244;2168.447046003275;2171.598254322955;2184.7815218478186;2187.431267870365;7830.725924592612;7880.881786773203;7948.5628290444;7974;8014.479058861214;4569.725816451024;4695.295705644181;4711.03423798124;4711.835085772016;4748.691335063209;2896.2904088498244;2968.7289223743855;2976.345204055104;3037.407705497429;3043.7564994800364;905.4069584422214;908.4231512989234;912.1744820937063;914.3690853311194;943.7876477792441;10901.945490272577;10925.289856159325;10979.83530247047;10988.725281868017;11043.39261340634;4159.396887451303;4272.829086836492;4371.344298355272;4377;4420.336949457607;9244.90755092454;9298.72103836886;9352.766180845534;9358;9360.4383736976;4787.640926930494;4806.206975848946;4808.471068182497;4812.278158276286;4818.204996175662;3814.9237015260096;4195.098053918361;4305.677074219446;4384.364267181241;4414.448193975753;3736.5142531470733;3752.2870654575545;3840.807959602009;3849.0377405648587;3856.633619806114;1212.5331747277185;1214.6356093172012;1225.601679454181;1230.132756406749;1230.6615680687883;776.8679324514846;814.2590242878952;879.1911441473859;895.4448242089946;911.8951320598084;5115.462876397999;5130;5292.153255479105;5292.338457692788;5303.337082864642;873.6854732296368;890.7817584691662;923.2936803345447;933.6172169410509;952.5999080386255;3583.6595523425235;3615.1142969972525;3618.656227658368;3663.8900832975055;3680.190358121209;9382.718518444457;9546.761330966781;9553.856692149624;9611.615535378507;9646.90353096474;9442.10300021497;9504.47725375111;9514.571844267024;9519.143277105093;9578.90421095794;7557.168711441737;7571.810704732316;7623.923760762322;7701.383889288843;7713.382929365637;5250.606204534599;5309.36287645485;5373.194020896896;5392.946070539245;5507.779688812403;9191.954040229755;9192.724218273463;9198.2181514572;9269.073092690676;9322.860157097784;9241.075892410705;9263.41848091908;9363.204127649225;9438.103380179147;9468.621255149717;5901.114832775118;6192.535559832941;6260.092286618506;6415.486761059197;6602.570832895846;7283.781486555412;7370.557766534025;7399.260073992773;7421.851562968603;7448.217937116741;6630.7679231226675;6975.232724400414;6976.790696279119;7007.719691212498;7127.572345659277;6832.214295356098;6857.862842743018;6890.20762612306;6991.335823096798;7036.401905837856;6101.7559297627595;6199.690015499297;6250.249970003629;6284.528660350401;6330.39861213184;4729.243321068612;4776.95223047779;4778.784954677118;4810.374651295309;4811.398575178103;4897.41231052276;4907.975460122677;4953.678010929278;4968.254761785761;4997.750112494288 00:25:32 INFO - PROCESS | 3435 | |4;prototype.html;319.7266337281624;320.3337058917452;322.41159883213135;330.9652486488919;332.8518809129935;5328.92006619901;5401.91897121543;5416.83749487515;5446.2647542581735;5472.206530053149;5325.467453254672;5337.092694241978;5349.117395629726;5355.571554275658;5368.597355198356;3980.900477488064;4032.9596704033024;4194.622483976442;4197.18154959783;4199.9790001050105;4183.079722461069;4194.203101410722;4210.0737837675815;4210.452641156646;4233.878022324071;4178.728382655133;4183.079722461053;4188.9946412861;4195.035141917361;4200.285951388256;4060.472138621975;4150.3566947123245;4164.104717485725;4183.435236243129;4205.600467955539;3662.9633703663153;3677.0991107178643;3685.0787303174206;3685.760425572356;3686.6129056448954;5070.315507406527;5095.955329157514;5098.311727916721;5099.33708617881;5137.356046065223;4665.113628410591;4738.455077666078;4784.976075119637;4788.186008378584;4792.233242681189;5532.806351777709;5566.944330556724;5592.105263157916;5620.831375058755;5633.718314084321;4008.9799551002056;4009.3785463253244;4021.2962731521866;4032.3145065338963;4037.6164264394833;5653.462921022497;5846;5848.122781582754;5864.44287792659;5887.205227294303;4146.253674338648;4148.43996060534;4158.251514727318;4160.292750232467;4175.812088456027;4176.707630465899;4180.289350810309;4192.161567686414;4226.915461690811;4227.302495088337;4408.647308215335;4730.219513780256;4732.881677958078;4746.881327966759;4772.76136193189;5623.943760562342;5626.493615574536;5629.774809007676;5635.633683810539;5650.604457688005;1406.4303956897472;1431.9069260498243;1433.3120102350929;1434.075021611055;1437.0802686280788;889.3018980100719;930.8789857318505;957.9521023948914;971.0726256425097;973.5105288907982;4802.807887684454;4821.590164835958;4845.103655823684;4886.096072226649;4890.657653964188;5735.254416925856;5757.193992841006;5769.769209231584;5773.1051686988585;5779.711014449261;4614.515475874985;4851.151048566487;4859.514048595183;4873.902521949542;4971.304017437562;3123.4377811993604;3147.3390587976783;3151.6375616803903;3161.7944833585743;3172.936541269162;5532.529734972572;5537.667739935617;5542.612017158841;5550.389457159709;5550.944490555043;5929.881402371929;5969.910451343233;6018.518518518508;6055.666938318347;6073.787417440369;5472.398036216013;5472.808451704331;5479.780808767684;5498.890022199534;5510.256115424527;5643.294588176478;5864.384239654775;5876.767777722151;5877.794277200277;5895.528357731286;5727.1695604138;5743.483086522233;5755.453231942959;5762.337331206965;5770.6249093808765;5491.807786727445;5495.505404513613;5497.917531237114;5498.505134537911;5499.450054994469;3881.243157584244;3965.702572307031;3996.0009997500624;4004.619561141687;4012;5819.418058194146;5828.446297601721;5830.912536311874;5841.299044114733;5883.705814709162;5638.5771067170945;5660.37735849048;5673.971630141823;5688.260526131742;5711.485966263056;5469.288992430958;5644.689542075225;5648.971755141362;5684.459976302244;5697.658140511582;5289.894202116013;5550.27846379968;5571.192177134212;5577.581681373832;5602.1036634138345;5443.891122177455;5654.575906806924;5656.264685590847;5656.6888821115235;5675.517581005661;5488.530161427294;5498.340199176125;5504.422035686355;5537.086380747292;5556.38879723222 00:25:32 INFO - PROCESS | 3435 | |5;yui.html;672.1060988884784;675.4731309578527;745.1244787374836;759.6163937211708;786.9055713314403;11681.182317237797;12744.107912446132;13037.869621303797;13041.80437293439;13061.346932653378;12238.75522489552;13523.729525409486;14009.929950350233;14015.719685606307;14026.158430494177;824.3817137147124;832.5837081459271;832.8917240758693;833.2459124492344;834.0200264688997;644.9838754031164;803.8874557561917;805.1063319715112;824.773187373471;828.7265202483167;853.1042405474258;861.8793368928355;867.0202670981781;867.8611422172454;869.613022205119;853.6286715278874;856.1994535109661;858.9477889585271;864.4121997042009;865.7489328094845;624.3475568031419;626;626.2297374229723;626.8056902360283;630.4609558827183;13421.932890335584;13443.462261509529;13518.256495892721;13532.458701651922;13556;12297;12477.563285285063;12511.436985335682;12665.620031399072;12811.871881281255;10193.439360835151;10370.481475926174;10411.427371494565;10424;10687.358758474438;3318.2699806042633;3345;3380.9661903380897;3452.68925796677;3479.425894727367;47376.5262347379;48575.27137092982;48609.75695121537;48908.26637600439;49043;9855.704328870002;9936.254780891462;10058.8491172631;10146.239032072624;10202.540885660163;17354.305827766748;17472.301107955795;17495.475135745946;17516.299348025936;17561.824381756276;6467.385598368148;6476.740930362733;6505.8698826024165;6517.641529715911;6667.933320666828;3662.432322989941;3663.230721548505;3682.8895133146048;3717.8326975286177;3738.719596030309;2851.871665775045;2999.79001469895;3003.339265361617;3004.9699503005127;3006.6842981487066;515.4227265462706;517.2758138605907;526.8682829292677;529.499622856397;533.3999250842802;530.3158924986801;583.5623282538096;601.885641728079;624.1199908129515;624.631467434216;8067.031956165298;8108.83782324362;8214.917850821535;8252.793680158044;8286.627101780434;568.5338022821247;584.961977471463;586.2876604924951;641.5412979719523;655.3053763011224;3872.386363071092;3902.20004898995;3996.9400458993136;4022.1151346703678;4048.6963477739287;47676.761616191696;47785.28322075102;48877;48981.51018489769;52946;44004.77997609991;44287.778561106985;44918;44921.32618010667;46120.308195377096;33414.66585334164;33860.15349616279;40026.399604005965;41329.38005929913;42419.57580424218;8271.586420679063;8446.746597602081;8663;8664.870026949475;8808.86786698213;25077.74922250754;25252.494950101263;25540.23379298624;25715;29022.564661529672;31141.53287700641;34533.82733086318;35319.470207947415;35654;35941;10976.560937562408;11035.613753518588;11192.664220073411;11223.0460410866;11246.100311975186;11932.940335298268;12054.035677145632;12185.69535761613;12288.692782680504;12330.938345308216;11231.15766317513;11271.267367621078;11411;11497.080233581126;11518.596849110241;11160.330380177214;11245.662630121109;11265.943670281924;11735.882641173821;11908.52365905354;11112.888871111185;11190.552377904793;11421.639019559298;11610.361430121424;11743.647690569296;8896.688615898413;9054.909450905407;9296.39573427725;9383.671571494964;9973.45146016947;9466.337356384987;9751.3661611995;10132.544035518273;10169.9491502542;10195.7451063724 00:25:32 INFO - PROCESS | 3435 | __end_tp_report 00:25:32 INFO - PROCESS | 3435 | __start_cc_report 00:25:32 INFO - PROCESS | 3435 | _x_x_mozilla_cycle_collect,344 00:25:32 INFO - PROCESS | 3435 | __end_cc_report 00:25:32 INFO - PROCESS | 3435 | __startTimestamp1460964332001__endTimestamp 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | ------- Summary: start ------- 00:25:32 INFO - PROCESS | 3435 | Number of tests: 6 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | [#0] dojo.html Cycles:165 Average:4719.45 Median:4877.56 stddev:603.09 (12.4%) stddev-sans-first:581.81 00:25:32 INFO - PROCESS | 3435 | Values: 2610.9 2690.4 2698.0 2735.9 2743.8 4738.2 4754.6 4780.8 4782.5 4831.5 4686.9 4799.7 4818.1 4871.1 4901.8 4354.0 4423.4 4473.7 4491.0 4517.3 371.4 4265.7 4369.8 4385.3 4420.7 4449.6 4478.2 4479.7 4486.2 4524.9 4435.1 4471.9 4473.3 4483.8 4503.4 4277.7 4393.6 4465.9 4479.3 4488.5 4653.7 4702.8 4716.9 4727.6 4752.3 4951.2 5140.7 5142.4 5147.2 5206.5 5040.8 5103.3 5109.2 5138.9 5152.9 4758.0 4793.5 4799.5 4803.7 4843.3 5106.9 5262.9 5270.1 5305.3 5326.9 5038.4 5053.7 5054.0 5068.2 5117.6 5096.1 5109.6 5112.5 5139.5 5190.8 5029.7 5059.0 5090.8 5108.8 5150.2 5048.2 5064.3 5068.7 5077.1 5102.1 4237.7 4278.8 4300.2 4306.2 4350.5 3696.8 3726.8 3799.7 3829.4 3868.1 4299.4 4360.1 4380.0 4410.5 4519.9 5142.0 5150.5 5155.5 5160.6 5196.1 4287.5 4365.9 4421.8 4426.0 4436.8 4570.2 4619.1 4620.1 4643.5 4668.0 4840.1 4855.4 4855.5 4877.6 4900.3 4985.9 5187.9 5189.8 5195.3 5272.4 4840.9 4857.9 4871.4 4880.6 4910.4 5072.8 5073.8 5074.2 5084.7 5090.9 4996.7 5163.0 5184.3 5230.8 5265.4 4935.0 4968.6 4981.0 4987.3 5036.1 4952.9 4955.9 4957.9 4959.0 5013.0 4733.9 4955.3 4975.5 5006.8 5039.0 5041.2 5057.2 5079.6 5090.5 5151.5 4785.0 4973.9 4977.0 4979.0 4988.2 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | [#1] ext.html Cycles:180 Average:53169.21 Median:34666.50 stddev:110550.40 (318.9%) stddev-sans-first:110789.97 00:25:32 INFO - PROCESS | 3435 | Values: 568.1 584.8 607.6 610.1 634.7 32426.4 33602.5 33664.5 33797.8 33839.3 33598.3 33746.7 34042.5 34176.3 34290.1 7534.8 7721.3 7729.7 7735.9 7736.3 7578.5 7803.8 7850.6 7850.6 7873.0 7718.8 7769.3 7853.4 7887.0 7887.6 7815.5 7847.8 7879.9 7884.1 7902.0 7690.4 7744.0 7767.3 7789.6 7794.6 29485.3 34424.0 34909.0 35194.8 35307.0 2950.4 3059.6 3083.3 3186.1 3194.9 26418.5 26869.9 27378.2 28089.4 28300.3 2883.5 2946.6 2949.6 2983.8 2984.2 225819.0 229871.0 230461.0 230637.0 231297.0 56233.7 56820.7 57274.0 57308.4 57396.4 61163.0 61581.7 61728.4 63972.4 64128.7 15577.2 15737.4 15865.2 15903.8 15913.8 11259.1 11333.8 11398.9 11435.7 11483.3 19032.1 19144.1 19535.6 19661.3 19792.5 7392.3 7407.6 7440.9 7455.2 7644.7 838.3 944.0 1063.1 1086.4 1087.8 28159.9 28193.3 28419.0 28474.0 28821.6 1049.2 1064.3 1069.8 1114.3 1126.6 14869.0 15509.1 15605.8 15749.1 15770.8 582662.0 600249.0 603104.0 603922.0 604058.0 50582.7 51076.5 51579.0 51696.0 51818.7 1276.4 1283.8 1294.4 1319.4 1323.5 24780.6 25841.6 25877.5 26326.1 28880.0 46667.3 47510.5 47817.8 47887.6 48117.5 313584.0 315828.0 316024.0 316348.0 317028.0 38448.4 39043.6 39292.0 39301.0 39873.0 43190.8 43750.8 43824.8 43879.8 44352.6 37046.4 37164.0 37382.4 37454.6 37626.0 36160.0 36237.1 36346.3 36463.3 36712.0 32558.8 35273.3 36734.4 37424.4 38223.2 29995.0 32328.7 32615.8 32772.3 32946.2 24027.3 24204.3 24514.3 24895.9 25074.4 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | [#2] jquery.html Cycles:180 Average:23953.38 Median:5175.31 stddev:65272.10 (1261.2%) stddev-sans-first:65431.21 00:25:32 INFO - PROCESS | 3435 | Values: 381.1 382.9 388.6 397.3 403.2 13064.3 15319.6 16156.2 17624.8 17768.5 15780.7 15936.8 16252.8 17203.6 17285.3 4982.3 5082.8 5233.8 5271.1 5326.7 5165.5 5193.3 5197.1 5197.7 5210.8 5127.5 5132.6 5168.7 5180.2 5199.0 5066.5 5170.4 5191.9 5200.8 5229.1 4490.8 4575.2 4638.7 4680.9 4690.2 20140.8 20312.7 20556.3 20720.7 20922.8 1902.8 1960.7 2145.3 2172.7 2412.0 13140.5 13425.5 13596.4 13774.0 13920.5 1769.0 1796.3 1813.4 1824.9 1869.8 69485.0 69824.7 70450.3 70629.0 71391.3 9552.7 9605.5 9830.2 10006.1 10025.9 11944.2 12721.4 13855.2 13920.7 13944.6 7337.9 7373.3 7666.2 7676.5 7782.6 7261.2 7268.3 7277.9 7344.0 7442.5 6189.6 6226.7 6286.3 6331.2 6396.3 1784.5 1820.4 1829.9 1857.0 1886.2 857.9 859.1 874.6 891.3 928.4 15163.3 16639.2 16885.3 17219.5 17338.7 876.3 915.5 917.9 953.6 961.3 9788.4 9881.8 9919.7 9940.8 9947.0 383718.0 394393.0 400870.0 400968.0 403103.0 71063.3 71319.6 71624.3 71694.3 75219.0 958.2 959.0 979.3 980.8 983.7 15049.3 15057.4 15118.4 15204.5 15540.3 31115.1 32130.4 32287.4 33449.5 33536.3 35699.8 40901.0 43472.6 43725.8 43817.8 7080.8 7371.2 7427.3 7431.6 7463.1 8253.0 10117.9 10397.4 10400.5 10485.3 9561.7 9562.8 9757.2 9759.1 9858.1 9133.2 9481.8 9565.0 9636.7 10178.4 5552.8 9722.3 9770.4 9818.5 9870.3 7418.8 7430.7 7492.9 7538.5 7565.4 7709.1 9097.5 9718.3 9914.9 10015.0 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | [#3] mootools.html Cycles:180 Average:5224.34 Median:5306.35 stddev:2902.02 (54.7%) stddev-sans-first:2896.01 00:25:32 INFO - PROCESS | 3435 | Values: 1410.5 1447.7 1579.4 1752.5 1786.6 7038.9 7617.2 7704.2 7846.9 7894.0 7800.2 7812.8 7826.9 7870.0 7871.0 2205.2 2222.4 2245.8 2246.1 2250.1 2217.0 2230.1 2246.0 2247.3 2263.2 2187.8 2188.2 2200.8 2242.0 2270.1 2190.9 2199.3 2209.0 2215.4 2216.8 2154.9 2168.4 2171.6 2184.8 2187.4 7830.7 7880.9 7948.6 7974.0 8014.5 4569.7 4695.3 4711.0 4711.8 4748.7 2896.3 2968.7 2976.3 3037.4 3043.8 905.4 908.4 912.2 914.4 943.8 10901.9 10925.3 10979.8 10988.7 11043.4 4159.4 4272.8 4371.3 4377.0 4420.3 9244.9 9298.7 9352.8 9358.0 9360.4 4787.6 4806.2 4808.5 4812.3 4818.2 3814.9 4195.1 4305.7 4384.4 4414.4 3736.5 3752.3 3840.8 3849.0 3856.6 1212.5 1214.6 1225.6 1230.1 1230.7 776.9 814.3 879.2 895.4 911.9 5115.5 5130.0 5292.2 5292.3 5303.3 873.7 890.8 923.3 933.6 952.6 3583.7 3615.1 3618.7 3663.9 3680.2 9382.7 9546.8 9553.9 9611.6 9646.9 9442.1 9504.5 9514.6 9519.1 9578.9 7557.2 7571.8 7623.9 7701.4 7713.4 5250.6 5309.4 5373.2 5392.9 5507.8 9192.0 9192.7 9198.2 9269.1 9322.9 9241.1 9263.4 9363.2 9438.1 9468.6 5901.1 6192.5 6260.1 6415.5 6602.6 7283.8 7370.6 7399.3 7421.9 7448.2 6630.8 6975.2 6976.8 7007.7 7127.6 6832.2 6857.9 6890.2 6991.3 7036.4 6101.8 6199.7 6250.2 6284.5 6330.4 4729.2 4777.0 4778.8 4810.4 4811.4 4897.4 4908.0 4953.7 4968.3 4997.8 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | [#4] prototype.html Cycles:180 Average:4673.57 Median:5362.08 stddev:1364.68 (25.5%) stddev-sans-first:1328.81 00:25:32 INFO - PROCESS | 3435 | Values: 319.7 320.3 322.4 331.0 332.9 5328.9 5401.9 5416.8 5446.3 5472.2 5325.5 5337.1 5349.1 5355.6 5368.6 3980.9 4033.0 4194.6 4197.2 4200.0 4183.1 4194.2 4210.1 4210.5 4233.9 4178.7 4183.1 4189.0 4195.0 4200.3 4060.5 4150.4 4164.1 4183.4 4205.6 3663.0 3677.1 3685.1 3685.8 3686.6 5070.3 5096.0 5098.3 5099.3 5137.4 4665.1 4738.5 4785.0 4788.2 4792.2 5532.8 5566.9 5592.1 5620.8 5633.7 4009.0 4009.4 4021.3 4032.3 4037.6 5653.5 5846.0 5848.1 5864.4 5887.2 4146.3 4148.4 4158.3 4160.3 4175.8 4176.7 4180.3 4192.2 4226.9 4227.3 4408.6 4730.2 4732.9 4746.9 4772.8 5623.9 5626.5 5629.8 5635.6 5650.6 1406.4 1431.9 1433.3 1434.1 1437.1 889.3 930.9 958.0 971.1 973.5 4802.8 4821.6 4845.1 4886.1 4890.7 5735.3 5757.2 5769.8 5773.1 5779.7 4614.5 4851.2 4859.5 4873.9 4971.3 3123.4 3147.3 3151.6 3161.8 3172.9 5532.5 5537.7 5542.6 5550.4 5550.9 5929.9 5969.9 6018.5 6055.7 6073.8 5472.4 5472.8 5479.8 5498.9 5510.3 5643.3 5864.4 5876.8 5877.8 5895.5 5727.2 5743.5 5755.5 5762.3 5770.6 5491.8 5495.5 5497.9 5498.5 5499.5 3881.2 3965.7 3996.0 4004.6 4012.0 5819.4 5828.4 5830.9 5841.3 5883.7 5638.6 5660.4 5674.0 5688.3 5711.5 5469.3 5644.7 5649.0 5684.5 5697.7 5289.9 5550.3 5571.2 5577.6 5602.1 5443.9 5654.6 5656.3 5656.7 5675.5 5488.5 5498.3 5504.4 5537.1 5556.4 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - PROCESS | 3435 | [#5] yui.html Cycles:180 Average:12563.03 Median:22011.67 stddev:13735.48 (62.4%) stddev-sans-first:13744.99 00:25:32 INFO - PROCESS | 3435 | Values: 672.1 675.5 745.1 759.6 786.9 11681.2 12744.1 13037.9 13041.8 13061.3 12238.8 13523.7 14009.9 14015.7 14026.2 824.4 832.6 832.9 833.2 834.0 645.0 803.9 805.1 824.8 828.7 853.1 861.9 867.0 867.9 869.6 853.6 856.2 858.9 864.4 865.7 624.3 626.0 626.2 626.8 630.5 13421.9 13443.5 13518.3 13532.5 13556.0 12297.0 12477.6 12511.4 12665.6 12811.9 10193.4 10370.5 10411.4 10424.0 10687.4 3318.3 3345.0 3381.0 3452.7 3479.4 47376.5 48575.3 48609.8 48908.3 49043.0 9855.7 9936.3 10058.8 10146.2 10202.5 17354.3 17472.3 17495.5 17516.3 17561.8 6467.4 6476.7 6505.9 6517.6 6667.9 3662.4 3663.2 3682.9 3717.8 3738.7 2851.9 2999.8 3003.3 3005.0 3006.7 515.4 517.3 526.9 529.5 533.4 530.3 583.6 601.9 624.1 624.6 8067.0 8108.8 8214.9 8252.8 8286.6 568.5 585.0 586.3 641.5 655.3 3872.4 3902.2 3996.9 4022.1 4048.7 47676.8 47785.3 48877.0 48981.5 52946.0 44004.8 44287.8 44918.0 44921.3 46120.3 33414.7 33860.2 40026.4 41329.4 42419.6 8271.6 8446.7 8663.0 8664.9 8808.9 25077.7 25252.5 25540.2 25715.0 29022.6 31141.5 34533.8 35319.5 35654.0 35941.0 10976.6 11035.6 11192.7 11223.0 11246.1 11932.9 12054.0 12185.7 12288.7 12330.9 11231.2 11271.3 11411.0 11497.1 11518.6 11160.3 11245.7 11265.9 11735.9 11908.5 11112.9 11190.6 11421.6 11610.4 11743.6 8896.7 9054.9 9296.4 9383.7 9973.5 9466.3 9751.4 10132.5 10169.9 10195.7 00:25:32 INFO - PROCESS | 3435 | -------- Summary: end -------- 00:25:32 INFO - PROCESS | 3435 | 00:25:32 INFO - TEST-INFO | 3435: exit 0 00:25:32 INFO - TEST-OK | dromaeo_css | took 1115838ms 00:25:32 INFO - TEST-START | kraken 00:25:32 INFO - operating with platform_type : linux_ 00:25:32 INFO - Initialising browser for kraken test... 00:25:32 INFO - TEST-INFO | started process 3670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSXDRT/profile http://localhost:45294/getInfo.html) 00:25:36 INFO - PROCESS | 3670 | 00:25:36 INFO - PROCESS | 3670 | (process:3739): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:25:36 INFO - PROCESS | 3670 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 00:25:37 INFO - PROCESS | 3670 | __metrics Screen width/height:1600/1200 00:25:37 INFO - PROCESS | 3670 | colorDepth:24 00:25:37 INFO - PROCESS | 3670 | Browser inner width/height: 1024/697 00:25:37 INFO - PROCESS | 3670 | __metrics 00:25:38 ERROR - PROCESS | 3670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 00:25:39 INFO - TEST-INFO | 3670: exit 0 00:25:39 INFO - Browser initialized. 00:25:39 INFO - Running cycle 1/1 for kraken test... 00:25:39 INFO - TEST-INFO | started process 3790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSXDRT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:25:40 INFO - PROCESS | 3790 | 00:25:40 INFO - PROCESS | 3790 | (process:3848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:25:50 INFO - PROCESS | 3790 | RSS: Main: 164462592 00:25:50 INFO - PROCESS | 3790 | 00:25:53 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45294/tests/kraken/driver.html?testName=audio-beat-detection) 00:25:54 INFO - PROCESS | 3790 | RSS: Main: 169209856 00:25:54 INFO - PROCESS | 3790 | 00:25:57 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45294/tests/kraken/driver.html?testName=audio-dft) 00:25:58 INFO - PROCESS | 3790 | RSS: Main: 172679168 00:25:58 INFO - PROCESS | 3790 | 00:26:00 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45294/tests/kraken/driver.html?testName=audio-fft) 00:26:01 INFO - PROCESS | 3790 | RSS: Main: 163348480 00:26:01 INFO - PROCESS | 3790 | 00:26:03 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45294/tests/kraken/driver.html?testName=audio-oscillator) 00:26:04 INFO - PROCESS | 3790 | RSS: Main: 163057664 00:26:04 INFO - PROCESS | 3790 | 00:26:06 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:26:07 INFO - PROCESS | 3790 | RSS: Main: 164646912 00:26:07 INFO - PROCESS | 3790 | 00:26:10 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45294/tests/kraken/driver.html?testName=imaging-darkroom) 00:26:11 INFO - PROCESS | 3790 | RSS: Main: 164966400 00:26:11 INFO - PROCESS | 3790 | 00:26:14 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45294/tests/kraken/driver.html?testName=imaging-desaturate) 00:26:15 INFO - PROCESS | 3790 | RSS: Main: 164171776 00:26:15 INFO - PROCESS | 3790 | 00:26:18 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45294/tests/kraken/driver.html?testName=json-parse-financial) 00:26:18 INFO - PROCESS | 3790 | RSS: Main: 164855808 00:26:18 INFO - PROCESS | 3790 | 00:26:20 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:26:21 INFO - PROCESS | 3790 | RSS: Main: 164958208 00:26:21 INFO - PROCESS | 3790 | 00:26:22 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:26:23 INFO - PROCESS | 3790 | RSS: Main: 165236736 00:26:23 INFO - PROCESS | 3790 | 00:26:25 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:26:26 INFO - PROCESS | 3790 | RSS: Main: 165384192 00:26:26 INFO - PROCESS | 3790 | 00:26:29 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:26:29 INFO - PROCESS | 3790 | RSS: Main: 165879808 00:26:29 INFO - PROCESS | 3790 | 00:26:32 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:26:33 INFO - PROCESS | 3790 | RSS: Main: 165736448 00:26:33 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:45294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45294/tests/kraken/driver.html?testName=ai-astar) 00:26:35 INFO - PROCESS | 3790 | RSS: Main: 167501824 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | __start_tp_report 00:26:35 INFO - PROCESS | 3790 | _x_x_mozilla_page_load 00:26:35 INFO - PROCESS | 3790 | _x_x_mozilla_page_load_details 00:26:35 INFO - PROCESS | 3790 | |i|pagename|runs| 00:26:35 INFO - PROCESS | 3790 | |0;ai-astar;118;111;114;114;116;129;114;115;113;113 00:26:35 INFO - PROCESS | 3790 | |1;audio-beat-detection;167;135;157;182;134;166;160;133;198;136 00:26:35 INFO - PROCESS | 3790 | |2;audio-dft;163;164;168;178;163;164;160;165;163;161 00:26:35 INFO - PROCESS | 3790 | |3;audio-fft;77;75;73;157;75;82;76;75;161;78 00:26:35 INFO - PROCESS | 3790 | |4;audio-oscillator;94;93;150;94;94;93;140;94;93;142 00:26:35 INFO - PROCESS | 3790 | |5;imaging-gaussian-blur;118;118;118;118;117;117;117;118;118;118 00:26:35 INFO - PROCESS | 3790 | |6;imaging-darkroom;148;147;148;148;147;147;147;149;148;149 00:26:35 INFO - PROCESS | 3790 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 00:26:35 INFO - PROCESS | 3790 | |8;json-parse-financial;66;68;66;66;68;66;67;88;65;64 00:26:35 INFO - PROCESS | 3790 | |9;json-stringify-tinderbox;64;65;64;65;65;64;64;65;64;64 00:26:35 INFO - PROCESS | 3790 | |10;stanford-crypto-aes;79;88;81;80;78;88;83;82;81;81 00:26:35 INFO - PROCESS | 3790 | |11;stanford-crypto-ccm;138;140;134;137;137;135;133;134;179;136 00:26:35 INFO - PROCESS | 3790 | |12;stanford-crypto-pbkdf2;184;182;178;178;185;181;182;172;173;174 00:26:35 INFO - PROCESS | 3790 | |13;stanford-crypto-sha256-iterative;83;76;73;79;74;77;76;74;72;71 00:26:35 INFO - PROCESS | 3790 | __end_tp_report 00:26:35 INFO - PROCESS | 3790 | __start_cc_report 00:26:35 INFO - PROCESS | 3790 | _x_x_mozilla_cycle_collect,916 00:26:35 INFO - PROCESS | 3790 | __end_cc_report 00:26:35 INFO - PROCESS | 3790 | __startTimestamp1460964395559__endTimestamp 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | ------- Summary: start ------- 00:26:35 INFO - PROCESS | 3790 | Number of tests: 14 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#0] ai-astar Cycles:10 Average:115.70 Median:114.50 stddev:5.03 (4.4%) stddev-sans-first:5.27 00:26:35 INFO - PROCESS | 3790 | Values: 118.0 111.0 114.0 114.0 116.0 129.0 114.0 115.0 113.0 113.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:163.00 stddev:22.42 (13.8%) stddev-sans-first:23.48 00:26:35 INFO - PROCESS | 3790 | Values: 167.0 135.0 157.0 182.0 134.0 166.0 160.0 133.0 198.0 136.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:5.09 (3.1%) stddev-sans-first:5.35 00:26:35 INFO - PROCESS | 3790 | Values: 163.0 164.0 168.0 178.0 163.0 164.0 160.0 165.0 163.0 161.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:34.93 (46.3%) stddev-sans-first:36.58 00:26:35 INFO - PROCESS | 3790 | Values: 77.0 75.0 73.0 157.0 75.0 82.0 76.0 75.0 161.0 78.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.50 stddev:24.49 (26.2%) stddev-sans-first:25.39 00:26:35 INFO - PROCESS | 3790 | Values: 94.0 93.0 150.0 94.0 94.0 93.0 140.0 94.0 93.0 142.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:26:35 INFO - PROCESS | 3790 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 00:26:35 INFO - PROCESS | 3790 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 147.0 149.0 148.0 149.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 00:26:35 INFO - PROCESS | 3790 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:66.50 stddev:7.00 (10.5%) stddev-sans-first:7.37 00:26:35 INFO - PROCESS | 3790 | Values: 66.0 68.0 66.0 66.0 68.0 66.0 67.0 88.0 65.0 64.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 00:26:35 INFO - PROCESS | 3790 | Values: 64.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.50 stddev:3.41 (4.2%) stddev-sans-first:3.43 00:26:35 INFO - PROCESS | 3790 | Values: 79.0 88.0 81.0 80.0 78.0 88.0 83.0 82.0 81.0 81.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:137.00 stddev:13.76 (10.0%) stddev-sans-first:14.57 00:26:35 INFO - PROCESS | 3790 | Values: 138.0 140.0 134.0 137.0 137.0 135.0 133.0 134.0 179.0 136.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:181.50 stddev:4.65 (2.6%) stddev-sans-first:4.56 00:26:35 INFO - PROCESS | 3790 | Values: 184.0 182.0 178.0 178.0 185.0 181.0 182.0 172.0 173.0 174.0 00:26:35 INFO - PROCESS | 3790 | 00:26:35 INFO - PROCESS | 3790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:76.00 stddev:3.57 (4.7%) stddev-sans-first:2.55 00:26:35 INFO - PROCESS | 3790 | Values: 83.0 76.0 73.0 79.0 74.0 77.0 76.0 74.0 72.0 71.0 00:26:35 INFO - PROCESS | 3790 | -------- Summary: end -------- 00:26:35 INFO - PROCESS | 3790 | 00:26:36 INFO - TEST-INFO | 3790: exit 0 00:26:36 INFO - TEST-OK | kraken | took 63830ms 00:26:36 INFO - SUITE-END | took 1179s 00:26:36 INFO - Completed test suite (00:19:39) 00:26:36 INFO - javascript benchmark 00:26:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.8564028978403, 2690.3812123211655, 2698.0287096645216, 2735.904243351482, 2743.7530622244008, 4738.170820106485, 4754.572088512034, 4780.7848646810935, 4782.545658162478, 4831.5168483151665, 4686.859394218171, 4799.7360145192, 4818.060478206751, 4871.12319782439, 4901.779419926103, 4354.0, 4423.4028406165235, 4473.686841921067, 4491.034427598066, 4517.3224016397635, 371.35704145674146, 4265.744055356673, 4369.847055353063, 4385.316339171599, 4420.712653677517, 4449.599536041739, 4478.238699421074, 4479.708818926776, 4486.214912390335, 4524.932126018112, 4435.090806384684, 4471.932921006188, 4473.306637471197, 4483.798229079699, 4503.369528266046, 4277.679174061957, 4393.648508119343, 4465.9106817863785, 4479.3057076153245, 4488.483824360175, 4653.720776753372, 4702.811887524529, 4716.9292460613115, 4727.621790256771, 4752.287156926454, 4951.183054795954, 5140.665856719339, 5142.408623008365, 5147.150720131174, 5206.453322401131, 5040.7731652075745, 5103.311053007834, 5109.156989096832, 5138.897222055538, 5152.9484705152845, 4757.952420475785, 4793.472718001017, 4799.496052914464, 4803.735794531264, 4843.321934929148, 5106.897862042739, 5262.947370526245, 5270.1040823060175, 5305.336832895888, 5326.866828329323, 5038.445770965191, 5053.67151135175, 5053.974730126326, 5068.163752980717, 5117.565006974449, 5096.108181068298, 5109.642325037286, 5112.488751124858, 5139.486051394831, 5190.792368305301, 5029.748512574357, 5059.038782631288, 5090.847274581768, 5108.795648174106, 5150.150225212873, 5048.167052436307, 5064.34163558735, 5068.670536415121, 5077.111505486599, 5102.107131252016, 4237.745735255895, 4278.7860606969525, 4300.182965236658, 4306.2248795217165, 4350.477942646839, 3696.796676182782, 3726.832292546842, 3799.7340186187253, 3829.368154254517, 3868.052327179803, 4299.441072660597, 4360.062586543908, 4380.014496738272, 4410.514843367227, 4519.88700282489, 5142.04872098663, 5150.459201783834, 5155.484451554815, 5160.612954028463, 5196.090684130338, 4287.485501739811, 4365.934510982338, 4421.845235416745, 4426.048399594103, 4436.778161091933, 4570.245909424908, 4619.076184763061, 4620.052889157714, 4643.489216186217, 4668.0, 4840.080384726891, 4855.441624213261, 4855.514448555187, 4877.561019508261, 4900.338454308623, 4985.925211121908, 5187.948120518747, 5189.818356357509, 5195.298634684269, 5272.367315921961, 4840.927386089282, 4857.9028419432125, 4871.439784424837, 4880.585150262267, 4910.386201724785, 5072.771725272298, 5073.7716802743225, 5074.213496907838, 5084.720340381166, 5090.898182036412, 4996.650234483552, 5162.97418512905, 5184.326037615086, 5230.790768369375, 5265.420803711665, 4934.950650493593, 4968.577670898014, 4980.950190498049, 4987.251912213197, 5036.118679231193, 4952.925706114339, 4955.851324460272, 4957.876053098557, 4959.0, 5013.0, 4733.928991065206, 4955.331030311006, 4975.527324904128, 5006.799728010838, 5038.974805125951, 5041.2438134280155, 5057.165567681292, 5079.593632509316, 5090.4655011223285, 5151.5106064923775, 4784.976075119602, 4973.850784476472, 4977.0, 4978.950210497848, 4988.152014157675], "value": 4683.147719757573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.0882184094528, 584.7865529081885, 607.565590602719, 610.100102349035, 634.7175506899432, 32426.351472970557, 33602.49596256052, 33664.4950325745, 33797.831010844944, 33839.32321353572, 33598.32803343931, 33746.662533374656, 34042.48936265958, 34176.316473670515, 34290.14274643129, 7534.8493030139225, 7721.30508254257, 7729.690812367498, 7735.922640773605, 7736.303732664059, 7578.507397019176, 7803.804904877366, 7850.568218747967, 7850.646720897574, 7872.960635196816, 7718.768436946901, 7769.339606133485, 7853.371730261594, 7886.960565197194, 7887.645055972466, 7815.452918295721, 7847.764567062997, 7879.921200788005, 7884.132745398002, 7901.960490197513, 7690.384769218449, 7744.0, 7767.339776119036, 7789.571573563452, 7794.571298578576, 29485.262868428246, 34424.0, 34909.0, 35194.82402587971, 35307.0, 2950.439416510856, 3059.6175478065243, 3083.260017595783, 3186.0601122668636, 3194.8881789137267, 26418.471630567474, 26869.865650671818, 27378.178654640193, 28089.438211235865, 28300.292492687848, 2883.480973424783, 2946.602208701819, 2949.601803756487, 2983.8209707417623, 2984.23901905015, 225819.0, 229871.0, 230461.0, 230637.0, 231297.0, 56233.71883140558, 56820.71589642108, 57274.0, 57308.426915730306, 57396.42603573911, 61163.0, 61581.69209154015, 61728.382716172266, 63972.36027639757, 64128.679356602916, 15577.221138943007, 15737.44918927832, 15865.20673966297, 15903.761443578356, 15913.840861591467, 11259.09927205838, 11333.829992550118, 11398.94300528492, 11435.714107147387, 11483.311001339946, 19032.143553540125, 19144.138513766913, 19535.609287814164, 19661.311854085325, 19792.50518737014, 7392.334689877936, 7407.555546667218, 7440.85118297631, 7455.2172021938, 7644.6942122315595, 838.308395573642, 943.9858402123974, 1063.1282348474176, 1086.3807629651023, 1087.8096333141668, 28159.936343743946, 28193.295167620563, 28419.0, 28474.0, 28821.56767648487, 1049.2130901823632, 1064.2762921213648, 1069.8288273876299, 1114.3369695031442, 1126.5831642292405, 14869.0, 15509.146996915053, 15605.843941560666, 15749.08641901252, 15770.842291577166, 582662.0, 600248.9900403935, 603104.0, 603922.0, 604058.0, 50582.74708626433, 51076.48923510792, 51579.0, 51696.0, 51818.74090629523, 1276.3873340796283, 1283.8074288856747, 1294.3657607772125, 1319.399673148715, 1323.4507679312978, 24780.628290575296, 25841.612375814755, 25877.48245035051, 26326.078587249354, 28880.0, 46667.299990499494, 47510.52489475061, 47817.76091119522, 47887.60561971957, 48117.518824811305, 313584.0, 315828.0, 316024.0, 316348.0, 317028.0, 38448.423273650355, 39043.609563904, 39292.0, 39301.0, 39873.0, 43190.78404607957, 43750.78124609357, 43824.780876095414, 43879.78060109679, 44352.556474434845, 37046.44430333493, 37164.0, 37382.439263410524, 37454.62545374512, 37626.0, 36160.0, 36237.0940726484, 36346.27307453889, 36463.27073458463, 36712.0, 32558.83720581382, 35273.294534109686, 36734.44898326581, 37424.438633421065, 38223.23553528858, 29995.0, 32328.676713232566, 32615.836920815244, 32772.34455310928, 32946.17634559155, 24027.27918162458, 24204.273871783873, 24514.264572062868, 24895.87552062228, 25074.3731406709], "value": 18071.941970835313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1424295335495, 382.8755654412316, 388.62303565541424, 397.253164051583, 403.16544752362586, 13064.281464519448, 15319.62123408893, 16156.192190390493, 17624.82375176248, 17768.466945991626, 15780.684386312296, 15936.760948585752, 16252.83747162528, 17203.569910752238, 17285.30858765651, 4982.252662100677, 5082.84751457456, 5233.816816411427, 5271.130263506517, 5326.680399176043, 5165.509276618715, 5193.324867767185, 5197.1424714922, 5197.688138711689, 5210.76551555181, 5127.538521533062, 5132.589392848582, 5168.715720635363, 5180.222966555009, 5199.038177937075, 5066.493350664922, 5170.405403378584, 5191.896162076775, 5200.765965531541, 5229.084910140729, 4490.775461226958, 4575.199340115467, 4638.744869032202, 4680.859574212745, 4690.1557719610455, 20140.798592014184, 20312.69530957037, 20556.28053018137, 20720.689189662167, 20922.790772092238, 1902.838258748008, 1960.6862901935622, 2145.324222869807, 2172.6958225848393, 2411.9758802411925, 13140.540081097211, 13425.530106446227, 13596.38816253271, 13774.0, 13920.51278205258, 1769.0, 1796.254554359939, 1813.3562585282166, 1824.9324145374972, 1869.7943226245102, 69485.0, 69824.65087674529, 70450.29549704489, 70629.0, 71391.28608713899, 9552.713418597454, 9605.519724013771, 9830.230558499396, 10006.099451049295, 10025.949870250603, 11944.223625464318, 12721.363931803373, 13855.237961912191, 13920.721585568232, 13944.58166255014, 7337.88993165103, 7373.29953654402, 7666.156722760492, 7676.53940763556, 7782.610869456505, 7261.237570055174, 7268.345848873627, 7277.89083163753, 7344.045274114331, 7442.479026468203, 6189.597676151036, 6226.719797609118, 6286.277078135981, 6331.240251169889, 6396.328385519547, 1784.4646606018143, 1820.4356649438716, 1829.9439935308067, 1856.9628607427776, 1886.2455017992913, 857.9184977427259, 859.0893652728129, 874.6355685131216, 891.2691592893894, 928.4243768863213, 15163.317650705523, 16639.16804159787, 16885.32458701663, 17219.483415497554, 17338.653226935392, 876.2683159561838, 915.5010519267015, 917.8531434970506, 953.5708930981086, 961.3126614470548, 9788.363756355815, 9881.75295617601, 9919.65281215154, 9940.80118397628, 9947.0, 383718.0, 394393.0, 400870.0, 400968.0, 403103.0, 71063.2893671067, 71319.64340178265, 71624.28375716176, 71694.28305716877, 75219.0, 958.1807554540907, 959.0122174160625, 979.3095867413457, 980.843065109579, 983.6852207293597, 15049.322780475124, 15057.397704091714, 15118.395264189308, 15204.543863684106, 15540.30068646891, 31115.066548003597, 32130.357392851543, 32287.35425291528, 33449.49825752664, 33536.329273414885, 35699.82150089233, 40901.0, 43472.56527434812, 43725.78137109294, 43817.780911095244, 7080.787576372717, 7371.189169191492, 7427.294407031323, 7431.628418578941, 7463.141738700119, 8252.958735206286, 10117.949410252902, 10397.376157430579, 10400.479976001321, 10485.26603137773, 9561.713148605553, 9562.808743825224, 9757.21942244633, 9759.121679048636, 9858.112769850748, 9133.178013978773, 9481.810363792547, 9564.95217523908, 9636.71089867305, 10178.440185789852, 5552.833414997556, 9722.319437639297, 9770.36492627977, 9818.509074546388, 9870.309078364446, 7418.848583575179, 7430.7399241026305, 7492.887606685795, 7538.54768713857, 7565.356944659766, 7709.113451953097, 9097.49963752, 9718.319717619699, 9914.851277230702, 10015.048570385801], "value": 8172.39958977952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.5486244401789, 1447.703220839728, 1579.3524654891496, 1752.4654980231041, 1786.6069464717757, 7038.894416583743, 7617.238276172387, 7704.229577042293, 7846.921530784698, 7893.960530197348, 7800.2199780021965, 7812.8046798830055, 7826.943362646055, 7869.9606501967555, 7871.0, 2205.184081889703, 2222.4332795137216, 2245.7529671736097, 2246.1015593762545, 2250.0662225176534, 2216.966745498819, 2230.0856648774006, 2246.0, 2247.314569056437, 2263.151318255654, 2187.7921597448217, 2188.190369563256, 2200.8129309008755, 2242.0247192471247, 2270.103309192876, 2190.87950162741, 2199.318211354477, 2208.9668654970187, 2215.401841502793, 2216.822654187661, 2154.8922553872244, 2168.447046003275, 2171.598254322955, 2184.7815218478186, 2187.431267870365, 7830.725924592612, 7880.881786773203, 7948.5628290444, 7974.0, 8014.479058861214, 4569.725816451024, 4695.295705644181, 4711.03423798124, 4711.835085772016, 4748.691335063209, 2896.2904088498244, 2968.7289223743855, 2976.345204055104, 3037.407705497429, 3043.7564994800364, 905.4069584422214, 908.4231512989234, 912.1744820937063, 914.3690853311194, 943.7876477792441, 10901.945490272577, 10925.289856159325, 10979.83530247047, 10988.725281868017, 11043.39261340634, 4159.396887451303, 4272.829086836492, 4371.344298355272, 4377.0, 4420.336949457607, 9244.90755092454, 9298.72103836886, 9352.766180845534, 9358.0, 9360.4383736976, 4787.640926930494, 4806.206975848946, 4808.471068182497, 4812.278158276286, 4818.204996175662, 3814.9237015260096, 4195.098053918361, 4305.677074219446, 4384.364267181241, 4414.448193975753, 3736.5142531470733, 3752.2870654575545, 3840.807959602009, 3849.0377405648587, 3856.633619806114, 1212.5331747277185, 1214.6356093172012, 1225.601679454181, 1230.132756406749, 1230.6615680687883, 776.8679324514846, 814.2590242878952, 879.1911441473859, 895.4448242089946, 911.8951320598084, 5115.462876397999, 5130.0, 5292.153255479105, 5292.338457692788, 5303.337082864642, 873.6854732296368, 890.7817584691662, 923.2936803345447, 933.6172169410509, 952.5999080386255, 3583.6595523425235, 3615.1142969972525, 3618.656227658368, 3663.8900832975055, 3680.190358121209, 9382.718518444457, 9546.761330966781, 9553.856692149624, 9611.615535378507, 9646.90353096474, 9442.10300021497, 9504.47725375111, 9514.571844267024, 9519.143277105093, 9578.90421095794, 7557.168711441737, 7571.810704732316, 7623.923760762322, 7701.383889288843, 7713.382929365637, 5250.606204534599, 5309.36287645485, 5373.194020896896, 5392.946070539245, 5507.779688812403, 9191.954040229755, 9192.724218273463, 9198.2181514572, 9269.073092690676, 9322.860157097784, 9241.075892410705, 9263.41848091908, 9363.204127649225, 9438.103380179147, 9468.621255149717, 5901.114832775118, 6192.535559832941, 6260.092286618506, 6415.486761059197, 6602.570832895846, 7283.781486555412, 7370.557766534025, 7399.260073992773, 7421.851562968603, 7448.217937116741, 6630.7679231226675, 6975.232724400414, 6976.790696279119, 7007.719691212498, 7127.572345659277, 6832.214295356098, 6857.862842743018, 6890.20762612306, 6991.335823096798, 7036.401905837856, 6101.7559297627595, 6199.690015499297, 6250.249970003629, 6284.528660350401, 6330.39861213184, 4729.243321068612, 4776.95223047779, 4778.784954677118, 4810.374651295309, 4811.398575178103, 4897.41231052276, 4907.975460122677, 4953.678010929278, 4968.254761785761, 4997.750112494288], "value": 4224.923465790804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.7266337281624, 320.3337058917452, 322.41159883213135, 330.9652486488919, 332.8518809129935, 5328.92006619901, 5401.91897121543, 5416.83749487515, 5446.2647542581735, 5472.206530053149, 5325.467453254672, 5337.092694241978, 5349.117395629726, 5355.571554275658, 5368.597355198356, 3980.900477488064, 4032.9596704033024, 4194.622483976442, 4197.18154959783, 4199.9790001050105, 4183.079722461069, 4194.203101410722, 4210.0737837675815, 4210.452641156646, 4233.878022324071, 4178.728382655133, 4183.079722461053, 4188.9946412861, 4195.035141917361, 4200.285951388256, 4060.472138621975, 4150.3566947123245, 4164.104717485725, 4183.435236243129, 4205.600467955539, 3662.9633703663153, 3677.0991107178643, 3685.0787303174206, 3685.760425572356, 3686.6129056448954, 5070.315507406527, 5095.955329157514, 5098.311727916721, 5099.33708617881, 5137.356046065223, 4665.113628410591, 4738.455077666078, 4784.976075119637, 4788.186008378584, 4792.233242681189, 5532.806351777709, 5566.944330556724, 5592.105263157916, 5620.831375058755, 5633.718314084321, 4008.9799551002056, 4009.3785463253244, 4021.2962731521866, 4032.3145065338963, 4037.6164264394833, 5653.462921022497, 5846.0, 5848.122781582754, 5864.44287792659, 5887.205227294303, 4146.253674338648, 4148.43996060534, 4158.251514727318, 4160.292750232467, 4175.812088456027, 4176.707630465899, 4180.289350810309, 4192.161567686414, 4226.915461690811, 4227.302495088337, 4408.647308215335, 4730.219513780256, 4732.881677958078, 4746.881327966759, 4772.76136193189, 5623.943760562342, 5626.493615574536, 5629.774809007676, 5635.633683810539, 5650.604457688005, 1406.4303956897472, 1431.9069260498243, 1433.3120102350929, 1434.075021611055, 1437.0802686280788, 889.3018980100719, 930.8789857318505, 957.9521023948914, 971.0726256425097, 973.5105288907982, 4802.807887684454, 4821.590164835958, 4845.103655823684, 4886.096072226649, 4890.657653964188, 5735.254416925856, 5757.193992841006, 5769.769209231584, 5773.1051686988585, 5779.711014449261, 4614.515475874985, 4851.151048566487, 4859.514048595183, 4873.902521949542, 4971.304017437562, 3123.4377811993604, 3147.3390587976783, 3151.6375616803903, 3161.7944833585743, 3172.936541269162, 5532.529734972572, 5537.667739935617, 5542.612017158841, 5550.389457159709, 5550.944490555043, 5929.881402371929, 5969.910451343233, 6018.518518518508, 6055.666938318347, 6073.787417440369, 5472.398036216013, 5472.808451704331, 5479.780808767684, 5498.890022199534, 5510.256115424527, 5643.294588176478, 5864.384239654775, 5876.767777722151, 5877.794277200277, 5895.528357731286, 5727.1695604138, 5743.483086522233, 5755.453231942959, 5762.337331206965, 5770.6249093808765, 5491.807786727445, 5495.505404513613, 5497.917531237114, 5498.505134537911, 5499.450054994469, 3881.243157584244, 3965.702572307031, 3996.0009997500624, 4004.619561141687, 4012.0, 5819.418058194146, 5828.446297601721, 5830.912536311874, 5841.299044114733, 5883.705814709162, 5638.5771067170945, 5660.37735849048, 5673.971630141823, 5688.260526131742, 5711.485966263056, 5469.288992430958, 5644.689542075225, 5648.971755141362, 5684.459976302244, 5697.658140511582, 5289.894202116013, 5550.27846379968, 5571.192177134212, 5577.581681373832, 5602.1036634138345, 5443.891122177455, 5654.575906806924, 5656.264685590847, 5656.6888821115235, 5675.517581005661, 5488.530161427294, 5498.340199176125, 5504.422035686355, 5537.086380747292, 5556.38879723222], "value": 4237.082029002951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.1060988884784, 675.4731309578527, 745.1244787374836, 759.6163937211708, 786.9055713314403, 11681.182317237797, 12744.107912446132, 13037.869621303797, 13041.80437293439, 13061.346932653378, 12238.75522489552, 13523.729525409486, 14009.929950350233, 14015.719685606307, 14026.158430494177, 824.3817137147124, 832.5837081459271, 832.8917240758693, 833.2459124492344, 834.0200264688997, 644.9838754031164, 803.8874557561917, 805.1063319715112, 824.773187373471, 828.7265202483167, 853.1042405474258, 861.8793368928355, 867.0202670981781, 867.8611422172454, 869.613022205119, 853.6286715278874, 856.1994535109661, 858.9477889585271, 864.4121997042009, 865.7489328094845, 624.3475568031419, 626.0, 626.2297374229723, 626.8056902360283, 630.4609558827183, 13421.932890335584, 13443.462261509529, 13518.256495892721, 13532.458701651922, 13556.0, 12297.0, 12477.563285285063, 12511.436985335682, 12665.620031399072, 12811.871881281255, 10193.439360835151, 10370.481475926174, 10411.427371494565, 10424.0, 10687.358758474438, 3318.2699806042633, 3345.0, 3380.9661903380897, 3452.68925796677, 3479.425894727367, 47376.5262347379, 48575.27137092982, 48609.75695121537, 48908.26637600439, 49043.0, 9855.704328870002, 9936.254780891462, 10058.8491172631, 10146.239032072624, 10202.540885660163, 17354.305827766748, 17472.301107955795, 17495.475135745946, 17516.299348025936, 17561.824381756276, 6467.385598368148, 6476.740930362733, 6505.8698826024165, 6517.641529715911, 6667.933320666828, 3662.432322989941, 3663.230721548505, 3682.8895133146048, 3717.8326975286177, 3738.719596030309, 2851.871665775045, 2999.79001469895, 3003.339265361617, 3004.9699503005127, 3006.6842981487066, 515.4227265462706, 517.2758138605907, 526.8682829292677, 529.499622856397, 533.3999250842802, 530.3158924986801, 583.5623282538096, 601.885641728079, 624.1199908129515, 624.631467434216, 8067.031956165298, 8108.83782324362, 8214.917850821535, 8252.793680158044, 8286.627101780434, 568.5338022821247, 584.961977471463, 586.2876604924951, 641.5412979719523, 655.3053763011224, 3872.386363071092, 3902.20004898995, 3996.9400458993136, 4022.1151346703678, 4048.6963477739287, 47676.761616191696, 47785.28322075102, 48877.0, 48981.51018489769, 52946.0, 44004.77997609991, 44287.778561106985, 44918.0, 44921.32618010667, 46120.308195377096, 33414.66585334164, 33860.15349616279, 40026.399604005965, 41329.38005929913, 42419.57580424218, 8271.586420679063, 8446.746597602081, 8663.0, 8664.870026949475, 8808.86786698213, 25077.74922250754, 25252.494950101263, 25540.23379298624, 25715.0, 29022.564661529672, 31141.53287700641, 34533.82733086318, 35319.470207947415, 35654.0, 35941.0, 10976.560937562408, 11035.613753518588, 11192.664220073411, 11223.0460410866, 11246.100311975186, 11932.940335298268, 12054.035677145632, 12185.69535761613, 12288.692782680504, 12330.938345308216, 11231.15766317513, 11271.267367621078, 11411.0, 11497.080233581126, 11518.596849110241, 11160.330380177214, 11245.662630121109, 11265.943670281924, 11735.882641173821, 11908.52365905354, 11112.888871111185, 11190.552377904793, 11421.639019559298, 11610.361430121424, 11743.647690569296, 8896.688615898413, 9054.909450905407, 9296.39573427725, 9383.671571494964, 9973.45146016947, 9466.337356384987, 9751.3661611995, 10132.544035518273, 10169.9491502542, 10195.7451063724], "value": 6002.74460691747, "unit": "score"}], "name": "dromaeo_css", "value": 6484.287405581071, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 111.0, 114.0, 114.0, 116.0, 129.0, 114.0, 115.0, 113.0, 113.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 135.0, 157.0, 182.0, 134.0, 166.0, 160.0, 133.0, 198.0, 136.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 168.0, 178.0, 163.0, 164.0, 160.0, 165.0, 163.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 73.0, 157.0, 75.0, 82.0, 76.0, 75.0, 161.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 150.0, 94.0, 94.0, 93.0, 140.0, 94.0, 93.0, 142.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 148.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 66.0, 68.0, 66.0, 67.0, 88.0, 65.0, 64.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 81.0, 80.0, 78.0, 88.0, 83.0, 82.0, 81.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 134.0, 137.0, 137.0, 135.0, 133.0, 134.0, 179.0, 136.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 178.0, 178.0, 185.0, 181.0, 182.0, 172.0, 173.0, 174.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 73.0, 79.0, 74.0, 77.0, 76.0, 74.0, 72.0, 71.0], "value": 75.5, "unit": "score"}], "name": "kraken", "value": 1609.1000000000001, "alertThreshold": 2.0}]} 00:26:36 INFO - Return code: 0 00:26:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:26:36 ERROR - # TBPL SUCCESS # 00:26:36 INFO - Running post-action listener: _resource_record_post_action 00:26:36 INFO - Running post-run listener: _resource_record_post_run 00:26:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8069120; Write bytes: 413782016; Read time: 2004; Write time: 349440 00:26:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 49676288; Read time: 84; Write time: 29168 00:26:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8060928; Write bytes: 364105728; Read time: 1904; Write time: 320272 00:26:37 INFO - Running post-run listener: _upload_blobber_files 00:26:37 INFO - Blob upload gear active. 00:26:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:26:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:26:37 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'] 00:26:37 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 00:26:38 INFO - (blobuploader) - INFO - Open directory for files ... 00:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:39 INFO - (blobuploader) - INFO - Done attempting. 00:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:40 INFO - (blobuploader) - INFO - Done attempting. 00:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 00:26:40 INFO - Return code: 0 00:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2f77b67d268cbd8d38da5b32e068217b7488daa93c4f2b9e335d84f77c65c61ddaccf7da28531a61bb47de8eff21f8259bf0aea45a84db7706aa951a2f6a30b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fa9e8df0bc562e0bca6274362079678c939ddd478fc0367c83d907d56c429d9e5311c9678424b7259b7e5be715c124fa35052366b8c9e190cb2a744ef32c3a2"} 00:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:26:40 INFO - Contents: 00:26:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2f77b67d268cbd8d38da5b32e068217b7488daa93c4f2b9e335d84f77c65c61ddaccf7da28531a61bb47de8eff21f8259bf0aea45a84db7706aa951a2f6a30b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fa9e8df0bc562e0bca6274362079678c939ddd478fc0367c83d907d56c429d9e5311c9678424b7259b7e5be715c124fa35052366b8c9e190cb2a744ef32c3a2"} 00:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 00:26:40 INFO - Copying logs to upload dir... 00:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 00:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.678731 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-18 00:26:40.035128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 00:26:40.038463) ========= 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=db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271 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/f2f77b67d268cbd8d38da5b32e068217b7488daa93c4f2b9e335d84f77c65c61ddaccf7da28531a61bb47de8eff21f8259bf0aea45a84db7706aa951a2f6a30b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fa9e8df0bc562e0bca6274362079678c939ddd478fc0367c83d907d56c429d9e5311c9678424b7259b7e5be715c124fa35052366b8c9e190cb2a744ef32c3a2"} build_url:https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/UhpVGlG0T568KyS13TnsKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2f77b67d268cbd8d38da5b32e068217b7488daa93c4f2b9e335d84f77c65c61ddaccf7da28531a61bb47de8eff21f8259bf0aea45a84db7706aa951a2f6a30b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fa9e8df0bc562e0bca6274362079678c939ddd478fc0367c83d907d56c429d9e5311c9678424b7259b7e5be715c124fa35052366b8c9e190cb2a744ef32c3a2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 00:26:40.064203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:26:40.064600) ========= 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=db0483c52d987ecb441a263b000001ad-1460954211.882088-674885271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 00:26:40.147286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 00:26:40.147632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 00:26:40.147948) ========= ========= Total master_lag: 0.17 =========