builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1460667622.71 results: success (0) buildid: 20160414113023 builduid: 217139d6c37f45b3a8cb45b7f1ca307b revision: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.709348) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.709800) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.710136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.727036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.727310) ========= 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=aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 14:00:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-14 14:00:22 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.846379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.846711) ========= 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=aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021952 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.897256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:22.897628) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bce3f1720e66a9cdc1a1699d3fd24a598641969 --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 1bce3f1720e66a9cdc1a1699d3fd24a598641969 --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=aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 14:00:23,048 truncating revision to first 12 chars 2016-04-14 14:00:23,048 Setting DEBUG logging. 2016-04-14 14:00:23,048 attempt 1/10 2016-04-14 14:00:23,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bce3f1720e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 14:00:23,299 unpacking tar archive at: fx-team-1bce3f1720e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:23.438402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:23.438725) ========= script_repo_revision: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:23.440279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:23.440660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:23.449376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-14 14:00:23.449750) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:23 INFO - MultiFileLogger online at 20160414 14:00:23 in /builds/slave/test 14:00:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:00:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:00:23 INFO - {'append_to_log': False, 14:00:23 INFO - 'base_work_dir': '/builds/slave/test', 14:00:23 INFO - 'blob_upload_branch': 'Fx-Team', 14:00:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:00:23 INFO - 'branch': 'Fx-Team', 14:00:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:23 INFO - 'config_files': ('talos/linux_config.py',), 14:00:23 INFO - 'default_actions': ('clobber', 14:00:23 INFO - 'read-buildbot-config', 14:00:23 INFO - 'download-and-extract', 14:00:23 INFO - 'populate-webroot', 14:00:23 INFO - 'create-virtualenv', 14:00:23 INFO - 'install', 14:00:23 INFO - 'run-tests'), 14:00:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:23 INFO - 'download_minidump_stackwalk': True, 14:00:23 INFO - 'download_symbols': 'ondemand', 14:00:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:23 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:23 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:23 INFO - 'installer_path': 'installer.exe', 14:00:23 INFO - 'log_level': 'info', 14:00:23 INFO - 'log_name': 'talos', 14:00:23 INFO - 'log_to_console': True, 14:00:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:23 INFO - 'opt_config_files': (), 14:00:23 INFO - 'pip_index': False, 14:00:23 INFO - 'sps_profile': False, 14:00:23 INFO - 'sps_profile_interval': 0, 14:00:23 INFO - 'suite': 'dromaeojs-e10s', 14:00:23 INFO - 'system_bits': '32', 14:00:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:23 INFO - 'title': 'talos-linux64-ix-009', 14:00:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:23 INFO - 'use_talos_json': True, 14:00:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:00:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:23 INFO - 'work_dir': 'build'} 14:00:23 INFO - ##### 14:00:23 INFO - ##### Running clobber step. 14:00:23 INFO - ##### 14:00:23 INFO - Running pre-action listener: _resource_record_pre_action 14:00:23 INFO - Running main action method: clobber 14:00:23 INFO - rmtree: /builds/slave/test/build 14:00:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:00:24 INFO - Running post-action listener: _resource_record_post_action 14:00:24 INFO - ##### 14:00:24 INFO - ##### Running read-buildbot-config step. 14:00:24 INFO - ##### 14:00:24 INFO - Running pre-action listener: _resource_record_pre_action 14:00:24 INFO - Running main action method: read_buildbot_config 14:00:24 INFO - Using buildbot properties: 14:00:24 INFO - { 14:00:24 INFO - "project": "", 14:00:24 INFO - "product": "firefox", 14:00:24 INFO - "script_repo_revision": "production", 14:00:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:00:24 INFO - "repository": "", 14:00:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:00:24 INFO - "buildid": "20160414113023", 14:00:24 INFO - "pgo_build": "True", 14:00:24 INFO - "basedir": "/builds/slave/test", 14:00:24 INFO - "buildnumber": 651, 14:00:24 INFO - "slavename": "talos-linux64-ix-009", 14:00:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:00:24 INFO - "platform": "ubuntu64_hw", 14:00:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:00:24 INFO - "branch": "fx-team", 14:00:24 INFO - "repo_path": "integration/fx-team", 14:00:24 INFO - "revision": "1bce3f1720e66a9cdc1a1699d3fd24a598641969", 14:00:24 INFO - "stage_platform": "linux64-pgo", 14:00:24 INFO - "builduid": "217139d6c37f45b3a8cb45b7f1ca307b", 14:00:24 INFO - "slavebuilddir": "test" 14:00:24 INFO - } 14:00:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:00:24 INFO - Running post-action listener: _resource_record_post_action 14:00:24 INFO - ##### 14:00:24 INFO - ##### Running download-and-extract step. 14:00:24 INFO - ##### 14:00:24 INFO - Running pre-action listener: _resource_record_pre_action 14:00:24 INFO - Running main action method: download_and_extract 14:00:24 INFO - mkdir: /builds/slave/test/build/tests 14:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:24 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:34 INFO - Downloaded 1361 bytes. 14:00:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:34 INFO - Using the following test package requirements: 14:00:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:00:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:00:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'jsshell-linux-x86_64.zip'], 14:00:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:00:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:00:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:00:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:00:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:00:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:34 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:57 INFO - Downloaded 23774556 bytes. 14:00:57 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'] 14:00:57 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 14:00:58 INFO - Return code: 0 14:00:58 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 14:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:58 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:01:02 INFO - Downloaded 23774556 bytes. 14:01:02 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'] 14:01:02 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 14:01:03 INFO - Return code: 0 14:01:03 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')]} 14:01:03 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:01:05 INFO - Downloaded 10841076 bytes. 14:01:05 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'] 14:01:05 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 14:01:05 INFO - Return code: 0 14:01:05 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')]} 14:01:05 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:01:07 INFO - Downloaded 58153627 bytes. 14:01:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:07 INFO - mkdir: /builds/slave/test/properties 14:01:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:07 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:07 INFO - Contents: 14:01:07 INFO - build_url:https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:08 INFO - Running post-action listener: _resource_record_post_action 14:01:08 INFO - Running post-action listener: set_extra_try_arguments 14:01:08 INFO - ##### 14:01:08 INFO - ##### Running populate-webroot step. 14:01:08 INFO - ##### 14:01:08 INFO - Running pre-action listener: _resource_record_pre_action 14:01:08 INFO - Running main action method: populate_webroot 14:01:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:08 INFO - '--tppagecycles', 14:01:08 INFO - '7'], 14:01:08 INFO - 'tests': ['tsvgm']}}, 14:01:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:01:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:01:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['damp', 'tps']}, 14:01:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'tests': ['damp', 'tps']}, 14:01:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['dromaeo_dom']}, 14:01:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['a11yr', 14:01:08 INFO - 'ts_paint', 14:01:08 INFO - 'tpaint', 14:01:08 INFO - 'sessionrestore', 14:01:08 INFO - 'sessionrestore_no_auto_restore', 14:01:08 INFO - 'tabpaint']}, 14:01:08 INFO - 'other-e10s': {'tests': ['a11yr', 14:01:08 INFO - 'ts_paint', 14:01:08 INFO - 'tpaint', 14:01:08 INFO - 'sessionrestore', 14:01:08 INFO - 'sessionrestore_no_auto_restore', 14:01:08 INFO - 'tabpaint']}, 14:01:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:01:08 INFO - 'ts_paint', 14:01:08 INFO - 'tpaint', 14:01:08 INFO - 'sessionrestore', 14:01:08 INFO - 'sessionrestore_no_auto_restore', 14:01:08 INFO - 'tabpaint']}, 14:01:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:01:08 INFO - 'ts_paint', 14:01:08 INFO - 'tpaint', 14:01:08 INFO - 'sessionrestore', 14:01:08 INFO - 'sessionrestore_no_auto_restore', 14:01:08 INFO - 'tabpaint']}, 14:01:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['a11yr', 14:01:08 INFO - 'ts_paint', 14:01:08 INFO - 'tpaint', 14:01:08 INFO - 'sessionrestore', 14:01:08 INFO - 'sessionrestore_no_auto_restore', 14:01:08 INFO - 'tabpaint']}, 14:01:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['a11yr', 14:01:08 INFO - 'ts_paint', 14:01:08 INFO - 'tpaint', 14:01:08 INFO - 'sessionrestore', 14:01:08 INFO - 'sessionrestore_no_auto_restore', 14:01:08 INFO - 'tabpaint']}, 14:01:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['tsvgx', 14:01:08 INFO - 'tsvgr_opacity', 14:01:08 INFO - 'tart', 14:01:08 INFO - 'tscrollx', 14:01:08 INFO - 'cart']}, 14:01:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:01:08 INFO - 'tsvgr_opacity', 14:01:08 INFO - 'tart', 14:01:08 INFO - 'tscrollx', 14:01:08 INFO - 'cart']}, 14:01:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'talos_options': ['--disable-e10s'], 14:01:08 INFO - 'tests': ['tp5o']}, 14:01:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'tests': ['tp5o']}, 14:01:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'talos_options': ['--disable-e10s', 14:01:08 INFO - '--xperf_path', 14:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:08 INFO - 'tests': ['tp5n']}, 14:01:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:08 INFO - 'talos_options': ['--xperf_path', 14:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:08 INFO - 'tests': ['tp5n']}}, 14:01:08 INFO - 'talos.zip': {'path': '', 14:01:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:08 INFO - Running post-action listener: _resource_record_post_action 14:01:08 INFO - ##### 14:01:08 INFO - ##### Running create-virtualenv step. 14:01:08 INFO - ##### 14:01:08 INFO - Running pre-action listener: _resource_record_pre_action 14:01:08 INFO - Running main action method: create_virtualenv 14:01:08 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:08 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 14:01:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:08 INFO - Using real prefix '/usr' 14:01:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:11 INFO - Installing pip.................done. 14:01:11 INFO - Return code: 0 14:01:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:11 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:11 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 14:01:11 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 14:01:11 INFO - Using env: {'DISPLAY': ':0', 14:01:11 INFO - 'HOME': '/home/cltbld', 14:01:11 INFO - 'LANG': 'en_US.UTF-8', 14:01:11 INFO - 'LANGUAGE': 'en_US:en', 14:01:11 INFO - 'LOGNAME': 'cltbld', 14:01:11 INFO - 'MAIL': '/var/mail/cltbld', 14:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:11 INFO - 'MOZ_NO_REMOTE': '1', 14:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:11 INFO - 'NO_EM_RESTART': '1', 14:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:11 INFO - 'PWD': '/builds/slave/test', 14:01:11 INFO - 'SHELL': '/bin/bash', 14:01:11 INFO - 'SHLVL': '1', 14:01:11 INFO - 'TERM': 'linux', 14:01:11 INFO - 'TMOUT': '86400', 14:01:11 INFO - 'USER': 'cltbld', 14:01:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:11 INFO - '_': '/tools/buildbot/bin/python'} 14:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:11 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 14:01:11 INFO - Cleaning up... 14:01:11 INFO - Return code: 0 14:01:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:11 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:11 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 14:01:11 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 14:01:11 INFO - Using env: {'DISPLAY': ':0', 14:01:11 INFO - 'HOME': '/home/cltbld', 14:01:11 INFO - 'LANG': 'en_US.UTF-8', 14:01:11 INFO - 'LANGUAGE': 'en_US:en', 14:01:11 INFO - 'LOGNAME': 'cltbld', 14:01:11 INFO - 'MAIL': '/var/mail/cltbld', 14:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:11 INFO - 'MOZ_NO_REMOTE': '1', 14:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:11 INFO - 'NO_EM_RESTART': '1', 14:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:11 INFO - 'PWD': '/builds/slave/test', 14:01:11 INFO - 'SHELL': '/bin/bash', 14:01:11 INFO - 'SHLVL': '1', 14:01:11 INFO - 'TERM': 'linux', 14:01:11 INFO - 'TMOUT': '86400', 14:01:11 INFO - 'USER': 'cltbld', 14:01:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:11 INFO - '_': '/tools/buildbot/bin/python'} 14:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:11 INFO - Downloading/unpacking psutil>=0.7.1 14:01:11 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 14:01:11 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 14:01:11 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 14:01:11 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 14:01:11 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 14:01:11 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 14:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:13 INFO - Installing collected packages: psutil 14:01:13 INFO - Running setup.py install for psutil 14:01:13 INFO - building 'psutil._psutil_linux' extension 14:01:13 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 14:01:14 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 14:01:14 INFO - building 'psutil._psutil_posix' extension 14:01:14 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 14:01:14 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 14:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:14 INFO - Successfully installed psutil 14:01:14 INFO - Cleaning up... 14:01:14 INFO - Return code: 0 14:01:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:01:14 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')]} 14:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:14 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')]} 14:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:14 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:14 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 14:01:14 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 14:01:14 INFO - Using env: {'DISPLAY': ':0', 14:01:14 INFO - 'HOME': '/home/cltbld', 14:01:14 INFO - 'LANG': 'en_US.UTF-8', 14:01:14 INFO - 'LANGUAGE': 'en_US:en', 14:01:14 INFO - 'LOGNAME': 'cltbld', 14:01:14 INFO - 'MAIL': '/var/mail/cltbld', 14:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:14 INFO - 'MOZ_NO_REMOTE': '1', 14:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:14 INFO - 'NO_EM_RESTART': '1', 14:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:14 INFO - 'PWD': '/builds/slave/test', 14:01:14 INFO - 'SHELL': '/bin/bash', 14:01:14 INFO - 'SHLVL': '1', 14:01:14 INFO - 'TERM': 'linux', 14:01:14 INFO - 'TMOUT': '86400', 14:01:14 INFO - 'USER': 'cltbld', 14:01:14 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:14 INFO - '_': '/tools/buildbot/bin/python'} 14:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:16 INFO - Installing collected packages: mozsystemmonitor 14:01:16 INFO - Running setup.py install for mozsystemmonitor 14:01:16 INFO - Successfully installed mozsystemmonitor 14:01:16 INFO - Cleaning up... 14:01:16 INFO - Return code: 0 14:01:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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', '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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:01: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 blobuploader==1.2.4 14:01:16 INFO - Using env: {'DISPLAY': ':0', 14:01:16 INFO - 'HOME': '/home/cltbld', 14:01:16 INFO - 'LANG': 'en_US.UTF-8', 14:01:16 INFO - 'LANGUAGE': 'en_US:en', 14:01:16 INFO - 'LOGNAME': 'cltbld', 14:01:16 INFO - 'MAIL': '/var/mail/cltbld', 14:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:16 INFO - 'MOZ_NO_REMOTE': '1', 14:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:16 INFO - 'NO_EM_RESTART': '1', 14:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:16 INFO - 'PWD': '/builds/slave/test', 14:01:16 INFO - 'SHELL': '/bin/bash', 14:01:16 INFO - 'SHLVL': '1', 14:01:16 INFO - 'TERM': 'linux', 14:01:16 INFO - 'TMOUT': '86400', 14:01:16 INFO - 'USER': 'cltbld', 14:01:16 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:16 INFO - '_': '/tools/buildbot/bin/python'} 14:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:16 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 14:01:16 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 14:01:16 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 14:01:16 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 14:01:16 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 14:01:16 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 14:01:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:01:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 INFO - Downloading docopt-0.6.1.tar.gz 14:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:19 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:19 INFO - Running setup.py install for blobuploader 14:01:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:01:19 INFO - Running setup.py install for requests 14:01:19 INFO - Running setup.py install for docopt 14:01:19 INFO - Successfully installed blobuploader requests docopt 14:01:19 INFO - Cleaning up... 14:01:20 INFO - Return code: 0 14:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:20 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:20 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 14:01:20 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 14:01:20 INFO - Using env: {'DISPLAY': ':0', 14:01:20 INFO - 'HOME': '/home/cltbld', 14:01:20 INFO - 'LANG': 'en_US.UTF-8', 14:01:20 INFO - 'LANGUAGE': 'en_US:en', 14:01:20 INFO - 'LOGNAME': 'cltbld', 14:01:20 INFO - 'MAIL': '/var/mail/cltbld', 14:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:20 INFO - 'MOZ_NO_REMOTE': '1', 14:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:20 INFO - 'NO_EM_RESTART': '1', 14:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:20 INFO - 'PWD': '/builds/slave/test', 14:01:20 INFO - 'SHELL': '/bin/bash', 14:01:20 INFO - 'SHLVL': '1', 14:01:20 INFO - 'TERM': 'linux', 14:01:20 INFO - 'TMOUT': '86400', 14:01:20 INFO - 'USER': 'cltbld', 14:01:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:20 INFO - '_': '/tools/buildbot/bin/python'} 14:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:20 INFO - Running setup.py (path:/tmp/pip-Ixh7PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:20 INFO - Running setup.py (path:/tmp/pip-MMggU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:20 INFO - Running setup.py (path:/tmp/pip-usIJrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:20 INFO - Running setup.py (path:/tmp/pip-GKrW3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:20 INFO - Running setup.py (path:/tmp/pip-uFWfvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:20 INFO - Running setup.py (path:/tmp/pip-_f1iQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:20 INFO - Running setup.py (path:/tmp/pip-wAIUOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:20 INFO - Running setup.py (path:/tmp/pip-uuCZch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:20 INFO - Running setup.py (path:/tmp/pip-I05eT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:20 INFO - Running setup.py (path:/tmp/pip-RUwcz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:20 INFO - Running setup.py (path:/tmp/pip-ZzsKBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:21 INFO - Running setup.py (path:/tmp/pip-PhJxKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:21 INFO - Running setup.py (path:/tmp/pip-K_DOsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:21 INFO - Running setup.py (path:/tmp/pip-I8FjLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:21 INFO - Running setup.py (path:/tmp/pip-Ad8kT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:21 INFO - Running setup.py (path:/tmp/pip-JVivDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:21 INFO - Running setup.py (path:/tmp/pip-NBkv8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:21 INFO - Running setup.py install for manifestparser 14:01:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:01:21 INFO - Running setup.py install for mozcrash 14:01:21 INFO - Running setup.py install for mozdebug 14:01:21 INFO - Running setup.py install for mozdevice 14:01:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:01:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:01:21 INFO - Running setup.py install for mozfile 14:01:21 INFO - Running setup.py install for mozhttpd 14:01:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozinfo 14:01:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozInstall 14:01:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozleak 14:01:22 INFO - Running setup.py install for mozlog 14:01:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for moznetwork 14:01:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozprocess 14:01:22 INFO - Running setup.py install for mozprofile 14:01:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozrunner 14:01:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozscreenshot 14:01:23 INFO - Running setup.py install for moztest 14:01:23 INFO - Running setup.py install for mozversion 14:01:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:23 INFO - Cleaning up... 14:01:23 INFO - Return code: 0 14:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:23 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:23 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 14:01:23 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 14:01:23 INFO - Using env: {'DISPLAY': ':0', 14:01:23 INFO - 'HOME': '/home/cltbld', 14:01:23 INFO - 'LANG': 'en_US.UTF-8', 14:01:23 INFO - 'LANGUAGE': 'en_US:en', 14:01:23 INFO - 'LOGNAME': 'cltbld', 14:01:23 INFO - 'MAIL': '/var/mail/cltbld', 14:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:23 INFO - 'MOZ_NO_REMOTE': '1', 14:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:23 INFO - 'NO_EM_RESTART': '1', 14:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:23 INFO - 'PWD': '/builds/slave/test', 14:01:23 INFO - 'SHELL': '/bin/bash', 14:01:23 INFO - 'SHLVL': '1', 14:01:23 INFO - 'TERM': 'linux', 14:01:23 INFO - 'TMOUT': '86400', 14:01:23 INFO - 'USER': 'cltbld', 14:01:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:23 INFO - '_': '/tools/buildbot/bin/python'} 14:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:23 INFO - Running setup.py (path:/tmp/pip-zH38Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:23 INFO - Running setup.py (path:/tmp/pip-EXL3X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:23 INFO - Running setup.py (path:/tmp/pip-bST93q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:23 INFO - Running setup.py (path:/tmp/pip-_AHH5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:23 INFO - Running setup.py (path:/tmp/pip-V5asLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:23 INFO - Running setup.py (path:/tmp/pip-VWShXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:23 INFO - Running setup.py (path:/tmp/pip-l6w4Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:23 INFO - Running setup.py (path:/tmp/pip-snLdvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:24 INFO - Running setup.py (path:/tmp/pip-FXldVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:24 INFO - Running setup.py (path:/tmp/pip-MEHuWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:24 INFO - Running setup.py (path:/tmp/pip-jkLeKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:24 INFO - Running setup.py (path:/tmp/pip-_oVn65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:24 INFO - Running setup.py (path:/tmp/pip-Q5cTnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:24 INFO - Running setup.py (path:/tmp/pip-aSspMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:24 INFO - Running setup.py (path:/tmp/pip-lKXCfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:24 INFO - Running setup.py (path:/tmp/pip-aA9N8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:24 INFO - Running setup.py (path:/tmp/pip-G42DUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:24 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)) 14:01:24 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)) 14:01:24 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)) 14:01:24 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)) 14:01:24 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)) 14:01:24 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)) 14:01:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:24 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 14:01:24 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 14:01:24 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 14:01:24 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 14:01:24 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 14:01:24 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 14:01:26 INFO - Downloading blessings-1.6.tar.gz 14:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:26 INFO - Installing collected packages: blessings 14:01:26 INFO - Running setup.py install for blessings 14:01:26 INFO - Successfully installed blessings 14:01:26 INFO - Cleaning up... 14:01:26 INFO - Return code: 0 14:01:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:26 INFO - Reading from file tmpfile_stdout 14:01:26 INFO - Current package versions: 14:01:26 INFO - argparse == 1.2.1 14:01:26 INFO - blessings == 1.6 14:01:26 INFO - blobuploader == 1.2.4 14:01:26 INFO - docopt == 0.6.1 14:01:26 INFO - manifestparser == 1.1 14:01:26 INFO - mozInstall == 1.12 14:01:26 INFO - mozcrash == 0.17 14:01:26 INFO - mozdebug == 0.1 14:01:26 INFO - mozdevice == 0.48 14:01:26 INFO - mozfile == 1.2 14:01:26 INFO - mozhttpd == 0.7 14:01:26 INFO - mozinfo == 0.9 14:01:26 INFO - mozleak == 0.1 14:01:26 INFO - mozlog == 3.1 14:01:26 INFO - moznetwork == 0.27 14:01:27 INFO - mozprocess == 0.22 14:01:27 INFO - mozprofile == 0.28 14:01:27 INFO - mozrunner == 6.11 14:01:27 INFO - mozscreenshot == 0.1 14:01:27 INFO - mozsystemmonitor == 0.0 14:01:27 INFO - moztest == 0.7 14:01:27 INFO - mozversion == 1.4 14:01:27 INFO - psutil == 3.1.1 14:01:27 INFO - requests == 1.2.3 14:01:27 INFO - wsgiref == 0.1.2 14:01:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:27 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:27 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 14:01:27 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 14:01:27 INFO - Using env: {'DISPLAY': ':0', 14:01:27 INFO - 'HOME': '/home/cltbld', 14:01:27 INFO - 'LANG': 'en_US.UTF-8', 14:01:27 INFO - 'LANGUAGE': 'en_US:en', 14:01:27 INFO - 'LOGNAME': 'cltbld', 14:01:27 INFO - 'MAIL': '/var/mail/cltbld', 14:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:27 INFO - 'MOZ_NO_REMOTE': '1', 14:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:27 INFO - 'NO_EM_RESTART': '1', 14:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:27 INFO - 'PWD': '/builds/slave/test', 14:01:27 INFO - 'SHELL': '/bin/bash', 14:01:27 INFO - 'SHLVL': '1', 14:01:27 INFO - 'TERM': 'linux', 14:01:27 INFO - 'TMOUT': '86400', 14:01:27 INFO - 'USER': 'cltbld', 14:01:27 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:27 INFO - '_': '/tools/buildbot/bin/python'} 14:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 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)) 14:01:27 INFO - Cleaning up... 14:01:27 INFO - Return code: 0 14:01:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:27 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:27 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 14:01:27 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 14:01:27 INFO - Using env: {'DISPLAY': ':0', 14:01:27 INFO - 'HOME': '/home/cltbld', 14:01:27 INFO - 'LANG': 'en_US.UTF-8', 14:01:27 INFO - 'LANGUAGE': 'en_US:en', 14:01:27 INFO - 'LOGNAME': 'cltbld', 14:01:27 INFO - 'MAIL': '/var/mail/cltbld', 14:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:27 INFO - 'MOZ_NO_REMOTE': '1', 14:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:27 INFO - 'NO_EM_RESTART': '1', 14:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:27 INFO - 'PWD': '/builds/slave/test', 14:01:27 INFO - 'SHELL': '/bin/bash', 14:01:27 INFO - 'SHLVL': '1', 14:01:27 INFO - 'TERM': 'linux', 14:01:27 INFO - 'TMOUT': '86400', 14:01:27 INFO - 'USER': 'cltbld', 14:01:27 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:27 INFO - '_': '/tools/buildbot/bin/python'} 14:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:27 INFO - Downloading/unpacking jsonschema 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:29 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:29 INFO - warning: no files found matching '*.txt' 14:01:29 INFO - no previously-included directories found matching 'build' 14:01:29 INFO - no previously-included directories found matching 'dist' 14:01:29 INFO - no previously-included directories found matching '.git*' 14:01:29 INFO - Installing collected packages: jsonschema, functools32 14:01:29 INFO - Running setup.py install for functools32 14:01:29 INFO - warning: no files found matching '*.txt' 14:01:29 INFO - no previously-included directories found matching 'build' 14:01:29 INFO - no previously-included directories found matching 'dist' 14:01:29 INFO - no previously-included directories found matching '.git*' 14:01:29 INFO - Successfully installed jsonschema functools32 14:01:29 INFO - Cleaning up... 14:01:29 INFO - Return code: 0 14:01:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:29 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 0x7f69637c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', '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 14:01:29 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 14:01:29 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 14:01:29 INFO - Using env: {'DISPLAY': ':0', 14:01:29 INFO - 'HOME': '/home/cltbld', 14:01:29 INFO - 'LANG': 'en_US.UTF-8', 14:01:29 INFO - 'LANGUAGE': 'en_US:en', 14:01:29 INFO - 'LOGNAME': 'cltbld', 14:01:29 INFO - 'MAIL': '/var/mail/cltbld', 14:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:29 INFO - 'MOZ_NO_REMOTE': '1', 14:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:29 INFO - 'NO_EM_RESTART': '1', 14:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:29 INFO - 'PWD': '/builds/slave/test', 14:01:29 INFO - 'SHELL': '/bin/bash', 14:01:29 INFO - 'SHLVL': '1', 14:01:29 INFO - 'TERM': 'linux', 14:01:29 INFO - 'TMOUT': '86400', 14:01:29 INFO - 'USER': 'cltbld', 14:01:29 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:29 INFO - '_': '/tools/buildbot/bin/python'} 14:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:30 INFO - Downloading/unpacking flake8 14:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 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 14:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:32 INFO - no previously-included directories found matching 'docs/_build' 14:01:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:32 INFO - Running setup.py install for pep8 14:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:32 INFO - no previously-included directories found matching 'docs/_build' 14:01:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:01:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:32 INFO - Cleaning up... 14:01:32 INFO - Return code: 0 14:01:32 INFO - Running post-action listener: _resource_record_post_action 14:01:32 INFO - Running post-action listener: _start_resource_monitoring 14:01:32 INFO - Starting resource monitoring. 14:01:32 INFO - ##### 14:01:32 INFO - ##### Running install step. 14:01:32 INFO - ##### 14:01:32 INFO - Running pre-action listener: _resource_record_pre_action 14:01:32 INFO - Running main action method: install 14:01:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:33 INFO - Reading from file tmpfile_stdout 14:01:33 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:01:33 INFO - Reading from file tmpfile_stdout 14:01:33 INFO - Output received: 14:01:33 INFO - Usage: mozinstall [options] installer 14:01:33 INFO - Options: 14:01:33 INFO - -h, --help show this help message and exit 14:01:33 INFO - -d DEST, --destination=DEST 14:01:33 INFO - Directory to install application into. [default: 14:01:33 INFO - "/builds/slave/test"] 14:01:33 INFO - --app=APP Application being installed. [default: firefox] 14:01:33 INFO - mkdir: /builds/slave/test/build/application 14:01:33 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'] 14:01:33 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 14:01:49 INFO - Reading from file tmpfile_stdout 14:01:49 INFO - Output received: 14:01:49 INFO - /builds/slave/test/build/application/firefox/firefox 14:01:49 INFO - Running post-action listener: _resource_record_post_action 14:01:49 INFO - ##### 14:01:49 INFO - ##### Running run-tests step. 14:01:49 INFO - ##### 14:01:49 INFO - Running pre-action listener: _resource_record_pre_action 14:01:49 INFO - Running main action method: run_tests 14:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:01:49 INFO - Python 2.7.3 14:01:49 INFO - Return code: 0 14:01:49 INFO - grabbing minidump binary from tooltool 14:01:49 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')]} 14:01:49 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 0x2ae5410>, '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 0x2ae6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:01:49 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 14:01:49 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 14:01:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:49 INFO - Return code: 0 14:01:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:01:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:01:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:01:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:01:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:01:50 INFO - Return code: 0 14:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 14:01:50 INFO - Using env: {'DISPLAY': ':0', 14:01:50 INFO - 'HOME': '/home/cltbld', 14:01:50 INFO - 'LANG': 'en_US.UTF-8', 14:01:50 INFO - 'LANGUAGE': 'en_US:en', 14:01:50 INFO - 'LOGNAME': 'cltbld', 14:01:50 INFO - 'MAIL': '/var/mail/cltbld', 14:01:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:01:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:50 INFO - 'MOZ_NO_REMOTE': '1', 14:01:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:50 INFO - 'NO_EM_RESTART': '1', 14:01:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:50 INFO - 'PWD': '/builds/slave/test', 14:01:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:01:50 INFO - 'SHELL': '/bin/bash', 14:01:50 INFO - 'SHLVL': '1', 14:01:50 INFO - 'TERM': 'linux', 14:01:50 INFO - 'TMOUT': '86400', 14:01:50 INFO - 'USER': 'cltbld', 14:01:50 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646', 14:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:50 INFO - '_': '/tools/buildbot/bin/python'} 14:01:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:01:50 INFO - mozversion application_buildid: 20160414113023 14:01:50 INFO - mozversion application_changeset: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 14:01:50 INFO - mozversion application_display_name: Nightly 14:01:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:50 INFO - mozversion application_name: Firefox 14:01:50 INFO - mozversion application_remotingname: firefox 14:01:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:01:50 INFO - mozversion application_vendor: Mozilla 14:01:50 INFO - mozversion application_version: 48.0a1 14:01:50 INFO - mozversion platform_buildid: 20160414113023 14:01:50 INFO - mozversion platform_changeset: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 14:01:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:01:50 INFO - mozversion platform_version: 48.0a1 14:01:50 INFO - using testdate: 1460667710 14:01:50 INFO - actual date: 1460667710 14:01:50 INFO - starting webserver on 'localhost:36840' 14:01:50 INFO - SUITE-START | Running 2 tests 14:01:50 INFO - TEST-START | dromaeo_css 14:01:50 INFO - operating with platform_type : linux_ 14:01:50 INFO - Initialising browser for dromaeo_css test... 14:01:50 INFO - TEST-INFO | started process 27727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqZYJhD/profile http://localhost:36840/getInfo.html) 14:01:54 INFO - PROCESS | 27727 | 14:01:54 INFO - PROCESS | 27727 | (process:27795): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:01:54 INFO - PROCESS | 27727 | 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] 14:01:55 INFO - PROCESS | 27727 | __metrics Screen width/height:1600/1200 14:01:55 INFO - PROCESS | 27727 | colorDepth:24 14:01:55 INFO - PROCESS | 27727 | Browser inner width/height: 1024/697 14:01:55 INFO - PROCESS | 27727 | __metrics 14:01:56 ERROR - PROCESS | 27727 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:01:57 INFO - TEST-INFO | 27727: exit 0 14:01:57 INFO - Browser initialized. 14:01:57 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:57 INFO - TEST-INFO | started process 27846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqZYJhD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:59 INFO - PROCESS | 27846 | 14:01:59 INFO - PROCESS | 27846 | (process:27907): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:02:09 INFO - PROCESS | 27846 | RSS: Main: 163454976 14:02:09 INFO - PROCESS | 27846 | 14:02:58 INFO - PROCESS | 27846 | 1460667778794 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] 14:05:06 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:36840/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36840/tests/dromaeo/cssquery-ext.html) 14:05:07 INFO - PROCESS | 27846 | RSS: Main: 168869888 14:05:07 INFO - PROCESS | 27846 | 14:08:09 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:36840/tests/dromaeo/cssquery-ext.html (next: http://localhost:36840/tests/dromaeo/cssquery-jquery.html) 14:08:09 INFO - PROCESS | 27846 | RSS: Main: 165928960 14:08:09 INFO - PROCESS | 27846 | 14:11:11 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:36840/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36840/tests/dromaeo/cssquery-mootools.html) 14:11:12 INFO - PROCESS | 27846 | RSS: Main: 166756352 14:11:12 INFO - PROCESS | 27846 | 14:14:13 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:36840/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36840/tests/dromaeo/cssquery-prototype.html) 14:14:14 INFO - PROCESS | 27846 | RSS: Main: 163930112 14:14:14 INFO - PROCESS | 27846 | 14:17:16 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:36840/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36840/tests/dromaeo/cssquery-yui.html) 14:17:17 INFO - PROCESS | 27846 | RSS: Main: 165330944 14:17:17 INFO - PROCESS | 27846 | 14:20:19 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:36840/tests/dromaeo/cssquery-yui.html (next: http://localhost:36840/tests/dromaeo/cssquery-dojo.html) 14:20:20 INFO - PROCESS | 27846 | RSS: Main: 167460864 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | __start_tp_report 14:20:20 INFO - PROCESS | 27846 | _x_x_mozilla_page_load 14:20:20 INFO - PROCESS | 27846 | _x_x_mozilla_page_load_details 14:20:20 INFO - PROCESS | 27846 | |i|pagename|runs| 14:20:20 INFO - PROCESS | 27846 | |0;dojo.html;3126.8280244586545;3145.056483055084;3186.6335371432265;3219.227385427498;3227.080282119595;5203.557697595704;5450.209719590657;5461.972690136554;5478.205660179272;5517.282753242078;5333.306670132887;5448.972755136218;5465.398806131322;5551.056320425528;5569.888602227963;4926.704397736147;4947.307376967227;5015.5486006259425;5023.598112151019;5054.241863720453;4964.304997300363;4994.700317980914;5034.496550344973;5042.899142017158;5102.107131252034;4898.926516102261;4913.140200464904;4920.729359885187;4946.208606622959;4981.32752078472;4910.8281210157475;4941.382327209099;4957.082939656175;4960.156773348539;4993.375828021497;4917.237828136645;4919.311296418504;4929.186684197103;4936.086823937583;4945.208766597327;5350.117230656937;5381.95051964867;5386.030514507387;5390;5404.351477822647;5752.935706894238;5759.136129580596;5789.363170051291;5810.622309549865;5821.50517206038;5651.886962260773;5764;5824.213731146283;5828.154917536934;5834.620749651302;5472.124460086367;5478.616496845222;5494.780208791643;5497.752601132918;5544.362398324163;5920.940790592039;5936.406359364116;5954.642721436728;5957.463828255478;5958.6424814511265;5551.167324901297;5687.374388817227;5713.542916566747;5736.4550367715;5743.052396354555;5806.767729290866;5836.066229403275;5840;5848.88302233953;5865.384134665884;5668.433156684381;5770.769169233267;5806.564507661942;5812.418758124154;5857.941420585825;5562.082256427725;5714.514266287329;5718.513926316226;5737.053386191232;5737.971310143423;4342.630876375543;4350.978245108818;4360.345948107809;4384.780760961939;4405.251107311765;3845.442410850411;3857.633524815138;3861.7876016819346;3871.588670989394;3890.299746045739;5418.810341638024;5478.780848766005;5498.780048798083;5521.613487055948;5529.751161197756;5795.304563452412;5807.767689292381;5810.477057064884;5813.157092221604;5822.039363505059;5528.474794894559;5538.778448862;5541.2796336476;5545.667259964415;5548.389677135512;4840.298156767249;4948.950510494921;4967.4784147664695;5006.249062640633;5018.347614810052;6023.096535519707;6032.638041717511;6035.818925432244;6052.939470605325;6064.66644334557;5881.558883083786;5896.941030589811;5898.1152827076285;5903.852403689943;5905.763769449174;5897.439743224387;5914.290285165807;5951.196588460675;5962.105684147413;6008.309044459768;5692;5693.202951586864;5701.800436984686;5703;5704.60067795267;5654.123610840326;5739.655620662774;5791.8552036199435;5793.36273009977;5799.043157879071;5570.554355651457;5634.098544233067;5680.4319568042865;5696.287964004499;5728.856778580569;5614.719264036864;5664.801731939362;5673.8297851064535;5674.858128546819;5734.655920644775;5569.972150139223;5574.86062848432;5582.49757521825;5604.635698679573;5614.494695477427;5594.804181853616;5613.971930140323;5639.661620302795;5683.147527870852;5764.279465066867;5498.560115190855;5524.33707955048;5546.861328466659;5561.721913904208;5586.441355864381 14:20:20 INFO - PROCESS | 27846 | |1;ext.html;609.6951524237882;623.090288179258;667.4493542827167;675.8411773233291;692.9618870962101;38574.61425385745;38639.80680096599;38702;38796.61203387965;41123;42876;43566.34650480237;43772;43835.561644383546;43887.78056109715;8651.697190598314;8846.15961483658;8853.73438796834;8863.069377715343;8870.42342247752;8865.379423440361;8897.154770296844;8931.374803763707;8983.19151276385;8994.820103597924;8983.236424903891;8985.415947963395;9015.233705135039;9039.502827344493;9058;8924.419912705685;8926.152015558511;8974.057723938959;8986.730398088068;8996.100389961017;8859.114088591154;8912.108789121101;8929.151730585649;8940.195382415613;8940.552972351357;33493.33013339744;40209;40700.796496017334;41057.384139237634;41059.38410923839;3234.838258087086;3313.9005829825146;3573.910652233689;4130.752154870687;4193.161367726467;26468.86765566179;26716.465670686674;26762.330941726417;27329.45341093167;27472;3999.14018486024;4013.4180543821276;4021.4369988201674;4022.329661566061;4087.4073259377224;193953;195013;196260;196436;234814.82592587097;34506.309873802886;34633;34722.61799421094;34815;35711.28577428489;34486.82756586201;34718.82640586781;34725.82637086798;34775;34793.30413391718;14882.702345953021;14954.775678364833;15016.549503514694;15132.243387830564;15143.394264229308;12588.622341329774;12639;12640.683982900317;12645.241285522714;12660.240385576895;8523.275521580736;8542.701005464904;8582.442141260799;8664.046954834963;8676.739697809076;3293.4730443129465;3305.7851239669344;3329.8335083246225;3343.281194543185;3344.8662053518074;1031.9484025798831;1080.0333701337415;1135.9261647992853;1150.4880328254014;1164.0512981919708;31541.855497214994;31979.680203198135;32021.359572808415;32190.83904580462;32207.841116308777;1090.6237348114887;1148.414308702551;1158.3802665573878;1164.4122158694715;1299.7725398055302;15449.227538623023;15627.453039143575;15764.68470630581;16137.677246455005;16689.415870444474;437104;442089;442096;445885;446829;55524;56528.15207771887;56738.14892776612;56764.148537771965;56772;1337.2377744685436;1394.6652803327129;1405.0305289350315;1417.3905220754968;1425.2659880161725;30685.53971690382;30758.077257682304;31252.218694532818;31451.528227076153;31898.84050579732;49610.50389496059;50398.496015040844;50462.2430663533;50496.747516262185;50522.2421663668;399912;402460;403032;403741;403834;27921.581176281965;28882.70027848794;28938.565921511614;28990.420191596473;29000.12999610015;48322.275165873245;50824.237636434744;52086.21870672019;52315.47684523106;53170.202446964104;37987.43018854775;38813.02967425837;38820.41769373405;39054;39410.211795764495;38225;38826.80586597049;38952.22095558016;39108.2178356437;39632.40551391789;35014;38930.221395572495;40102;41810.58189418067;42815.78592107019;33783.4932476018;33854.36675231411;34453.655463445044;34897.47653785144;35043.12392190216;27161.38256496361;27900.30249243785;27902.44195116127;27912.581311280752;27919.162425127277 14:20:20 INFO - PROCESS | 27846 | |2;jquery.html;381.87398158607647;383.6642937429749;391.2644228849764;391.3777094419873;407.16531111221985;16466.752998705015;18484.815151848477;18740.53148671284;18806.34177803777;18933.715994260096;15831.920840395782;15954.680906381865;16092.114933678644;16160.191990400463;18650.440486785385;5410.972945135279;5537.446255374451;5549.334079910416;5560.082586373263;5566.610337276392;4000.9799951000205;5771.2497375341145;6096.4817990470865;6120.571559990803;6134.539909506782;5878.118282257674;6061.787837425691;6062.060380641008;6071.666058366788;6107.664078475682;6132.816015519542;6133.3559976202305;6144.56988010835;6153.4154255345675;6188.535859810532;4726.385569875929;5063.544281014726;5084.161113416282;5388.91916621251;5390.21841832932;11521.884781152165;12322;12331;21698;21734.239301624526;2129.2601393933164;2137.8075973162336;2233.2072114399316;2261.7059782228207;2281.7147856517936;9568.665096721581;9625.989271126571;10063;10070.647527336581;13046.804297935538;1885.6605810954022;1894.4506093232947;1960.823525882663;1978.4559246207264;2000.449876284019;70534;76017.23982760157;80603.5969820153;80787;81440;9682.467464289532;10009.199264059003;10369.9481502592;10465.162786977024;10496.527656255486;14712.852871471148;14740.926295368454;14826.925865370604;14835.332410041574;14844.2577871106;7331.827198046938;7995.040595128506;8035;8127.0653874803975;8147.348212143014;7773.795061765435;7860.489068210548;7909.762707118795;8071.838563228703;8119.106898241189;4246.7027308088755;4302.09655972243;4372.698612547506;4417.867463976086;4619.122366750306;1809.5204770735766;1849.5653521422455;1851.1484717030316;1863.1802007116826;1914.745841473809;931.6226928093997;971.7424882406168;998.3161534348994;1003.7741508160606;1033.9586416543254;17979.73030404545;18755.718664220047;18855.90572047131;18928.43214703561;19161.041947902828;962.7689354554857;987.6197663899451;990.2672022703292;1013.1337706261188;1034.9793004139874;10466;10657.200709946785;10677.57289708403;10687.519061642244;10729.9463502682;477402;479518;494554;499787;507835;91385.54307228421;93245.5337723307;93836;94107;94730.52634736782;1049.3861091261697;1075.4783929794044;1084.7938891610568;1101.2126329674322;1108.866935967689;16522.58693532671;16897.408590699266;17091.145442727564;17150.571235718708;17287.222075006404;36856.44715329219;37299.440508391854;38345.80827095846;38550.42174367443;39596.2080758389;50693.74653126858;52096;52257.38713064408;53016.4698353027;53205.46794532005;7207.9279207207255;7451.925480745123;8135.471194372583;8190.303824175012;8507.702230421906;11935.283882966702;12625.936870315589;12912;13055.934720326337;13180.934095329845;11053;11084.224104312621;11221.495032723711;11231.494582743959;11349.659510214708;7322.560646361236;11185.888141118485;11284.9435752824;11551;11594.826077608674;5844.327902291291;9693.854592180982;10052.346597471142;10978.725531861448;10979.341239525334;7630.8092297693;7800.024996875391;7872.921270787218;7875.488093273919;7934.2859142677435;10519.579216831547;10851.728706782395;10924.344539327665;11007.504662290055;11124.721881953015 14:20:20 INFO - PROCESS | 27846 | |3;mootools.html;1518.8481151884812;1532.908025518469;1557.1202270717044;1621.2380181314786;1659.21187435968;7432.739854105107;8003.559804210773;8151.062627797805;8152.714654987077;8264.586770661466;7985.720499782508;8018.278354948054;8061.113277539466;8093;8110.675572977088;2266.2634643740766;2278.2481781012225;2291.6218823894037;2298.230092918874;2301.4821665125296;2222.633265511197;2254.86470811751;2270.92051778187;2276.6243569811045;2280.6122959096992;2268.353519247015;2268.5576312619046;2294.33464295355;2300.229423143249;2302.8848557572137;2222.100049479963;2224.265992222579;2234.251525738863;2237.65316375962;2241.876696781668;2200.559888022386;2204.2836078274463;2209.2930262316067;2210.2706106984656;2212.9004194811273;8045.637946292431;8193.426460147792;8217.178282171795;8221.218984196492;8268.958655206745;4866.075445665312;4973.1297023020825;4981.875453113665;5035.3454050973505;5056.140456122468;3342.197872510604;3346.330733853239;3389.86440542378;3389.9661003390142;3402.1664692150334;1149.4884776274562;1165.1494409081417;1169.5146514196683;1179.9792531120274;1184.1592469346774;10928.508217130247;11030.28303160292;11032.50353734084;11059.059979901718;11126.554937802479;4281.272183728774;4328.653707703376;4455.5989960903025;4491.483479399911;4514.097180563835;8933.28533717301;8934.329925255632;8965;8968.23769979546;9001.639934402681;4970.353853998957;5007.599392048627;5034.647574669738;5060.5698515625845;5082.847514574569;4211.4525111735275;4646.326282688991;4708.976455117771;4714.740689262055;4773.952260477351;3671.687906527975;3732.9626703732615;3781.357169281229;3833.0800607853917;3844.7116466265143;1139.7093741095966;1181.3030312115893;1197.0662882951312;1209.2200530657676;1213.9453724582415;746.216472703659;921.3550514639645;938.4181807279394;938.5213541093955;969.8836139663285;5558.722063896789;5680.233168522279;5712.971435142881;5769.538436925036;5885.234919460443;965.232640051161;977.9853302200472;1002.2583288366557;1007.5214273220308;1032.9825122254574;3801.334766415866;3929.941050884239;3937.6062393760967;3946.7434616750393;3968.0079980005;9754.122129008423;10106.848397274047;10134.645287414905;10155.695329140137;10212.336198147097;10209.030142136486;10329.9483502582;10352.585896564204;10394.22043346752;10409.063184313449;7804.453688241769;7949.085855126619;7969.322607578305;8019;8034.558099304478;5673.092305231144;5800.767969281182;5805.390434004537;5840.2115714378015;5941.287045554561;9536.570854311434;9546.284028697737;9577.808443831223;9633.181179599813;9674.08096230857;9229.584668690059;9406.858897116412;9781.951090244504;9814.65648702292;9832.213422926292;6837.247902730596;7410.333070023724;7584.62076896164;7671.424643151674;7799.06411230656;7931.84136317282;7976.960115199387;8007.959960200395;8018.799530011563;8030.5181689098845;7112.110986126734;7245.818854528679;7293.234210407831;7362.815929601588;7425.554466732014;6998.265182156004;7093.787186384417;7102.857942841218;7108.971745119361;7124.608146551989;6161.291451483136;6267.467265282502;6276.089966954857;6293.339199383999;6315.747370105144;4816.518348165296;4995.200767877268;5003.974980125076;5015.824446144367;5035.773390197377;4944.48082951285;5004.299398084344;5030.723310217973;5060.063888180698;5079.466656001066 14:20:20 INFO - PROCESS | 27846 | |4;prototype.html;322.73696936996345;323.9983800080999;326.5852367493284;333.0026570421586;334.2045930684972;5952.583319167655;6054.515638748895;6064.332923378425;6069.969650151748;6088;5917.55618328626;5923.229980102591;5931.792387266447;5955.255593050869;6000.279966404038;4390.846320378788;4531.640507847633;4552.271636538155;4568.588827005568;4576.794044268016;4529.479109902354;4548.135854187711;4548.613367863719;4576.816927322903;4576.931346029813;4516.2322405191035;4520.593146616804;4535.795889184995;4537.2286711259;4540.636749060084;4259.1268789897995;4309.504406993189;4433.645308375322;4487.12501062293;4507.954920450787;3892.8053597320304;3896.3181443247317;3897.162110146304;3917.4515567820526;3925.4308125321954;5690.829275121753;5737.770489180428;5739.368669446358;5762.193292938992;5789.913151302734;4982.6013918886765;5274.3670759509105;5279.472052794728;5280.973595132038;5281.551068159211;6153.353897840707;6183.567150299481;6185.072239164117;6228.4394404503355;6237.34507876671;4296.957030429687;4326.805293761789;4363.3454981752675;4391.5827996340295;4396.296592545209;6455.580387274859;6460.189817429433;6464.870702585969;6506.642134682591;6542.803715888531;4435.312526558324;4437.201303765289;4451.599356057905;4456.77716114193;4458.9331160032625;4219;4457.732536047847;4478.149151661174;4483.453208643078;4490.348899409632;5223.164293712987;5228.849653076317;5236.795537026505;5237.397699264558;5249.580033597379;6283.151774510383;6289.528285378615;6292.874142517124;6312.715927783261;6352.841178970562;1557.5872393815648;1573.087609186669;1594.7288960876679;1595.9840401596068;1598.8640965518061;1054.667779649408;1069.4652673663168;1071.8285074388061;1091.9781604367868;1106.6790630717003;6017.097435384728;6048.818535443944;6074.848128796727;6080.574359794772;6088.939110608926;6435.259945106279;6461.741530338828;6479.157709497735;6506.429960165708;6506.642134682544;5917.165575533779;5989.341172471025;6061.212042434456;6074.817755467343;6089.812486565166;3444.362792883325;3449.4653328734084;3478.356504046709;3481.112316359363;3500.9299814004085;6427.871442571216;6718.832029199211;6721.764738234138;6838.555493892881;6838.931610683929;6753.358430949052;6758.189017317954;6760.661966901635;6768.424683901923;6769.627670478072;6636.203655561363;6690.42062496562;6711.3288671132495;6817.454603631698;6842.418394436529;6439.291677915519;6498.805035848932;6529.4776417885505;6560.277484843737;6564.6389448578875;6136.2636483622255;6455.580387274812;6485.6108633482145;6487.3188315226225;6517.511186660925;6750.6624668767345;6782.626955517494;6787.355201255873;6788.830279243059;6807.931920680928;4370.956290437055;4401.559844015701;4415.2494076006515;4420.624246938917;4423.778811059498;6342.270638876588;6519.3480651936325;6548.869022619616;6586.670666466754;6589.604623722592;6335.271443784024;6367.816091954023;6389.297177310399;6406.13517175194;6426.260979987362;6054.515638748801;6286.748530058747;6344.904826427515;6352.777652782131;6355.809325720235;5866.472017518444;6010.969945150421;6218.284897236876;6231.158793562992;6280.717367718372;6335.461485773761;6352.714127864165;6358.237011558643;6394.520410969289;6415.486761059011;6027;6118.938810611837;6142;6182.567220294536;6228.719707613259 14:20:20 INFO - PROCESS | 27846 | |5;yui.html;714.9928500714991;802.3541049455187;833.7248707926383;870.8519551676214;882.5013867165053;12693.238405695665;12880.613581592545;12888;12963.546275880346;14587.34356953937;13589.252591107484;13614.659633509167;13624.727505449886;13667.111637743565;13667.658308542292;817.2277198047847;846.0566468387734;855.5636625321068;855.6919508976795;856.1780690537092;834.1783343406739;843.9831203375929;844.7296865003201;846.1622993236713;846.4413487098516;872.162723785167;873.7466134820894;879.248242752447;880.3573391424264;881.532787622561;873.5894129759004;874.208840998897;875.4353442029919;877.591919757316;881.5988725130114;636.0903907412398;637.4931929116364;641.3650486018854;642.7621779941405;644.3395519592408;13592.592222233348;13677.31613419325;13683.726325473435;13683.86316136836;13709.383077761524;13240.536581219707;13561.186328820302;13655.453781848713;13798;14042.36809343582;11559.884401156049;11613.361265130414;11621.47703353351;11735.589254376142;11882.168248222628;3715.5541335039698;3718.0890681782867;3812.9809350953346;3849.538055433366;3878.941815872764;54292;54397.45602544003;55459.44540554583;55629;55771.72114139403;10680.412577308323;10699.25013125185;10762.999999999844;10962.177836662282;10967.561297548169;19460.80539194618;19463.513412164808;19468.318608848906;19497.22011119568;19522.609547808963;8310.418270721113;8403.747887563382;8489.320854331638;8522.275606573387;8523.06246312905;4775.188218002879;4809.639277054235;4909.2881532177635;4910.533499317559;4965.528274813887;3213.550102985584;3295.0938491914435;3298.4887342461957;3300.207950091961;3309.9007029789145;572.705056895699;582.9417058294222;588.7703795519751;597.1013624495193;606.8907596632648;608.3277977834517;661.0810972747885;709.2765379313072;734.6400263870665;750.0099868174067;9070.138336857988;9099.727008189764;9099.863502047474;9221.216196623229;9300.767480812898;611.2756383685347;616.488314698799;709.606168576445;738.1843063414957;770.0797546931475;3951.4270430787374;4078.7159190853217;4227.450431443893;4236.894077648083;4284.721493102938;61072.69463652653;63418;63974.68012659907;64116.35883641104;66682.33317666859;53924.46075539273;54252;54556;54592;54742.452575474534;48575.27137092876;50405.24392134121;50550.7472462628;50578;50727;7962.800929976797;8187.1403502631365;8196.631151598072;8335.041470231;8396.37027222973;29695.406091878474;30006.399872002876;30803.229919252197;30843.383132336778;30954.380912382076;40487.15372039651;43441.131177376905;43568;43594.782026090936;44095.55904441043;10053.396796192252;10185.287029907835;10447.268691191544;10567.78864422692;10661.360318380923;12322.137450378388;12405.813912791496;12493;12768.872311276768;13230.470781168646;12710;12761.93619031899;12951.287679177736;13216.801747973981;13645.522406715718;12012.939935300268;12099.75800484003;12362.629121126382;12383.62849114528;12432.502699892264;11314.547418103184;12505.312207828656;12885.48458061667;13116.475340986635;13194.208347499181;9878.654247101316;9892.851607225753;10056.195504359488;10087.798244035224;10090.192784577363;10156.746081348025;10659.733506662396;10752.516136773707;10859.294145880809;10897.782044359226 14:20:20 INFO - PROCESS | 27846 | __end_tp_report 14:20:20 INFO - PROCESS | 27846 | __start_cc_report 14:20:20 INFO - PROCESS | 27846 | _x_x_mozilla_cycle_collect,354 14:20:20 INFO - PROCESS | 27846 | __end_cc_report 14:20:20 INFO - PROCESS | 27846 | __startTimestamp1460668820051__endTimestamp 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | ------- Summary: start ------- 14:20:20 INFO - PROCESS | 27846 | Number of tests: 6 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | [#0] dojo.html Cycles:165 Average:5388.04 Median:5570.55 stddev:612.38 (11.0%) stddev-sans-first:588.00 14:20:20 INFO - PROCESS | 27846 | Values: 3126.8 3145.1 3186.6 3219.2 3227.1 5203.6 5450.2 5462.0 5478.2 5517.3 5333.3 5449.0 5465.4 5551.1 5569.9 4926.7 4947.3 5015.5 5023.6 5054.2 4964.3 4994.7 5034.5 5042.9 5102.1 4898.9 4913.1 4920.7 4946.2 4981.3 4910.8 4941.4 4957.1 4960.2 4993.4 4917.2 4919.3 4929.2 4936.1 4945.2 5350.1 5382.0 5386.0 5390.0 5404.4 5752.9 5759.1 5789.4 5810.6 5821.5 5651.9 5764.0 5824.2 5828.2 5834.6 5472.1 5478.6 5494.8 5497.8 5544.4 5920.9 5936.4 5954.6 5957.5 5958.6 5551.2 5687.4 5713.5 5736.5 5743.1 5806.8 5836.1 5840.0 5848.9 5865.4 5668.4 5770.8 5806.6 5812.4 5857.9 5562.1 5714.5 5718.5 5737.1 5738.0 4342.6 4351.0 4360.3 4384.8 4405.3 3845.4 3857.6 3861.8 3871.6 3890.3 5418.8 5478.8 5498.8 5521.6 5529.8 5795.3 5807.8 5810.5 5813.2 5822.0 5528.5 5538.8 5541.3 5545.7 5548.4 4840.3 4949.0 4967.5 5006.2 5018.3 6023.1 6032.6 6035.8 6052.9 6064.7 5881.6 5896.9 5898.1 5903.9 5905.8 5897.4 5914.3 5951.2 5962.1 6008.3 5692.0 5693.2 5701.8 5703.0 5704.6 5654.1 5739.7 5791.9 5793.4 5799.0 5570.6 5634.1 5680.4 5696.3 5728.9 5614.7 5664.8 5673.8 5674.9 5734.7 5570.0 5574.9 5582.5 5604.6 5614.5 5594.8 5614.0 5639.7 5683.1 5764.3 5498.6 5524.3 5546.9 5561.7 5586.4 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | [#1] ext.html Cycles:180 Average:50255.80 Median:38804.82 stddev:96859.21 (249.6%) stddev-sans-first:97059.20 14:20:20 INFO - PROCESS | 27846 | Values: 609.7 623.1 667.4 675.8 693.0 38574.6 38639.8 38702.0 38796.6 41123.0 42876.0 43566.3 43772.0 43835.6 43887.8 8651.7 8846.2 8853.7 8863.1 8870.4 8865.4 8897.2 8931.4 8983.2 8994.8 8983.2 8985.4 9015.2 9039.5 9058.0 8924.4 8926.2 8974.1 8986.7 8996.1 8859.1 8912.1 8929.2 8940.2 8940.6 33493.3 40209.0 40700.8 41057.4 41059.4 3234.8 3313.9 3573.9 4130.8 4193.2 26468.9 26716.5 26762.3 27329.5 27472.0 3999.1 4013.4 4021.4 4022.3 4087.4 193953.0 195013.0 196260.0 196436.0 234814.8 34506.3 34633.0 34722.6 34815.0 35711.3 34486.8 34718.8 34725.8 34775.0 34793.3 14882.7 14954.8 15016.5 15132.2 15143.4 12588.6 12639.0 12640.7 12645.2 12660.2 8523.3 8542.7 8582.4 8664.0 8676.7 3293.5 3305.8 3329.8 3343.3 3344.9 1031.9 1080.0 1135.9 1150.5 1164.1 31541.9 31979.7 32021.4 32190.8 32207.8 1090.6 1148.4 1158.4 1164.4 1299.8 15449.2 15627.5 15764.7 16137.7 16689.4 437104.0 442089.0 442096.0 445885.0 446829.0 55524.0 56528.2 56738.1 56764.1 56772.0 1337.2 1394.7 1405.0 1417.4 1425.3 30685.5 30758.1 31252.2 31451.5 31898.8 49610.5 50398.5 50462.2 50496.7 50522.2 399912.0 402460.0 403032.0 403741.0 403834.0 27921.6 28882.7 28938.6 28990.4 29000.1 48322.3 50824.2 52086.2 52315.5 53170.2 37987.4 38813.0 38820.4 39054.0 39410.2 38225.0 38826.8 38952.2 39108.2 39632.4 35014.0 38930.2 40102.0 41810.6 42815.8 33783.5 33854.4 34453.7 34897.5 35043.1 27161.4 27900.3 27902.4 27912.6 27919.2 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | [#2] jquery.html Cycles:180 Average:28193.49 Median:382.77 stddev:81114.63 (21191.5%) stddev-sans-first:81315.29 14:20:20 INFO - PROCESS | 27846 | Values: 381.9 383.7 391.3 391.4 407.2 16466.8 18484.8 18740.5 18806.3 18933.7 15831.9 15954.7 16092.1 16160.2 18650.4 5411.0 5537.4 5549.3 5560.1 5566.6 4001.0 5771.2 6096.5 6120.6 6134.5 5878.1 6061.8 6062.1 6071.7 6107.7 6132.8 6133.4 6144.6 6153.4 6188.5 4726.4 5063.5 5084.2 5388.9 5390.2 11521.9 12322.0 12331.0 21698.0 21734.2 2129.3 2137.8 2233.2 2261.7 2281.7 9568.7 9626.0 10063.0 10070.6 13046.8 1885.7 1894.5 1960.8 1978.5 2000.4 70534.0 76017.2 80603.6 80787.0 81440.0 9682.5 10009.2 10369.9 10465.2 10496.5 14712.9 14740.9 14826.9 14835.3 14844.3 7331.8 7995.0 8035.0 8127.1 8147.3 7773.8 7860.5 7909.8 8071.8 8119.1 4246.7 4302.1 4372.7 4417.9 4619.1 1809.5 1849.6 1851.1 1863.2 1914.7 931.6 971.7 998.3 1003.8 1034.0 17979.7 18755.7 18855.9 18928.4 19161.0 962.8 987.6 990.3 1013.1 1035.0 10466.0 10657.2 10677.6 10687.5 10729.9 477402.0 479518.0 494554.0 499787.0 507835.0 91385.5 93245.5 93836.0 94107.0 94730.5 1049.4 1075.5 1084.8 1101.2 1108.9 16522.6 16897.4 17091.1 17150.6 17287.2 36856.4 37299.4 38345.8 38550.4 39596.2 50693.7 52096.0 52257.4 53016.5 53205.5 7207.9 7451.9 8135.5 8190.3 8507.7 11935.3 12625.9 12912.0 13055.9 13180.9 11053.0 11084.2 11221.5 11231.5 11349.7 7322.6 11185.9 11284.9 11551.0 11594.8 5844.3 9693.9 10052.3 10978.7 10979.3 7630.8 7800.0 7872.9 7875.5 7934.3 10519.6 10851.7 10924.3 11007.5 11124.7 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | [#3] mootools.html Cycles:180 Average:5462.43 Median:5005.95 stddev:3005.12 (60.0%) stddev-sans-first:2998.93 14:20:20 INFO - PROCESS | 27846 | Values: 1518.8 1532.9 1557.1 1621.2 1659.2 7432.7 8003.6 8151.1 8152.7 8264.6 7985.7 8018.3 8061.1 8093.0 8110.7 2266.3 2278.2 2291.6 2298.2 2301.5 2222.6 2254.9 2270.9 2276.6 2280.6 2268.4 2268.6 2294.3 2300.2 2302.9 2222.1 2224.3 2234.3 2237.7 2241.9 2200.6 2204.3 2209.3 2210.3 2212.9 8045.6 8193.4 8217.2 8221.2 8269.0 4866.1 4973.1 4981.9 5035.3 5056.1 3342.2 3346.3 3389.9 3390.0 3402.2 1149.5 1165.1 1169.5 1180.0 1184.2 10928.5 11030.3 11032.5 11059.1 11126.6 4281.3 4328.7 4455.6 4491.5 4514.1 8933.3 8934.3 8965.0 8968.2 9001.6 4970.4 5007.6 5034.6 5060.6 5082.8 4211.5 4646.3 4709.0 4714.7 4774.0 3671.7 3733.0 3781.4 3833.1 3844.7 1139.7 1181.3 1197.1 1209.2 1213.9 746.2 921.4 938.4 938.5 969.9 5558.7 5680.2 5713.0 5769.5 5885.2 965.2 978.0 1002.3 1007.5 1033.0 3801.3 3929.9 3937.6 3946.7 3968.0 9754.1 10106.8 10134.6 10155.7 10212.3 10209.0 10329.9 10352.6 10394.2 10409.1 7804.5 7949.1 7969.3 8019.0 8034.6 5673.1 5800.8 5805.4 5840.2 5941.3 9536.6 9546.3 9577.8 9633.2 9674.1 9229.6 9406.9 9782.0 9814.7 9832.2 6837.2 7410.3 7584.6 7671.4 7799.1 7931.8 7977.0 8008.0 8018.8 8030.5 7112.1 7245.8 7293.2 7362.8 7425.6 6998.3 7093.8 7102.9 7109.0 7124.6 6161.3 6267.5 6276.1 6293.3 6315.7 4816.5 4995.2 5004.0 5015.8 5035.8 4944.5 5004.3 5030.7 5060.1 5079.5 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | [#4] prototype.html Cycles:180 Average:5263.95 Median:6022.05 stddev:1600.13 (26.6%) stddev-sans-first:1561.05 14:20:20 INFO - PROCESS | 27846 | Values: 322.7 324.0 326.6 333.0 334.2 5952.6 6054.5 6064.3 6070.0 6088.0 5917.6 5923.2 5931.8 5955.3 6000.3 4390.8 4531.6 4552.3 4568.6 4576.8 4529.5 4548.1 4548.6 4576.8 4576.9 4516.2 4520.6 4535.8 4537.2 4540.6 4259.1 4309.5 4433.6 4487.1 4508.0 3892.8 3896.3 3897.2 3917.5 3925.4 5690.8 5737.8 5739.4 5762.2 5789.9 4982.6 5274.4 5279.5 5281.0 5281.6 6153.4 6183.6 6185.1 6228.4 6237.3 4297.0 4326.8 4363.3 4391.6 4396.3 6455.6 6460.2 6464.9 6506.6 6542.8 4435.3 4437.2 4451.6 4456.8 4458.9 4219.0 4457.7 4478.1 4483.5 4490.3 5223.2 5228.8 5236.8 5237.4 5249.6 6283.2 6289.5 6292.9 6312.7 6352.8 1557.6 1573.1 1594.7 1596.0 1598.9 1054.7 1069.5 1071.8 1092.0 1106.7 6017.1 6048.8 6074.8 6080.6 6088.9 6435.3 6461.7 6479.2 6506.4 6506.6 5917.2 5989.3 6061.2 6074.8 6089.8 3444.4 3449.5 3478.4 3481.1 3500.9 6427.9 6718.8 6721.8 6838.6 6838.9 6753.4 6758.2 6760.7 6768.4 6769.6 6636.2 6690.4 6711.3 6817.5 6842.4 6439.3 6498.8 6529.5 6560.3 6564.6 6136.3 6455.6 6485.6 6487.3 6517.5 6750.7 6782.6 6787.4 6788.8 6807.9 4371.0 4401.6 4415.2 4420.6 4423.8 6342.3 6519.3 6548.9 6586.7 6589.6 6335.3 6367.8 6389.3 6406.1 6426.3 6054.5 6286.7 6344.9 6352.8 6355.8 5866.5 6011.0 6218.3 6231.2 6280.7 6335.5 6352.7 6358.2 6394.5 6415.5 6027.0 6118.9 6142.0 6182.6 6228.7 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - PROCESS | 27846 | [#5] yui.html Cycles:180 Average:14544.58 Median:43581.39 stddev:17032.72 (39.1%) stddev-sans-first:17048.83 14:20:20 INFO - PROCESS | 27846 | Values: 715.0 802.4 833.7 870.9 882.5 12693.2 12880.6 12888.0 12963.5 14587.3 13589.3 13614.7 13624.7 13667.1 13667.7 817.2 846.1 855.6 855.7 856.2 834.2 844.0 844.7 846.2 846.4 872.2 873.7 879.2 880.4 881.5 873.6 874.2 875.4 877.6 881.6 636.1 637.5 641.4 642.8 644.3 13592.6 13677.3 13683.7 13683.9 13709.4 13240.5 13561.2 13655.5 13798.0 14042.4 11559.9 11613.4 11621.5 11735.6 11882.2 3715.6 3718.1 3813.0 3849.5 3878.9 54292.0 54397.5 55459.4 55629.0 55771.7 10680.4 10699.3 10763.0 10962.2 10967.6 19460.8 19463.5 19468.3 19497.2 19522.6 8310.4 8403.7 8489.3 8522.3 8523.1 4775.2 4809.6 4909.3 4910.5 4965.5 3213.6 3295.1 3298.5 3300.2 3309.9 572.7 582.9 588.8 597.1 606.9 608.3 661.1 709.3 734.6 750.0 9070.1 9099.7 9099.9 9221.2 9300.8 611.3 616.5 709.6 738.2 770.1 3951.4 4078.7 4227.5 4236.9 4284.7 61072.7 63418.0 63974.7 64116.4 66682.3 53924.5 54252.0 54556.0 54592.0 54742.5 48575.3 50405.2 50550.7 50578.0 50727.0 7962.8 8187.1 8196.6 8335.0 8396.4 29695.4 30006.4 30803.2 30843.4 30954.4 40487.2 43441.1 43568.0 43594.8 44095.6 10053.4 10185.3 10447.3 10567.8 10661.4 12322.1 12405.8 12493.0 12768.9 13230.5 12710.0 12761.9 12951.3 13216.8 13645.5 12012.9 12099.8 12362.6 12383.6 12432.5 11314.5 12505.3 12885.5 13116.5 13194.2 9878.7 9892.9 10056.2 10087.8 10090.2 10156.7 10659.7 10752.5 10859.3 10897.8 14:20:20 INFO - PROCESS | 27846 | -------- Summary: end -------- 14:20:20 INFO - PROCESS | 27846 | 14:20:20 INFO - TEST-INFO | 27846: exit 0 14:20:20 INFO - TEST-OK | dromaeo_css | took 1109781ms 14:20:20 INFO - TEST-START | kraken 14:20:20 INFO - operating with platform_type : linux_ 14:20:20 INFO - Initialising browser for kraken test... 14:20:20 INFO - TEST-INFO | started process 28087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp78Swne/profile http://localhost:36840/getInfo.html) 14:20:24 INFO - PROCESS | 28087 | 14:20:24 INFO - PROCESS | 28087 | (process:28158): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:20:24 INFO - PROCESS | 28087 | 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] 14:20:25 INFO - PROCESS | 28087 | __metrics Screen width/height:1600/1200 14:20:25 INFO - PROCESS | 28087 | colorDepth:24 14:20:25 INFO - PROCESS | 28087 | Browser inner width/height: 1024/697 14:20:25 INFO - PROCESS | 28087 | __metrics 14:20:26 ERROR - PROCESS | 28087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:20:26 INFO - TEST-INFO | 28087: exit 0 14:20:26 INFO - Browser initialized. 14:20:26 INFO - Running cycle 1/1 for kraken test... 14:20:26 INFO - TEST-INFO | started process 28209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp78Swne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:28 INFO - PROCESS | 28209 | 14:20:28 INFO - PROCESS | 28209 | (process:28268): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:20:38 INFO - PROCESS | 28209 | RSS: Main: 162611200 14:20:38 INFO - PROCESS | 28209 | 14:20:41 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36840/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:42 INFO - PROCESS | 28209 | RSS: Main: 167444480 14:20:42 INFO - PROCESS | 28209 | 14:20:44 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36840/tests/kraken/driver.html?testName=audio-dft) 14:20:45 INFO - PROCESS | 28209 | RSS: Main: 170561536 14:20:45 INFO - PROCESS | 28209 | 14:20:48 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36840/tests/kraken/driver.html?testName=audio-fft) 14:20:48 INFO - PROCESS | 28209 | RSS: Main: 160468992 14:20:48 INFO - PROCESS | 28209 | 14:20:51 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36840/tests/kraken/driver.html?testName=audio-oscillator) 14:20:51 INFO - PROCESS | 28209 | RSS: Main: 161144832 14:20:51 INFO - PROCESS | 28209 | 14:20:54 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36840/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:54 INFO - PROCESS | 28209 | RSS: Main: 162717696 14:20:54 INFO - PROCESS | 28209 | 14:20:57 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36840/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:58 INFO - PROCESS | 28209 | RSS: Main: 162779136 14:20:58 INFO - PROCESS | 28209 | 14:21:01 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36840/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:02 INFO - PROCESS | 28209 | RSS: Main: 165158912 14:21:02 INFO - PROCESS | 28209 | 14:21:05 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36840/tests/kraken/driver.html?testName=json-parse-financial) 14:21:05 INFO - PROCESS | 28209 | RSS: Main: 165507072 14:21:05 INFO - PROCESS | 28209 | 14:21:07 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36840/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:08 INFO - PROCESS | 28209 | RSS: Main: 165257216 14:21:08 INFO - PROCESS | 28209 | 14:21:09 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:10 INFO - PROCESS | 28209 | RSS: Main: 165208064 14:21:10 INFO - PROCESS | 28209 | 14:21:12 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:13 INFO - PROCESS | 28209 | RSS: Main: 165691392 14:21:13 INFO - PROCESS | 28209 | 14:21:15 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:16 INFO - PROCESS | 28209 | RSS: Main: 166162432 14:21:16 INFO - PROCESS | 28209 | 14:21:19 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:19 INFO - PROCESS | 28209 | RSS: Main: 166047744 14:21:19 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | Cycle 1(1): loaded http://localhost:36840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36840/tests/kraken/driver.html?testName=ai-astar) 14:21:21 INFO - PROCESS | 28209 | RSS: Main: 167481344 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | __start_tp_report 14:21:21 INFO - PROCESS | 28209 | _x_x_mozilla_page_load 14:21:21 INFO - PROCESS | 28209 | _x_x_mozilla_page_load_details 14:21:21 INFO - PROCESS | 28209 | |i|pagename|runs| 14:21:21 INFO - PROCESS | 28209 | |0;ai-astar;114;108;112;112;114;124;112;113;112;112 14:21:21 INFO - PROCESS | 28209 | |1;audio-beat-detection;163;130;152;183;131;164;164;130;198;130 14:21:21 INFO - PROCESS | 28209 | |2;audio-dft;162;161;161;162;164;166;173;162;166;164 14:21:21 INFO - PROCESS | 28209 | |3;audio-fft;76;73;79;160;77;75;76;76;164;77 14:21:21 INFO - PROCESS | 28209 | |4;audio-oscillator;93;94;153;92;95;93;152;92;92;153 14:21:21 INFO - PROCESS | 28209 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;117;117;118 14:21:21 INFO - PROCESS | 28209 | |6;imaging-darkroom;147;146;146;146;147;146;146;145;147;148 14:21:21 INFO - PROCESS | 28209 | |7;imaging-desaturate;96;96;96;96;96;96;97;96;96;96 14:21:21 INFO - PROCESS | 28209 | |8;json-parse-financial;60;61;59;57;59;59;68;79;56;56 14:21:21 INFO - PROCESS | 28209 | |9;json-stringify-tinderbox;62;62;61;61;63;61;62;62;62;62 14:21:21 INFO - PROCESS | 28209 | |10;stanford-crypto-aes;80;81;80;80;82;84;82;80;81;81 14:21:21 INFO - PROCESS | 28209 | |11;stanford-crypto-ccm;131;127;128;142;128;131;141;133;171;138 14:21:21 INFO - PROCESS | 28209 | |12;stanford-crypto-pbkdf2;166;164;167;166;166;164;169;161;162;172 14:21:21 INFO - PROCESS | 28209 | |13;stanford-crypto-sha256-iterative;69;68;67;69;81;67;65;69;67;67 14:21:21 INFO - PROCESS | 28209 | __end_tp_report 14:21:21 INFO - PROCESS | 28209 | __start_cc_report 14:21:21 INFO - PROCESS | 28209 | _x_x_mozilla_cycle_collect,839 14:21:21 INFO - PROCESS | 28209 | __end_cc_report 14:21:21 INFO - PROCESS | 28209 | __startTimestamp1460668881843__endTimestamp 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | ------- Summary: start ------- 14:21:21 INFO - PROCESS | 28209 | Number of tests: 14 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.50 stddev:4.11 (3.7%) stddev-sans-first:4.35 14:21:21 INFO - PROCESS | 28209 | Values: 114.0 108.0 112.0 112.0 114.0 124.0 112.0 113.0 112.0 112.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:163.50 stddev:24.30 (14.9%) stddev-sans-first:25.58 14:21:21 INFO - PROCESS | 28209 | Values: 163.0 130.0 152.0 183.0 131.0 164.0 164.0 130.0 198.0 130.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.63 (2.2%) stddev-sans-first:3.77 14:21:21 INFO - PROCESS | 28209 | Values: 162.0 161.0 161.0 162.0 164.0 166.0 173.0 162.0 166.0 164.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.25 (47.7%) stddev-sans-first:37.91 14:21:21 INFO - PROCESS | 28209 | Values: 76.0 73.0 79.0 160.0 77.0 75.0 76.0 76.0 164.0 77.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:92.50 stddev:28.84 (31.2%) stddev-sans-first:29.85 14:21:21 INFO - PROCESS | 28209 | Values: 93.0 94.0 153.0 92.0 95.0 93.0 152.0 92.0 92.0 153.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:21:21 INFO - PROCESS | 28209 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 14:21:21 INFO - PROCESS | 28209 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 148.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:21:21 INFO - PROCESS | 28209 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:59.50 stddev:7.07 (11.9%) stddev-sans-first:7.49 14:21:21 INFO - PROCESS | 28209 | Values: 60.0 61.0 59.0 57.0 59.0 59.0 68.0 79.0 56.0 56.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:21:21 INFO - PROCESS | 28209 | Values: 62.0 62.0 61.0 61.0 63.0 61.0 62.0 62.0 62.0 62.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:1.29 (1.6%) stddev-sans-first:1.30 14:21:21 INFO - PROCESS | 28209 | Values: 80.0 81.0 80.0 80.0 82.0 84.0 82.0 80.0 81.0 81.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:135.50 stddev:13.11 (9.7%) stddev-sans-first:13.73 14:21:21 INFO - PROCESS | 28209 | Values: 131.0 127.0 128.0 142.0 128.0 131.0 141.0 133.0 171.0 138.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:3.23 (1.9%) stddev-sans-first:3.43 14:21:21 INFO - PROCESS | 28209 | Values: 166.0 164.0 167.0 166.0 166.0 164.0 169.0 161.0 162.0 172.0 14:21:21 INFO - PROCESS | 28209 | 14:21:21 INFO - PROCESS | 28209 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:4.43 (6.5%) stddev-sans-first:4.70 14:21:21 INFO - PROCESS | 28209 | Values: 69.0 68.0 67.0 69.0 81.0 67.0 65.0 69.0 67.0 67.0 14:21:21 INFO - PROCESS | 28209 | -------- Summary: end -------- 14:21:21 INFO - PROCESS | 28209 | 14:21:22 INFO - TEST-INFO | 28209: exit 0 14:21:22 INFO - TEST-OK | kraken | took 62110ms 14:21:22 INFO - SUITE-END | took 1171s 14:21:23 INFO - Completed test suite (00:19:32) 14:21:23 INFO - javascript benchmark 14:21:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.8280244586545, 3145.056483055084, 3186.6335371432265, 3219.227385427498, 3227.080282119595, 5203.557697595704, 5450.209719590657, 5461.972690136554, 5478.205660179272, 5517.282753242078, 5333.306670132887, 5448.972755136218, 5465.398806131322, 5551.056320425528, 5569.888602227963, 4926.704397736147, 4947.307376967227, 5015.5486006259425, 5023.598112151019, 5054.241863720453, 4964.304997300363, 4994.700317980914, 5034.496550344973, 5042.899142017158, 5102.107131252034, 4898.926516102261, 4913.140200464904, 4920.729359885187, 4946.208606622959, 4981.32752078472, 4910.8281210157475, 4941.382327209099, 4957.082939656175, 4960.156773348539, 4993.375828021497, 4917.237828136645, 4919.311296418504, 4929.186684197103, 4936.086823937583, 4945.208766597327, 5350.117230656937, 5381.95051964867, 5386.030514507387, 5390.0, 5404.351477822647, 5752.935706894238, 5759.136129580596, 5789.363170051291, 5810.622309549865, 5821.50517206038, 5651.886962260773, 5764.0, 5824.213731146283, 5828.154917536934, 5834.620749651302, 5472.124460086367, 5478.616496845222, 5494.780208791643, 5497.752601132918, 5544.362398324163, 5920.940790592039, 5936.406359364116, 5954.642721436728, 5957.463828255478, 5958.6424814511265, 5551.167324901297, 5687.374388817227, 5713.542916566747, 5736.4550367715, 5743.052396354555, 5806.767729290866, 5836.066229403275, 5840.0, 5848.88302233953, 5865.384134665884, 5668.433156684381, 5770.769169233267, 5806.564507661942, 5812.418758124154, 5857.941420585825, 5562.082256427725, 5714.514266287329, 5718.513926316226, 5737.053386191232, 5737.971310143423, 4342.630876375543, 4350.978245108818, 4360.345948107809, 4384.780760961939, 4405.251107311765, 3845.442410850411, 3857.633524815138, 3861.7876016819346, 3871.588670989394, 3890.299746045739, 5418.810341638024, 5478.780848766005, 5498.780048798083, 5521.613487055948, 5529.751161197756, 5795.304563452412, 5807.767689292381, 5810.477057064884, 5813.157092221604, 5822.039363505059, 5528.474794894559, 5538.778448862, 5541.2796336476, 5545.667259964415, 5548.389677135512, 4840.298156767249, 4948.950510494921, 4967.4784147664695, 5006.249062640633, 5018.347614810052, 6023.096535519707, 6032.638041717511, 6035.818925432244, 6052.939470605325, 6064.66644334557, 5881.558883083786, 5896.941030589811, 5898.1152827076285, 5903.852403689943, 5905.763769449174, 5897.439743224387, 5914.290285165807, 5951.196588460675, 5962.105684147413, 6008.309044459768, 5692.0, 5693.202951586864, 5701.800436984686, 5703.0, 5704.60067795267, 5654.123610840326, 5739.655620662774, 5791.8552036199435, 5793.36273009977, 5799.043157879071, 5570.554355651457, 5634.098544233067, 5680.4319568042865, 5696.287964004499, 5728.856778580569, 5614.719264036864, 5664.801731939362, 5673.8297851064535, 5674.858128546819, 5734.655920644775, 5569.972150139223, 5574.86062848432, 5582.49757521825, 5604.635698679573, 5614.494695477427, 5594.804181853616, 5613.971930140323, 5639.661620302795, 5683.147527870852, 5764.279465066867, 5498.560115190855, 5524.33707955048, 5546.861328466659, 5561.721913904208, 5586.441355864381], "value": 5346.610964137677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.6951524237882, 623.090288179258, 667.4493542827167, 675.8411773233291, 692.9618870962101, 38574.61425385745, 38639.80680096599, 38702.0, 38796.61203387965, 41123.0, 42876.0, 43566.34650480237, 43772.0, 43835.561644383546, 43887.78056109715, 8651.697190598314, 8846.15961483658, 8853.73438796834, 8863.069377715343, 8870.42342247752, 8865.379423440361, 8897.154770296844, 8931.374803763707, 8983.19151276385, 8994.820103597924, 8983.236424903891, 8985.415947963395, 9015.233705135039, 9039.502827344493, 9058.0, 8924.419912705685, 8926.152015558511, 8974.057723938959, 8986.730398088068, 8996.100389961017, 8859.114088591154, 8912.108789121101, 8929.151730585649, 8940.195382415613, 8940.552972351357, 33493.33013339744, 40209.0, 40700.796496017334, 41057.384139237634, 41059.38410923839, 3234.838258087086, 3313.9005829825146, 3573.910652233689, 4130.752154870687, 4193.161367726467, 26468.86765566179, 26716.465670686674, 26762.330941726417, 27329.45341093167, 27472.0, 3999.14018486024, 4013.4180543821276, 4021.4369988201674, 4022.329661566061, 4087.4073259377224, 193953.0, 195013.0, 196260.0, 196436.0, 234814.82592587097, 34506.309873802886, 34633.0, 34722.61799421094, 34815.0, 35711.28577428489, 34486.82756586201, 34718.82640586781, 34725.82637086798, 34775.0, 34793.30413391718, 14882.702345953021, 14954.775678364833, 15016.549503514694, 15132.243387830564, 15143.394264229308, 12588.622341329774, 12639.0, 12640.683982900317, 12645.241285522714, 12660.240385576895, 8523.275521580736, 8542.701005464904, 8582.442141260799, 8664.046954834963, 8676.739697809076, 3293.4730443129465, 3305.7851239669344, 3329.8335083246225, 3343.281194543185, 3344.8662053518074, 1031.9484025798831, 1080.0333701337415, 1135.9261647992853, 1150.4880328254014, 1164.0512981919708, 31541.855497214994, 31979.680203198135, 32021.359572808415, 32190.83904580462, 32207.841116308777, 1090.6237348114887, 1148.414308702551, 1158.3802665573878, 1164.4122158694715, 1299.7725398055302, 15449.227538623023, 15627.453039143575, 15764.68470630581, 16137.677246455005, 16689.415870444474, 437104.0, 442089.0, 442096.0, 445885.0, 446829.0, 55524.0, 56528.15207771887, 56738.14892776612, 56764.148537771965, 56772.0, 1337.2377744685436, 1394.6652803327129, 1405.0305289350315, 1417.3905220754968, 1425.2659880161725, 30685.53971690382, 30758.077257682304, 31252.218694532818, 31451.528227076153, 31898.84050579732, 49610.50389496059, 50398.496015040844, 50462.2430663533, 50496.747516262185, 50522.2421663668, 399912.0, 402460.0, 403032.0, 403741.0, 403834.0, 27921.581176281965, 28882.70027848794, 28938.565921511614, 28990.420191596473, 29000.12999610015, 48322.275165873245, 50824.237636434744, 52086.21870672019, 52315.47684523106, 53170.202446964104, 37987.43018854775, 38813.02967425837, 38820.41769373405, 39054.0, 39410.211795764495, 38225.0, 38826.80586597049, 38952.22095558016, 39108.2178356437, 39632.40551391789, 35014.0, 38930.221395572495, 40102.0, 41810.58189418067, 42815.78592107019, 33783.4932476018, 33854.36675231411, 34453.655463445044, 34897.47653785144, 35043.12392190216, 27161.38256496361, 27900.30249243785, 27902.44195116127, 27912.581311280752, 27919.162425127277], "value": 18034.82844997983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.87398158607647, 383.6642937429749, 391.2644228849764, 391.3777094419873, 407.16531111221985, 16466.752998705015, 18484.815151848477, 18740.53148671284, 18806.34177803777, 18933.715994260096, 15831.920840395782, 15954.680906381865, 16092.114933678644, 16160.191990400463, 18650.440486785385, 5410.972945135279, 5537.446255374451, 5549.334079910416, 5560.082586373263, 5566.610337276392, 4000.9799951000205, 5771.2497375341145, 6096.4817990470865, 6120.571559990803, 6134.539909506782, 5878.118282257674, 6061.787837425691, 6062.060380641008, 6071.666058366788, 6107.664078475682, 6132.816015519542, 6133.3559976202305, 6144.56988010835, 6153.4154255345675, 6188.535859810532, 4726.385569875929, 5063.544281014726, 5084.161113416282, 5388.91916621251, 5390.21841832932, 11521.884781152165, 12322.0, 12331.0, 21698.0, 21734.239301624526, 2129.2601393933164, 2137.8075973162336, 2233.2072114399316, 2261.7059782228207, 2281.7147856517936, 9568.665096721581, 9625.989271126571, 10063.0, 10070.647527336581, 13046.804297935538, 1885.6605810954022, 1894.4506093232947, 1960.823525882663, 1978.4559246207264, 2000.449876284019, 70534.0, 76017.23982760157, 80603.5969820153, 80787.0, 81440.0, 9682.467464289532, 10009.199264059003, 10369.9481502592, 10465.162786977024, 10496.527656255486, 14712.852871471148, 14740.926295368454, 14826.925865370604, 14835.332410041574, 14844.2577871106, 7331.827198046938, 7995.040595128506, 8035.0, 8127.0653874803975, 8147.348212143014, 7773.795061765435, 7860.489068210548, 7909.762707118795, 8071.838563228703, 8119.106898241189, 4246.7027308088755, 4302.09655972243, 4372.698612547506, 4417.867463976086, 4619.122366750306, 1809.5204770735766, 1849.5653521422455, 1851.1484717030316, 1863.1802007116826, 1914.745841473809, 931.6226928093997, 971.7424882406168, 998.3161534348994, 1003.7741508160606, 1033.9586416543254, 17979.73030404545, 18755.718664220047, 18855.90572047131, 18928.43214703561, 19161.041947902828, 962.7689354554857, 987.6197663899451, 990.2672022703292, 1013.1337706261188, 1034.9793004139874, 10466.0, 10657.200709946785, 10677.57289708403, 10687.519061642244, 10729.9463502682, 477402.0, 479518.0, 494554.0, 499787.0, 507835.0, 91385.54307228421, 93245.5337723307, 93836.0, 94107.0, 94730.52634736782, 1049.3861091261697, 1075.4783929794044, 1084.7938891610568, 1101.2126329674322, 1108.866935967689, 16522.58693532671, 16897.408590699266, 17091.145442727564, 17150.571235718708, 17287.222075006404, 36856.44715329219, 37299.440508391854, 38345.80827095846, 38550.42174367443, 39596.2080758389, 50693.74653126858, 52096.0, 52257.38713064408, 53016.4698353027, 53205.46794532005, 7207.9279207207255, 7451.925480745123, 8135.471194372583, 8190.303824175012, 8507.702230421906, 11935.283882966702, 12625.936870315589, 12912.0, 13055.934720326337, 13180.934095329845, 11053.0, 11084.224104312621, 11221.495032723711, 11231.494582743959, 11349.659510214708, 7322.560646361236, 11185.888141118485, 11284.9435752824, 11551.0, 11594.826077608674, 5844.327902291291, 9693.854592180982, 10052.346597471142, 10978.725531861448, 10979.341239525334, 7630.8092297693, 7800.024996875391, 7872.921270787218, 7875.488093273919, 7934.2859142677435, 10519.579216831547, 10851.728706782395, 10924.344539327665, 11007.504662290055, 11124.721881953015], "value": 8793.02347683381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.8481151884812, 1532.908025518469, 1557.1202270717044, 1621.2380181314786, 1659.21187435968, 7432.739854105107, 8003.559804210773, 8151.062627797805, 8152.714654987077, 8264.586770661466, 7985.720499782508, 8018.278354948054, 8061.113277539466, 8093.0, 8110.675572977088, 2266.2634643740766, 2278.2481781012225, 2291.6218823894037, 2298.230092918874, 2301.4821665125296, 2222.633265511197, 2254.86470811751, 2270.92051778187, 2276.6243569811045, 2280.6122959096992, 2268.353519247015, 2268.5576312619046, 2294.33464295355, 2300.229423143249, 2302.8848557572137, 2222.100049479963, 2224.265992222579, 2234.251525738863, 2237.65316375962, 2241.876696781668, 2200.559888022386, 2204.2836078274463, 2209.2930262316067, 2210.2706106984656, 2212.9004194811273, 8045.637946292431, 8193.426460147792, 8217.178282171795, 8221.218984196492, 8268.958655206745, 4866.075445665312, 4973.1297023020825, 4981.875453113665, 5035.3454050973505, 5056.140456122468, 3342.197872510604, 3346.330733853239, 3389.86440542378, 3389.9661003390142, 3402.1664692150334, 1149.4884776274562, 1165.1494409081417, 1169.5146514196683, 1179.9792531120274, 1184.1592469346774, 10928.508217130247, 11030.28303160292, 11032.50353734084, 11059.059979901718, 11126.554937802479, 4281.272183728774, 4328.653707703376, 4455.5989960903025, 4491.483479399911, 4514.097180563835, 8933.28533717301, 8934.329925255632, 8965.0, 8968.23769979546, 9001.639934402681, 4970.353853998957, 5007.599392048627, 5034.647574669738, 5060.5698515625845, 5082.847514574569, 4211.4525111735275, 4646.326282688991, 4708.976455117771, 4714.740689262055, 4773.952260477351, 3671.687906527975, 3732.9626703732615, 3781.357169281229, 3833.0800607853917, 3844.7116466265143, 1139.7093741095966, 1181.3030312115893, 1197.0662882951312, 1209.2200530657676, 1213.9453724582415, 746.216472703659, 921.3550514639645, 938.4181807279394, 938.5213541093955, 969.8836139663285, 5558.722063896789, 5680.233168522279, 5712.971435142881, 5769.538436925036, 5885.234919460443, 965.232640051161, 977.9853302200472, 1002.2583288366557, 1007.5214273220308, 1032.9825122254574, 3801.334766415866, 3929.941050884239, 3937.6062393760967, 3946.7434616750393, 3968.0079980005, 9754.122129008423, 10106.848397274047, 10134.645287414905, 10155.695329140137, 10212.336198147097, 10209.030142136486, 10329.9483502582, 10352.585896564204, 10394.22043346752, 10409.063184313449, 7804.453688241769, 7949.085855126619, 7969.322607578305, 8019.0, 8034.558099304478, 5673.092305231144, 5800.767969281182, 5805.390434004537, 5840.2115714378015, 5941.287045554561, 9536.570854311434, 9546.284028697737, 9577.808443831223, 9633.181179599813, 9674.08096230857, 9229.584668690059, 9406.858897116412, 9781.951090244504, 9814.65648702292, 9832.213422926292, 6837.247902730596, 7410.333070023724, 7584.62076896164, 7671.424643151674, 7799.06411230656, 7931.84136317282, 7976.960115199387, 8007.959960200395, 8018.799530011563, 8030.5181689098845, 7112.110986126734, 7245.818854528679, 7293.234210407831, 7362.815929601588, 7425.554466732014, 6998.265182156004, 7093.787186384417, 7102.857942841218, 7108.971745119361, 7124.608146551989, 6161.291451483136, 6267.467265282502, 6276.089966954857, 6293.339199383999, 6315.747370105144, 4816.518348165296, 4995.200767877268, 5003.974980125076, 5015.824446144367, 5035.773390197377, 4944.48082951285, 5004.299398084344, 5030.723310217973, 5060.063888180698, 5079.466656001066], "value": 4430.701999224193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.73696936996345, 323.9983800080999, 326.5852367493284, 333.0026570421586, 334.2045930684972, 5952.583319167655, 6054.515638748895, 6064.332923378425, 6069.969650151748, 6088.0, 5917.55618328626, 5923.229980102591, 5931.792387266447, 5955.255593050869, 6000.279966404038, 4390.846320378788, 4531.640507847633, 4552.271636538155, 4568.588827005568, 4576.794044268016, 4529.479109902354, 4548.135854187711, 4548.613367863719, 4576.816927322903, 4576.931346029813, 4516.2322405191035, 4520.593146616804, 4535.795889184995, 4537.2286711259, 4540.636749060084, 4259.1268789897995, 4309.504406993189, 4433.645308375322, 4487.12501062293, 4507.954920450787, 3892.8053597320304, 3896.3181443247317, 3897.162110146304, 3917.4515567820526, 3925.4308125321954, 5690.829275121753, 5737.770489180428, 5739.368669446358, 5762.193292938992, 5789.913151302734, 4982.6013918886765, 5274.3670759509105, 5279.472052794728, 5280.973595132038, 5281.551068159211, 6153.353897840707, 6183.567150299481, 6185.072239164117, 6228.4394404503355, 6237.34507876671, 4296.957030429687, 4326.805293761789, 4363.3454981752675, 4391.5827996340295, 4396.296592545209, 6455.580387274859, 6460.189817429433, 6464.870702585969, 6506.642134682591, 6542.803715888531, 4435.312526558324, 4437.201303765289, 4451.599356057905, 4456.77716114193, 4458.9331160032625, 4219.0, 4457.732536047847, 4478.149151661174, 4483.453208643078, 4490.348899409632, 5223.164293712987, 5228.849653076317, 5236.795537026505, 5237.397699264558, 5249.580033597379, 6283.151774510383, 6289.528285378615, 6292.874142517124, 6312.715927783261, 6352.841178970562, 1557.5872393815648, 1573.087609186669, 1594.7288960876679, 1595.9840401596068, 1598.8640965518061, 1054.667779649408, 1069.4652673663168, 1071.8285074388061, 1091.9781604367868, 1106.6790630717003, 6017.097435384728, 6048.818535443944, 6074.848128796727, 6080.574359794772, 6088.939110608926, 6435.259945106279, 6461.741530338828, 6479.157709497735, 6506.429960165708, 6506.642134682544, 5917.165575533779, 5989.341172471025, 6061.212042434456, 6074.817755467343, 6089.812486565166, 3444.362792883325, 3449.4653328734084, 3478.356504046709, 3481.112316359363, 3500.9299814004085, 6427.871442571216, 6718.832029199211, 6721.764738234138, 6838.555493892881, 6838.931610683929, 6753.358430949052, 6758.189017317954, 6760.661966901635, 6768.424683901923, 6769.627670478072, 6636.203655561363, 6690.42062496562, 6711.3288671132495, 6817.454603631698, 6842.418394436529, 6439.291677915519, 6498.805035848932, 6529.4776417885505, 6560.277484843737, 6564.6389448578875, 6136.2636483622255, 6455.580387274812, 6485.6108633482145, 6487.3188315226225, 6517.511186660925, 6750.6624668767345, 6782.626955517494, 6787.355201255873, 6788.830279243059, 6807.931920680928, 4370.956290437055, 4401.559844015701, 4415.2494076006515, 4420.624246938917, 4423.778811059498, 6342.270638876588, 6519.3480651936325, 6548.869022619616, 6586.670666466754, 6589.604623722592, 6335.271443784024, 6367.816091954023, 6389.297177310399, 6406.13517175194, 6426.260979987362, 6054.515638748801, 6286.748530058747, 6344.904826427515, 6352.777652782131, 6355.809325720235, 5866.472017518444, 6010.969945150421, 6218.284897236876, 6231.158793562992, 6280.717367718372, 6335.461485773761, 6352.714127864165, 6358.237011558643, 6394.520410969289, 6415.486761059011, 6027.0, 6118.938810611837, 6142.0, 6182.567220294536, 6228.719707613259], "value": 4742.802195167778, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.9928500714991, 802.3541049455187, 833.7248707926383, 870.8519551676214, 882.5013867165053, 12693.238405695665, 12880.613581592545, 12888.0, 12963.546275880346, 14587.34356953937, 13589.252591107484, 13614.659633509167, 13624.727505449886, 13667.111637743565, 13667.658308542292, 817.2277198047847, 846.0566468387734, 855.5636625321068, 855.6919508976795, 856.1780690537092, 834.1783343406739, 843.9831203375929, 844.7296865003201, 846.1622993236713, 846.4413487098516, 872.162723785167, 873.7466134820894, 879.248242752447, 880.3573391424264, 881.532787622561, 873.5894129759004, 874.208840998897, 875.4353442029919, 877.591919757316, 881.5988725130114, 636.0903907412398, 637.4931929116364, 641.3650486018854, 642.7621779941405, 644.3395519592408, 13592.592222233348, 13677.31613419325, 13683.726325473435, 13683.86316136836, 13709.383077761524, 13240.536581219707, 13561.186328820302, 13655.453781848713, 13798.0, 14042.36809343582, 11559.884401156049, 11613.361265130414, 11621.47703353351, 11735.589254376142, 11882.168248222628, 3715.5541335039698, 3718.0890681782867, 3812.9809350953346, 3849.538055433366, 3878.941815872764, 54292.0, 54397.45602544003, 55459.44540554583, 55629.0, 55771.72114139403, 10680.412577308323, 10699.25013125185, 10762.999999999844, 10962.177836662282, 10967.561297548169, 19460.80539194618, 19463.513412164808, 19468.318608848906, 19497.22011119568, 19522.609547808963, 8310.418270721113, 8403.747887563382, 8489.320854331638, 8522.275606573387, 8523.06246312905, 4775.188218002879, 4809.639277054235, 4909.2881532177635, 4910.533499317559, 4965.528274813887, 3213.550102985584, 3295.0938491914435, 3298.4887342461957, 3300.207950091961, 3309.9007029789145, 572.705056895699, 582.9417058294222, 588.7703795519751, 597.1013624495193, 606.8907596632648, 608.3277977834517, 661.0810972747885, 709.2765379313072, 734.6400263870665, 750.0099868174067, 9070.138336857988, 9099.727008189764, 9099.863502047474, 9221.216196623229, 9300.767480812898, 611.2756383685347, 616.488314698799, 709.606168576445, 738.1843063414957, 770.0797546931475, 3951.4270430787374, 4078.7159190853217, 4227.450431443893, 4236.894077648083, 4284.721493102938, 61072.69463652653, 63418.0, 63974.68012659907, 64116.35883641104, 66682.33317666859, 53924.46075539273, 54252.0, 54556.0, 54592.0, 54742.452575474534, 48575.27137092876, 50405.24392134121, 50550.7472462628, 50578.0, 50727.0, 7962.800929976797, 8187.1403502631365, 8196.631151598072, 8335.041470231, 8396.37027222973, 29695.406091878474, 30006.399872002876, 30803.229919252197, 30843.383132336778, 30954.380912382076, 40487.15372039651, 43441.131177376905, 43568.0, 43594.782026090936, 44095.55904441043, 10053.396796192252, 10185.287029907835, 10447.268691191544, 10567.78864422692, 10661.360318380923, 12322.137450378388, 12405.813912791496, 12493.0, 12768.872311276768, 13230.470781168646, 12710.0, 12761.93619031899, 12951.287679177736, 13216.801747973981, 13645.522406715718, 12012.939935300268, 12099.75800484003, 12362.629121126382, 12383.62849114528, 12432.502699892264, 11314.547418103184, 12505.312207828656, 12885.48458061667, 13116.475340986635, 13194.208347499181, 9878.654247101316, 9892.851607225753, 10056.195504359488, 10087.798244035224, 10090.192784577363, 10156.746081348025, 10659.733506662396, 10752.516136773707, 10859.294145880809, 10897.782044359226], "value": 6635.54527812372, "unit": "score"}], "name": "dromaeo_css", "value": 7005.811768689743, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 112.0, 112.0, 114.0, 124.0, 112.0, 113.0, 112.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 152.0, 183.0, 131.0, 164.0, 164.0, 130.0, 198.0, 130.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 164.0, 166.0, 173.0, 162.0, 166.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 79.0, 160.0, 77.0, 75.0, 76.0, 76.0, 164.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 153.0, 92.0, 95.0, 93.0, 152.0, 92.0, 92.0, 153.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 57.0, 59.0, 59.0, 68.0, 79.0, 56.0, 56.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 80.0, 82.0, 84.0, 82.0, 80.0, 81.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 128.0, 142.0, 128.0, 131.0, 141.0, 133.0, 171.0, 138.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 167.0, 166.0, 166.0, 164.0, 169.0, 161.0, 162.0, 172.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 69.0, 81.0, 67.0, 65.0, 69.0, 67.0, 67.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1571.8999999999999, "alertThreshold": 2.0}]} 14:21:23 INFO - Return code: 0 14:21:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:23 ERROR - # TBPL SUCCESS # 14:21:23 INFO - Running post-action listener: _resource_record_post_action 14:21:23 INFO - Running post-run listener: _resource_record_post_run 14:21:24 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536924160; Read time: 12; Write time: 784884 14:21:24 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 188182528; Read time: 0; Write time: 507724 14:21:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284442624; Read time: 12; Write time: 206276 14:21:24 INFO - Running post-run listener: _upload_blobber_files 14:21:24 INFO - Blob upload gear active. 14:21:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:21:24 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 14:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:21:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:21:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:25 INFO - (blobuploader) - INFO - Done attempting. 14:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:26 INFO - (blobuploader) - INFO - Done attempting. 14:21:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:26 INFO - Return code: 0 14:21:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:21:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a4bd3ef0d1587e23874f97f546be10c0970caaaa13584e4b08e636ffd8beb7bb8396881edec97e71e5e449a3847022cfeb625e9a6a77876165e241f069a7819", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54fc8df8fc4cc0d7bdc4f32a3d7aab6cf7c8af2ade561ae6b0b3bc024df16b0fdb29a67eb7877f12c3d98f2823081fb25612802c27100d703403d2ec3e564b04"} 14:21:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:21:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:21:26 INFO - Contents: 14:21:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a4bd3ef0d1587e23874f97f546be10c0970caaaa13584e4b08e636ffd8beb7bb8396881edec97e71e5e449a3847022cfeb625e9a6a77876165e241f069a7819", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54fc8df8fc4cc0d7bdc4f32a3d7aab6cf7c8af2ade561ae6b0b3bc024df16b0fdb29a67eb7877f12c3d98f2823081fb25612802c27100d703403d2ec3e564b04"} 14:21:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:26 INFO - Copying logs to upload dir... 14:21:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:21:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.853249 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-14 14:21:26.326344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:26.329603) ========= 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=aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646 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/sha512/0a4bd3ef0d1587e23874f97f546be10c0970caaaa13584e4b08e636ffd8beb7bb8396881edec97e71e5e449a3847022cfeb625e9a6a77876165e241f069a7819", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54fc8df8fc4cc0d7bdc4f32a3d7aab6cf7c8af2ade561ae6b0b3bc024df16b0fdb29a67eb7877f12c3d98f2823081fb25612802c27100d703403d2ec3e564b04"} build_url:https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/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/sha512/0a4bd3ef0d1587e23874f97f546be10c0970caaaa13584e4b08e636ffd8beb7bb8396881edec97e71e5e449a3847022cfeb625e9a6a77876165e241f069a7819", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54fc8df8fc4cc0d7bdc4f32a3d7aab6cf7c8af2ade561ae6b0b3bc024df16b0fdb29a67eb7877f12c3d98f2823081fb25612802c27100d703403d2ec3e564b04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:26.355152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:26.355502) ========= 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=aa52b8aba932b19cc50b5275000001de-1460667146.21587-1877493646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:26.440602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 14:21:26.440929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 14:21:26.441301) ========= ========= Total master_lag: 0.17 =========