builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1461006914.47 results: success (0) buildid: 20160418094943 builduid: 82cf067085264d8d8a7159b7c61cf302 revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.475043) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.475599) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.475944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.545967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.546269) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 12:15:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-04-18 12:15:14 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117681 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.680590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.681253) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016118 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.770495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.770847) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a229bf7891d7b453eb6e5269c11ace513e400a4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a229bf7891d7b453eb6e5269c11ace513e400a4 --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=fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 12:15:14,875 truncating revision to first 12 chars 2016-04-18 12:15:14,875 Setting DEBUG logging. 2016-04-18 12:15:14,875 attempt 1/10 2016-04-18 12:15:14,875 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a229bf7891d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 12:15:15,143 unpacking tar archive at: mozilla-aurora-1a229bf7891d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:15.367795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:15.368485) ========= script_repo_revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:15.369288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:15.369909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:15.380753) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-18 12:15:15.381056) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:15 INFO - MultiFileLogger online at 20160418 12:15:15 in /builds/slave/test 12:15:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:15:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:15 INFO - {'append_to_log': False, 12:15:15 INFO - 'base_work_dir': '/builds/slave/test', 12:15:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:15:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:15 INFO - 'branch': 'Mozilla-Aurora', 12:15:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:15 INFO - 'config_files': ('talos/linux_config.py',), 12:15:15 INFO - 'default_actions': ('clobber', 12:15:15 INFO - 'read-buildbot-config', 12:15:15 INFO - 'download-and-extract', 12:15:15 INFO - 'populate-webroot', 12:15:15 INFO - 'create-virtualenv', 12:15:15 INFO - 'install', 12:15:15 INFO - 'run-tests'), 12:15:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:15 INFO - 'download_minidump_stackwalk': True, 12:15:15 INFO - 'download_symbols': 'ondemand', 12:15:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:15 INFO - 'installer_path': 'installer.exe', 12:15:15 INFO - 'log_level': 'info', 12:15:15 INFO - 'log_name': 'talos', 12:15:15 INFO - 'log_to_console': True, 12:15:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:15 INFO - 'opt_config_files': (), 12:15:15 INFO - 'pip_index': False, 12:15:15 INFO - 'sps_profile': False, 12:15:15 INFO - 'sps_profile_interval': 0, 12:15:15 INFO - 'suite': 'dromaeojs-e10s', 12:15:15 INFO - 'system_bits': '32', 12:15:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:15 INFO - 'title': 'talos-linux64-ix-014', 12:15:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:15 INFO - 'use_talos_json': True, 12:15:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:15 INFO - 'work_dir': 'build'} 12:15:15 INFO - ##### 12:15:15 INFO - ##### Running clobber step. 12:15:15 INFO - ##### 12:15:15 INFO - Running pre-action listener: _resource_record_pre_action 12:15:15 INFO - Running main action method: clobber 12:15:15 INFO - rmtree: /builds/slave/test/build 12:15:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:16 INFO - Running post-action listener: _resource_record_post_action 12:15:16 INFO - ##### 12:15:16 INFO - ##### Running read-buildbot-config step. 12:15:16 INFO - ##### 12:15:16 INFO - Running pre-action listener: _resource_record_pre_action 12:15:16 INFO - Running main action method: read_buildbot_config 12:15:16 INFO - Using buildbot properties: 12:15:16 INFO - { 12:15:16 INFO - "project": "", 12:15:16 INFO - "product": "firefox", 12:15:16 INFO - "script_repo_revision": "production", 12:15:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:15:16 INFO - "repository": "", 12:15:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:15:16 INFO - "buildid": "20160418094943", 12:15:16 INFO - "pgo_build": "True", 12:15:16 INFO - "basedir": "/builds/slave/test", 12:15:16 INFO - "buildnumber": 206, 12:15:16 INFO - "slavename": "talos-linux64-ix-014", 12:15:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:15:16 INFO - "platform": "ubuntu64_hw", 12:15:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:15:16 INFO - "branch": "mozilla-aurora", 12:15:16 INFO - "repo_path": "releases/mozilla-aurora", 12:15:16 INFO - "revision": "1a229bf7891d7b453eb6e5269c11ace513e400a4", 12:15:16 INFO - "stage_platform": "linux64-pgo", 12:15:16 INFO - "builduid": "82cf067085264d8d8a7159b7c61cf302", 12:15:16 INFO - "slavebuilddir": "test" 12:15:16 INFO - } 12:15:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 12:15:16 INFO - Running post-action listener: _resource_record_post_action 12:15:16 INFO - ##### 12:15:16 INFO - ##### Running download-and-extract step. 12:15:16 INFO - ##### 12:15:16 INFO - Running pre-action listener: _resource_record_pre_action 12:15:16 INFO - Running main action method: download_and_extract 12:15:16 INFO - mkdir: /builds/slave/test/build/tests 12:15: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')]} 12:15:16 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:15:20 INFO - Downloaded 1448 bytes. 12:15:20 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:20 INFO - Using the following test package requirements: 12:15:20 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:15:20 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:20 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:15:20 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'jsshell-linux-x86_64.zip'], 12:15:20 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:20 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:15:20 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:15:20 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:15:20 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:20 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:15:20 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15: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')]} 12:15:20 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:24 INFO - Downloaded 23351834 bytes. 12:15:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:15:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:15:25 INFO - Return code: 0 12:15:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:25 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:30 INFO - Downloaded 23351834 bytes. 12:15:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:15:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:15:31 INFO - Return code: 0 12:15:31 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')]} 12:15:31 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:15:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:15:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:15:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:15:32 INFO - Downloaded 10845168 bytes. 12:15:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:15:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:15:32 INFO - Return code: 0 12:15:32 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')]} 12:15:32 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:15:34 INFO - Downloaded 60592669 bytes. 12:15:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:34 INFO - mkdir: /builds/slave/test/properties 12:15:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:34 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:34 INFO - Contents: 12:15:34 INFO - build_url:https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:35 INFO - Running post-action listener: _resource_record_post_action 12:15:35 INFO - Running post-action listener: set_extra_try_arguments 12:15:35 INFO - ##### 12:15:35 INFO - ##### Running populate-webroot step. 12:15:35 INFO - ##### 12:15:35 INFO - Running pre-action listener: _resource_record_pre_action 12:15:35 INFO - Running main action method: populate_webroot 12:15:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:35 INFO - '--tppagecycles', 12:15:35 INFO - '7'], 12:15:35 INFO - 'tests': ['tsvgm']}}, 12:15:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:15:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:15:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'tests': ['damp', 'tps']}, 12:15:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['damp', 'tps']}, 12:15:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:15:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:35 INFO - 'other': {'tests': ['a11yr', 12:15:35 INFO - 'ts_paint', 12:15:35 INFO - 'tpaint', 12:15:35 INFO - 'sessionrestore', 12:15:35 INFO - 'sessionrestore_no_auto_restore', 12:15:35 INFO - 'tabpaint']}, 12:15:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['a11yr', 12:15:35 INFO - 'ts_paint', 12:15:35 INFO - 'tpaint', 12:15:35 INFO - 'sessionrestore', 12:15:35 INFO - 'sessionrestore_no_auto_restore', 12:15:35 INFO - 'tabpaint']}, 12:15:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['a11yr', 12:15:35 INFO - 'ts_paint', 12:15:35 INFO - 'tpaint', 12:15:35 INFO - 'sessionrestore', 12:15:35 INFO - 'sessionrestore_no_auto_restore', 12:15:35 INFO - 'tabpaint']}, 12:15:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['a11yr', 12:15:35 INFO - 'ts_paint', 12:15:35 INFO - 'tpaint', 12:15:35 INFO - 'sessionrestore', 12:15:35 INFO - 'sessionrestore_no_auto_restore', 12:15:35 INFO - 'tabpaint']}, 12:15:35 INFO - 'other_l64': {'tests': ['a11yr', 12:15:35 INFO - 'ts_paint', 12:15:35 INFO - 'tpaint', 12:15:35 INFO - 'sessionrestore', 12:15:35 INFO - 'sessionrestore_no_auto_restore', 12:15:35 INFO - 'tabpaint']}, 12:15:35 INFO - 'other_nol64': {'tests': ['a11yr', 12:15:35 INFO - 'ts_paint', 12:15:35 INFO - 'tpaint', 12:15:35 INFO - 'sessionrestore', 12:15:35 INFO - 'sessionrestore_no_auto_restore', 12:15:35 INFO - 'tabpaint']}, 12:15:35 INFO - 'svgr': {'tests': ['tsvgx', 12:15:35 INFO - 'tsvgr_opacity', 12:15:35 INFO - 'tart', 12:15:35 INFO - 'tscrollx', 12:15:35 INFO - 'cart']}, 12:15:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['tsvgx', 12:15:35 INFO - 'tsvgr_opacity', 12:15:35 INFO - 'tart', 12:15:35 INFO - 'tscrollx', 12:15:35 INFO - 'cart']}, 12:15:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'tests': ['tp5o']}, 12:15:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'talos_options': ['--e10s'], 12:15:35 INFO - 'tests': ['tp5o']}, 12:15:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'talos_options': ['--xperf_path', 12:15:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:35 INFO - 'tests': ['tp5n']}, 12:15:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:35 INFO - 'talos_options': ['--e10s', 12:15:35 INFO - '--xperf_path', 12:15:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:35 INFO - 'tests': ['tp5n']}}, 12:15:35 INFO - 'talos.zip': {'path': '', 12:15:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:35 INFO - Running post-action listener: _resource_record_post_action 12:15:35 INFO - ##### 12:15:35 INFO - ##### Running create-virtualenv step. 12:15:35 INFO - ##### 12:15:35 INFO - Running pre-action listener: _resource_record_pre_action 12:15:35 INFO - Running main action method: create_virtualenv 12:15:35 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:35 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 12:15:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:35 INFO - Using real prefix '/usr' 12:15:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:37 INFO - Installing pip.................done. 12:15:37 INFO - Return code: 0 12:15:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:37 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 12:15:37 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 12:15:37 INFO - Using env: {'DISPLAY': ':0', 12:15:37 INFO - 'HOME': '/home/cltbld', 12:15:37 INFO - 'LANG': 'en_US.UTF-8', 12:15:37 INFO - 'LANGUAGE': 'en_US:en', 12:15:37 INFO - 'LOGNAME': 'cltbld', 12:15:37 INFO - 'MAIL': '/var/mail/cltbld', 12:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:37 INFO - 'MOZ_NO_REMOTE': '1', 12:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:37 INFO - 'NO_EM_RESTART': '1', 12:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:37 INFO - 'PWD': '/builds/slave/test', 12:15:37 INFO - 'SHELL': '/bin/bash', 12:15:37 INFO - 'SHLVL': '1', 12:15:37 INFO - 'TERM': 'linux', 12:15:37 INFO - 'TMOUT': '86400', 12:15:37 INFO - 'USER': 'cltbld', 12:15:37 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:37 INFO - '_': '/tools/buildbot/bin/python'} 12:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:38 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 12:15:38 INFO - Cleaning up... 12:15:38 INFO - Return code: 0 12:15:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:15:38 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')]} 12:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:38 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')]} 12:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:38 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:38 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 12:15:38 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 12:15:38 INFO - Using env: {'DISPLAY': ':0', 12:15:38 INFO - 'HOME': '/home/cltbld', 12:15:38 INFO - 'LANG': 'en_US.UTF-8', 12:15:38 INFO - 'LANGUAGE': 'en_US:en', 12:15:38 INFO - 'LOGNAME': 'cltbld', 12:15:38 INFO - 'MAIL': '/var/mail/cltbld', 12:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:38 INFO - 'MOZ_NO_REMOTE': '1', 12:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:38 INFO - 'NO_EM_RESTART': '1', 12:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:38 INFO - 'PWD': '/builds/slave/test', 12:15:38 INFO - 'SHELL': '/bin/bash', 12:15:38 INFO - 'SHLVL': '1', 12:15:38 INFO - 'TERM': 'linux', 12:15:38 INFO - 'TMOUT': '86400', 12:15:38 INFO - 'USER': 'cltbld', 12:15:38 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:38 INFO - '_': '/tools/buildbot/bin/python'} 12:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:38 INFO - Downloading/unpacking psutil>=0.7.1 12:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:40 INFO - Installing collected packages: psutil 12:15:40 INFO - Running setup.py install for psutil 12:15:40 INFO - building 'psutil._psutil_linux' extension 12:15:40 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 12:15:40 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 12:15:40 INFO - building 'psutil._psutil_posix' extension 12:15:40 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 12:15:40 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 12:15:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:40 INFO - Successfully installed psutil 12:15:40 INFO - Cleaning up... 12:15:40 INFO - Return code: 0 12:15:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:15:40 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')]} 12:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:40 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')]} 12:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:40 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:40 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 12:15:40 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 12:15:40 INFO - Using env: {'DISPLAY': ':0', 12:15:40 INFO - 'HOME': '/home/cltbld', 12:15:40 INFO - 'LANG': 'en_US.UTF-8', 12:15:40 INFO - 'LANGUAGE': 'en_US:en', 12:15:40 INFO - 'LOGNAME': 'cltbld', 12:15:40 INFO - 'MAIL': '/var/mail/cltbld', 12:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:40 INFO - 'MOZ_NO_REMOTE': '1', 12:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:40 INFO - 'NO_EM_RESTART': '1', 12:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:40 INFO - 'PWD': '/builds/slave/test', 12:15:40 INFO - 'SHELL': '/bin/bash', 12:15:40 INFO - 'SHLVL': '1', 12:15:40 INFO - 'TERM': 'linux', 12:15:40 INFO - 'TMOUT': '86400', 12:15:40 INFO - 'USER': 'cltbld', 12:15:40 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:40 INFO - '_': '/tools/buildbot/bin/python'} 12:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:15:41 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 12:15:41 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 12:15:41 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 12:15:41 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 12:15:41 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 12:15:41 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 12:15:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:15:42 INFO - Installing collected packages: mozsystemmonitor 12:15:42 INFO - Running setup.py install for mozsystemmonitor 12:15:43 INFO - Successfully installed mozsystemmonitor 12:15:43 INFO - Cleaning up... 12:15:43 INFO - Return code: 0 12:15:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:43 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:43 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 12:15:43 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 12:15:43 INFO - Using env: {'DISPLAY': ':0', 12:15:43 INFO - 'HOME': '/home/cltbld', 12:15:43 INFO - 'LANG': 'en_US.UTF-8', 12:15:43 INFO - 'LANGUAGE': 'en_US:en', 12:15:43 INFO - 'LOGNAME': 'cltbld', 12:15:43 INFO - 'MAIL': '/var/mail/cltbld', 12:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:43 INFO - 'MOZ_NO_REMOTE': '1', 12:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:43 INFO - 'NO_EM_RESTART': '1', 12:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:43 INFO - 'PWD': '/builds/slave/test', 12:15:43 INFO - 'SHELL': '/bin/bash', 12:15:43 INFO - 'SHLVL': '1', 12:15:43 INFO - 'TERM': 'linux', 12:15:43 INFO - 'TMOUT': '86400', 12:15:43 INFO - 'USER': 'cltbld', 12:15:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:43 INFO - '_': '/tools/buildbot/bin/python'} 12:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:43 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 12:15:43 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 12:15:43 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 12:15:43 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 12:15:43 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 12:15:43 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 12:15:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:46 INFO - Downloading docopt-0.6.1.tar.gz 12:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:46 INFO - Running setup.py install for blobuploader 12:15:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:46 INFO - Running setup.py install for requests 12:15:46 INFO - Running setup.py install for docopt 12:15:46 INFO - Successfully installed blobuploader requests docopt 12:15:46 INFO - Cleaning up... 12:15:46 INFO - Return code: 0 12:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:46 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 12:15:46 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 12:15:46 INFO - Using env: {'DISPLAY': ':0', 12:15:46 INFO - 'HOME': '/home/cltbld', 12:15:46 INFO - 'LANG': 'en_US.UTF-8', 12:15:46 INFO - 'LANGUAGE': 'en_US:en', 12:15:46 INFO - 'LOGNAME': 'cltbld', 12:15:46 INFO - 'MAIL': '/var/mail/cltbld', 12:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:46 INFO - 'MOZ_NO_REMOTE': '1', 12:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:46 INFO - 'NO_EM_RESTART': '1', 12:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:46 INFO - 'PWD': '/builds/slave/test', 12:15:46 INFO - 'SHELL': '/bin/bash', 12:15:46 INFO - 'SHLVL': '1', 12:15:46 INFO - 'TERM': 'linux', 12:15:46 INFO - 'TMOUT': '86400', 12:15:46 INFO - 'USER': 'cltbld', 12:15:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:46 INFO - '_': '/tools/buildbot/bin/python'} 12:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:46 INFO - Running setup.py (path:/tmp/pip-5tz6fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:47 INFO - Running setup.py (path:/tmp/pip-0DVSiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:47 INFO - Running setup.py (path:/tmp/pip-8lkUI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:47 INFO - Running setup.py (path:/tmp/pip-_Dzcfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:47 INFO - Running setup.py (path:/tmp/pip-2HpX0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:47 INFO - Running setup.py (path:/tmp/pip-pGvlxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:47 INFO - Running setup.py (path:/tmp/pip-WLke8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:47 INFO - Running setup.py (path:/tmp/pip-U0zqPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:47 INFO - Running setup.py (path:/tmp/pip-Kysw72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:47 INFO - Running setup.py (path:/tmp/pip-bXa86a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:47 INFO - Running setup.py (path:/tmp/pip-7mbqnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:47 INFO - Running setup.py (path:/tmp/pip-t6kDvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:47 INFO - Running setup.py (path:/tmp/pip-9czOGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:47 INFO - Running setup.py (path:/tmp/pip-HVjZHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:47 INFO - Running setup.py (path:/tmp/pip-esCkgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:48 INFO - Running setup.py (path:/tmp/pip-b3ek9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:48 INFO - Running setup.py (path:/tmp/pip-LwY2BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:48 INFO - Running setup.py install for manifestparser 12:15:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozcrash 12:15:48 INFO - Running setup.py install for mozdebug 12:15:48 INFO - Running setup.py install for mozdevice 12:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozfile 12:15:48 INFO - Running setup.py install for mozhttpd 12:15:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozinfo 12:15:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozInstall 12:15:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:48 INFO - Running setup.py install for mozleak 12:15:49 INFO - Running setup.py install for mozlog 12:15:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for moznetwork 12:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozprocess 12:15:49 INFO - Running setup.py install for mozprofile 12:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozrunner 12:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Running setup.py install for mozscreenshot 12:15:49 INFO - Running setup.py install for moztest 12:15:49 INFO - Running setup.py install for mozversion 12:15:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:49 INFO - Cleaning up... 12:15:49 INFO - Return code: 0 12:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:49 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:49 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 12:15:49 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 12:15:49 INFO - Using env: {'DISPLAY': ':0', 12:15:49 INFO - 'HOME': '/home/cltbld', 12:15:49 INFO - 'LANG': 'en_US.UTF-8', 12:15:49 INFO - 'LANGUAGE': 'en_US:en', 12:15:49 INFO - 'LOGNAME': 'cltbld', 12:15:49 INFO - 'MAIL': '/var/mail/cltbld', 12:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:49 INFO - 'MOZ_NO_REMOTE': '1', 12:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:49 INFO - 'NO_EM_RESTART': '1', 12:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:49 INFO - 'PWD': '/builds/slave/test', 12:15:49 INFO - 'SHELL': '/bin/bash', 12:15:49 INFO - 'SHLVL': '1', 12:15:49 INFO - 'TERM': 'linux', 12:15:49 INFO - 'TMOUT': '86400', 12:15:49 INFO - 'USER': 'cltbld', 12:15:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:49 INFO - '_': '/tools/buildbot/bin/python'} 12:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:50 INFO - Running setup.py (path:/tmp/pip-hetVvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:50 INFO - Running setup.py (path:/tmp/pip-92sSyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:50 INFO - Running setup.py (path:/tmp/pip-FADtqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:50 INFO - Running setup.py (path:/tmp/pip-Fs1_Ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:50 INFO - Running setup.py (path:/tmp/pip-peaOay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:50 INFO - Running setup.py (path:/tmp/pip-3ojXjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:50 INFO - Running setup.py (path:/tmp/pip-6xuqQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:50 INFO - Running setup.py (path:/tmp/pip-dKXdSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:50 INFO - Running setup.py (path:/tmp/pip-YEtFcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:50 INFO - Running setup.py (path:/tmp/pip-afU83V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:50 INFO - Running setup.py (path:/tmp/pip-L4wqO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:50 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)) 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:50 INFO - Running setup.py (path:/tmp/pip-BXHjQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:51 INFO - Running setup.py (path:/tmp/pip-wCdJiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:51 INFO - Running setup.py (path:/tmp/pip-G8Cyox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:51 INFO - Running setup.py (path:/tmp/pip-qpTYY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:51 INFO - Running setup.py (path:/tmp/pip-zxs55_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:51 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)) 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:51 INFO - Running setup.py (path:/tmp/pip-5TUiVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:51 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)) 12:15:51 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)) 12:15:51 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)) 12:15:51 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)) 12:15:51 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)) 12:15:51 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)) 12:15:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:51 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 12:15:51 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 12:15:51 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 12:15:51 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 12:15:51 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 12:15:51 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 12:15:53 INFO - Downloading blessings-1.6.tar.gz 12:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:53 INFO - Installing collected packages: blessings 12:15:53 INFO - Running setup.py install for blessings 12:15:53 INFO - Successfully installed blessings 12:15:53 INFO - Cleaning up... 12:15:53 INFO - Return code: 0 12:15:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:53 INFO - Reading from file tmpfile_stdout 12:15:53 INFO - Current package versions: 12:15:53 INFO - argparse == 1.2.1 12:15:53 INFO - blessings == 1.6 12:15:53 INFO - blobuploader == 1.2.4 12:15:53 INFO - docopt == 0.6.1 12:15:53 INFO - manifestparser == 1.1 12:15:53 INFO - mozInstall == 1.12 12:15:53 INFO - mozcrash == 0.17 12:15:53 INFO - mozdebug == 0.1 12:15:53 INFO - mozdevice == 0.48 12:15:53 INFO - mozfile == 1.2 12:15:53 INFO - mozhttpd == 0.7 12:15:53 INFO - mozinfo == 0.9 12:15:53 INFO - mozleak == 0.1 12:15:53 INFO - mozlog == 3.1 12:15:53 INFO - moznetwork == 0.27 12:15:53 INFO - mozprocess == 0.22 12:15:53 INFO - mozprofile == 0.28 12:15:53 INFO - mozrunner == 6.11 12:15:53 INFO - mozscreenshot == 0.1 12:15:53 INFO - mozsystemmonitor == 0.0 12:15:53 INFO - moztest == 0.7 12:15:53 INFO - mozversion == 1.4 12:15:53 INFO - psutil == 3.1.1 12:15:53 INFO - requests == 1.2.3 12:15:53 INFO - wsgiref == 0.1.2 12:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:53 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:53 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 12:15:53 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 12:15:53 INFO - Using env: {'DISPLAY': ':0', 12:15:53 INFO - 'HOME': '/home/cltbld', 12:15:53 INFO - 'LANG': 'en_US.UTF-8', 12:15:53 INFO - 'LANGUAGE': 'en_US:en', 12:15:53 INFO - 'LOGNAME': 'cltbld', 12:15:53 INFO - 'MAIL': '/var/mail/cltbld', 12:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:53 INFO - 'MOZ_NO_REMOTE': '1', 12:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:53 INFO - 'NO_EM_RESTART': '1', 12:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:53 INFO - 'PWD': '/builds/slave/test', 12:15:53 INFO - 'SHELL': '/bin/bash', 12:15:53 INFO - 'SHLVL': '1', 12:15:53 INFO - 'TERM': 'linux', 12:15:53 INFO - 'TMOUT': '86400', 12:15:53 INFO - 'USER': 'cltbld', 12:15:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:53 INFO - '_': '/tools/buildbot/bin/python'} 12:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 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)) 12:15:53 INFO - Cleaning up... 12:15:53 INFO - Return code: 0 12:15:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:53 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:53 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 12:15:53 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 12:15:53 INFO - Using env: {'DISPLAY': ':0', 12:15:53 INFO - 'HOME': '/home/cltbld', 12:15:53 INFO - 'LANG': 'en_US.UTF-8', 12:15:53 INFO - 'LANGUAGE': 'en_US:en', 12:15:53 INFO - 'LOGNAME': 'cltbld', 12:15:53 INFO - 'MAIL': '/var/mail/cltbld', 12:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:53 INFO - 'MOZ_NO_REMOTE': '1', 12:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:53 INFO - 'NO_EM_RESTART': '1', 12:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:53 INFO - 'PWD': '/builds/slave/test', 12:15:53 INFO - 'SHELL': '/bin/bash', 12:15:53 INFO - 'SHLVL': '1', 12:15:53 INFO - 'TERM': 'linux', 12:15:53 INFO - 'TMOUT': '86400', 12:15:53 INFO - 'USER': 'cltbld', 12:15:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:53 INFO - '_': '/tools/buildbot/bin/python'} 12:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:54 INFO - Downloading/unpacking jsonschema 12:15:54 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 12:15:54 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 12:15:54 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 12:15:54 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 12:15:54 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 12:15:54 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 12:15:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:56 INFO - Downloading/unpacking functools32 (from jsonschema) 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:56 INFO - warning: no files found matching '*.txt' 12:15:56 INFO - no previously-included directories found matching 'build' 12:15:56 INFO - no previously-included directories found matching 'dist' 12:15:56 INFO - no previously-included directories found matching '.git*' 12:15:56 INFO - Installing collected packages: jsonschema, functools32 12:15:56 INFO - Running setup.py install for functools32 12:15:56 INFO - warning: no files found matching '*.txt' 12:15:56 INFO - no previously-included directories found matching 'build' 12:15:56 INFO - no previously-included directories found matching 'dist' 12:15:56 INFO - no previously-included directories found matching '.git*' 12:15:56 INFO - Successfully installed jsonschema functools32 12:15:56 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:15:56 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')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x7fc36f4b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1919410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', '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 12:15:56 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 12:15:56 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 12:15:56 INFO - Using env: {'DISPLAY': ':0', 12:15:56 INFO - 'HOME': '/home/cltbld', 12:15:56 INFO - 'LANG': 'en_US.UTF-8', 12:15:56 INFO - 'LANGUAGE': 'en_US:en', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MAIL': '/var/mail/cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SHLVL': '1', 12:15:56 INFO - 'TERM': 'linux', 12:15:56 INFO - 'TMOUT': '86400', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - '_': '/tools/buildbot/bin/python'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Downloading/unpacking flake8 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:15:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:15:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:15:59 INFO - no previously-included directories found matching 'docs/_build' 12:15:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:15:59 INFO - Running setup.py install for pep8 12:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:15:59 INFO - no previously-included directories found matching 'docs/_build' 12:15:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:15:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:15:59 INFO - Cleaning up... 12:15:59 INFO - Return code: 0 12:15:59 INFO - Running post-action listener: _resource_record_post_action 12:15:59 INFO - Running post-action listener: _start_resource_monitoring 12:15:59 INFO - Starting resource monitoring. 12:15:59 INFO - ##### 12:15:59 INFO - ##### Running install step. 12:15:59 INFO - ##### 12:15:59 INFO - Running pre-action listener: _resource_record_pre_action 12:15:59 INFO - Running main action method: install 12:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:59 INFO - Reading from file tmpfile_stdout 12:15:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:59 INFO - Reading from file tmpfile_stdout 12:15:59 INFO - Output received: 12:15:59 INFO - Usage: mozinstall [options] installer 12:15:59 INFO - Options: 12:15:59 INFO - -h, --help show this help message and exit 12:15:59 INFO - -d DEST, --destination=DEST 12:15:59 INFO - Directory to install application into. [default: 12:15:59 INFO - "/builds/slave/test"] 12:15:59 INFO - --app=APP Application being installed. [default: firefox] 12:15:59 INFO - mkdir: /builds/slave/test/build/application 12:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:16:15 INFO - Reading from file tmpfile_stdout 12:16:15 INFO - Output received: 12:16:15 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:15 INFO - Running post-action listener: _resource_record_post_action 12:16:15 INFO - ##### 12:16:15 INFO - ##### Running run-tests step. 12:16:15 INFO - ##### 12:16:15 INFO - Running pre-action listener: _resource_record_pre_action 12:16:15 INFO - Running main action method: run_tests 12:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:15 INFO - Python 2.7.3 12:16:15 INFO - Return code: 0 12:16:15 INFO - grabbing minidump binary from tooltool 12:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:15 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 0x19a8160>, '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 0x19a9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a94f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:15 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 12:16:15 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 12:16:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:15 INFO - Return code: 0 12:16:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:16:16 INFO - Return code: 0 12:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 12:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 12:16:16 INFO - Using env: {'DISPLAY': ':0', 12:16:16 INFO - 'HOME': '/home/cltbld', 12:16:16 INFO - 'LANG': 'en_US.UTF-8', 12:16:16 INFO - 'LANGUAGE': 'en_US:en', 12:16:16 INFO - 'LOGNAME': 'cltbld', 12:16:16 INFO - 'MAIL': '/var/mail/cltbld', 12:16:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:16 INFO - 'MOZ_NO_REMOTE': '1', 12:16:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:16 INFO - 'NO_EM_RESTART': '1', 12:16:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:16 INFO - 'PWD': '/builds/slave/test', 12:16:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:16 INFO - 'SHELL': '/bin/bash', 12:16:16 INFO - 'SHLVL': '1', 12:16:16 INFO - 'TERM': 'linux', 12:16:16 INFO - 'TMOUT': '86400', 12:16:16 INFO - 'USER': 'cltbld', 12:16:16 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725', 12:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:16 INFO - '_': '/tools/buildbot/bin/python'} 12:16:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 12:16:16 INFO - mozversion application_buildid: 20160418094943 12:16:16 INFO - mozversion application_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 12:16:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:16:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:16 INFO - mozversion application_name: Firefox 12:16:16 INFO - mozversion application_remotingname: firefox-dev 12:16:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:16 INFO - mozversion application_vendor: Mozilla 12:16:16 INFO - mozversion application_version: 47.0a2 12:16:16 INFO - mozversion platform_buildid: 20160418094943 12:16:16 INFO - mozversion platform_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 12:16:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:16 INFO - mozversion platform_version: 47.0a2 12:16:16 INFO - using testdate: 1461006976 12:16:16 INFO - actual date: 1461006976 12:16:16 INFO - starting webserver on 'localhost:54068' 12:16:16 INFO - SUITE-START | Running 2 tests 12:16:16 INFO - TEST-START | dromaeo_css 12:16:16 INFO - operating with platform_type : linux_ 12:16:16 INFO - Initialising browser for dromaeo_css test... 12:16:16 INFO - TEST-INFO | started process 15441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFCE2j/profile http://localhost:54068/getInfo.html) 12:16:19 INFO - PROCESS | 15441 | 12:16:19 INFO - PROCESS | 15441 | (process:15520): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:16:20 INFO - PROCESS | 15441 | __metrics Screen width/height:1600/1200 12:16:20 INFO - PROCESS | 15441 | colorDepth:24 12:16:20 INFO - PROCESS | 15441 | Browser inner width/height: 1024/697 12:16:20 INFO - PROCESS | 15441 | __metrics 12:16:21 ERROR - PROCESS | 15441 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:16:22 INFO - TEST-INFO | 15441: exit 0 12:16:22 INFO - Browser initialized. 12:16:22 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:22 INFO - TEST-INFO | started process 15571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFCE2j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:24 INFO - PROCESS | 15571 | 12:16:24 INFO - PROCESS | 15571 | (process:15639): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:16:34 INFO - PROCESS | 15571 | RSS: Main: 151461888 12:16:34 INFO - PROCESS | 15571 | 12:17:23 INFO - PROCESS | 15571 | 1461007043911 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] 12:19:31 INFO - PROCESS | 15571 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54068/tests/dromaeo/cssquery-ext.html) 12:19:33 INFO - PROCESS | 15571 | RSS: Main: 154525696 12:19:33 INFO - PROCESS | 15571 | 12:22:34 INFO - PROCESS | 15571 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-ext.html (next: http://localhost:54068/tests/dromaeo/cssquery-jquery.html) 12:22:35 INFO - PROCESS | 15571 | RSS: Main: 153624576 12:22:35 INFO - PROCESS | 15571 | 12:25:37 INFO - PROCESS | 15571 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54068/tests/dromaeo/cssquery-mootools.html) 12:25:37 INFO - PROCESS | 15571 | RSS: Main: 153190400 12:25:37 INFO - PROCESS | 15571 | 12:28:39 INFO - PROCESS | 15571 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54068/tests/dromaeo/cssquery-prototype.html) 12:28:39 INFO - PROCESS | 15571 | RSS: Main: 153063424 12:28:39 INFO - PROCESS | 15571 | 12:31:42 INFO - PROCESS | 15571 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54068/tests/dromaeo/cssquery-yui.html) 12:31:42 INFO - PROCESS | 15571 | RSS: Main: 154345472 12:31:42 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-yui.html (next: http://localhost:54068/tests/dromaeo/cssquery-dojo.html) 12:34:45 INFO - PROCESS | 15571 | RSS: Main: 156069888 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | __start_tp_report 12:34:45 INFO - PROCESS | 15571 | _x_x_mozilla_page_load 12:34:45 INFO - PROCESS | 15571 | _x_x_mozilla_page_load_details 12:34:45 INFO - PROCESS | 15571 | |i|pagename|runs| 12:34:45 INFO - PROCESS | 15571 | |0;dojo.html;3338.9165270868225;3359.5968483781944;3399.7790143640646;3423.281110966697;3430.554027976364;5554;5574.1917421973785;5586.106223004315;5588.524975377093;5589.301337332833;5526.834194974157;5570.136628822529;5594.412586678391;5611.382747897728;5621.072523033705;5088.414832294287;5141.074606570815;5155.381354237496;5188.221766735001;5201.505856943584;5009.0482808266315;5116.309298244727;5194.792208311663;5215.322008138936;5240.711760853152;5107.591392688576;5152.613553983448;5185.429602743695;5199.09015922214;5213.661112027725;5128.051310507568;5131.409887862887;5135.306733590992;5139.922901156504;5153.819616313449;4870.732109733964;5021.046001259749;5032.597392208651;5087.974560127176;5104.259882317043;5272.841814745564;5338.225957236179;5349.3045904032615;5360.59795515334;5361.758720857571;5997.760089596411;6018.518518518508;6041.214642096544;6046.909296360514;6056.666883321415;5892.616979896293;5969.701514924236;6056.606320589148;6072.423119803611;6078.057901025348;5638.577106717013;5656.91514627281;5661.745221464962;5678.943210567924;5705.65766054034;6150.077488376779;6156.26124865019;6172.567920245539;6176.752929882844;6189.535784816067;5781.797637082682;5872.7357268923;5921.851953701106;5956.7319470623925;5960.254968128984;6025.3372129065765;6037.0642550404755;6041.577089603774;6048;6062;5888.146218798251;5890.1164825276555;5975.43233392827;5982.551308651869;5986.670733109634;5828.6794226317115;5938.406159384027;5965.9105113422465;5999.460048595647;6029.909551356734;4515.848458643025;4561.315802629632;4562.498125206224;4568.56598623137;4594.2419500782;4074.694397920168;4109.753414795122;4128.896777580524;4136.21411931732;4142.813573389144;5463.262459567987;5651.463111004448;5720.8283751487525;5745.511631511368;5766.798162064308;6028.638281703112;6119.380693981235;6122.947104152868;6126.408290899671;6126.622178332329;5553.333599968029;5700.515456186187;5714.085746280575;5714.542836573064;5728.971355143281;5073.746312684351;5120.129577971754;5130.897382052338;5149.0474262261605;5165.431802501722;6130.080487926846;6167.876642467215;6203.193584833943;6223;6234.501239900887;5867.295924489089;5881.147233651182;6056.9091463628965;6059.606125601822;6062.696865156813;6176.752929882754;6240.251169859464;6248.375162483715;6265.185525881606;6272.310045895039;5983;5988.041913294026;5992.860419201168;5996.850078748066;6035.9094613579955;5849.707514624337;5993.340732519507;6030.547708921936;6039.396060393926;6058.939410605837;5888.263967004124;5897.321807992136;5897.734601943009;5907.113932910098;5908.231929849264;5792.971035144966;5854.677992710442;5858.853528661817;5894.174815525744;5930.970345148246;5555.472230138131;5699.430056994267;5749.655020698771;5782.017057100219;5828.970855145697;5914.4381283777975;5923.703814809329;5932.733027013881;5956.910646340221;5964.642121472725;5780.45085716873;5780.479756821906;5795.884082318415;5817.040188368872;5844.47399734026 12:34:45 INFO - PROCESS | 15571 | |1;ext.html;513.9665921715091;539.5063516882053;555.9249501317323;571.2687759667625;596.8030549918527;30817.845910770444;38314.233715325674;38992.61007389925;39003;39292.80353598228;41215;41866.372004419885;41938;41973.58026419735;42015.369769453486;8883.51140687262;9069;9080.909190908105;9122.771930701752;9137.954310228439;8940.19538241558;9027.413218140833;9069.093090690943;9074.455532668027;9079.546022698873;9024.458532488072;9113.3165012624;9123.771905702344;9141.497217653026;9153.816923661523;8983.820323593523;9031.548422578877;9086.999999999967;9150.40522366044;9227.44635321883;9050.230730387924;9184.494852783095;9214.677486287948;9237.214836738885;9263.722088337361;40729.1854162918;40790.18419631621;41159.176816463805;41175.588244117476;41196.1760764783;3652.6347365263528;3671.0822294426393;3712.257548490286;3756.34264003801;3929.2337994091163;30460;30735.846320768476;30989.690103098907;33135;33944.83027584871;3932.075962148893;3968.3452230381954;4003.499562554681;4026.5369482509595;4056.8782936511952;279648;285181;285465;285675;285968;47135.29297060547;47471;69888;70467;70716.292837072;48201.348925808714;48385.758071210126;48448.5155148444;48465.273020904715;48528.27207591889;13511.932440337736;13524.797128043087;13571;13584.796228056586;13628.65928351799;10769.62306319275;10788.244822862482;10873.347599144077;10934.234603577674;10968.451577421256;15769.763453548207;15811.762823557656;15834.208289585475;15918.60203494922;15931.681366372608;6087.4521293083835;6107.267127944675;6120.724567394478;6212.534059945522;6271.435570798559;1062.3891262523925;1089.7548051688466;1092.5902786455079;1122.5790328626765;1127.7913585986619;29199.708002920124;29340.853295733385;30122.09633710992;30131.246718831768;30142.54786178209;1064.7870425914693;1078.5254488025244;1081.9459027048615;1097.0839349143396;1097.550004498152;15252.763631846976;15504.457343992906;15514.9224253878;15708;15901.204939752966;330549;554777.1305717309;555902;557417;557571;58048;58647.4135258642;58660.41339586635;58669.413305867245;59016;1444.833844107941;1452.992735036318;1482.2440555316866;1484.747592909208;1498.8576085271882;29841.850790745906;30117.69882301149;30388.84805575958;30668.846655766578;30774.538381924736;50771;51411.2288315683;51546.711332217;51585.484145158065;51686;248664;250840;250938;251786;251816;32207.838960805046;32397.514037288987;32719.18202044968;35718.821405892806;36205;46907.29639055485;47498;51687.74156129195;52065.7396713014;52567;36754.63245367619;37446;37546;37609.4358584616;37702;36115.27769444544;36548.63451365559;36732.44901326536;36792.63207367892;36857.81571092128;35851.46222806608;36485.45271820872;36629.63370366369;36651;37032.25935481222;32250.06871392538;32614.673853261163;33525.49711754277;35370.29259414849;35934.460983085795;27211.319717007234;27643.44713105767;27777.305567360978;27970.58044129299;27980.860095700205 12:34:45 INFO - PROCESS | 15571 | |2;jquery.html;374.39348255825564;391.1980440097799;392.174472734893;399.08410198594225;400.7054814711187;17210.569735756613;18995.43013709591;19485.805141948575;19639.410817675474;19719.901400493014;16997.2351244194;17284.827151728477;17388.130593470338;17390.304387824504;17505.3873114441;5066.898662026757;5100.183970564711;5254.924304899562;5319.973400132994;5371.838844834661;5253.57971362292;5292.10034294169;5342.732863356817;5367.329083864517;5385.488378604026;5237.13587258102;5300.310959575269;5320.962412329597;5353.625246232766;5361.195820626898;5713.685747283897;5792.189093526909;5796.478316951452;5853.2976042875125;5854.531637469014;5219.060569097561;5247.39654939683;5264.710440925747;5298.761555730001;5311.362636483608;13186;13807.240601766898;13871.514496992657;13944.860551394459;13969.945177685204;2413;2456.545539075277;2457.7050753909643;2689.0050681248063;2820.3372207531215;11435;14076.155430674193;14134.081284716563;14309;14393.496227631982;1950.4246247357064;1953.7264782930401;1958.2754380879023;1974.41241287157;2055.835533157359;63987.360126398606;65865.3413465864;66104;66144.33855661478;68945.96581051339;9591.328606997582;10436.37381757097;10909.418134370471;10943.671689849318;10947.124230061576;14429;15023.624409389853;15432.305546250445;15444.227788610524;15473.5357939262;7187.209406965229;7367.226441223702;7388.963055184689;7529.849403012018;7705.9229407706325;7212.891806622905;7239.384652304613;7288.817779555554;7347.926520734831;7355.535840668251;4618.076384723069;4710;4748.667593268438;4784.665073444826;4811.061842940663;1850.9259629614664;1890.3667271464215;1906.761654793151;1975.9703604445945;1986.3047933223256;952.8856537215579;953.3660116022767;986.8815742110993;1080.0819303591884;1080.5947769586405;17815.376461823773;17965.101744912703;17975.640487190445;17995.73006404879;18662;958.3339578992673;991.8809742830906;1020.0258752890971;1022.2639699416409;1026.071405378134;10079.49602519871;10177.084062434416;10454.059134677915;10668.093212077061;10749.462526873782;479866;480368;489212;495754;501877;79537.20462795414;80580.59709701414;81138.59430702927;81403;82546;1053.7681710023783;1060.7825395793843;1069.9786004280027;1077.504347999913;1089.4716062709422;16391.098489583186;16427.753583696493;16546.255418506436;16745.665086697954;17005.234764435878;27098.72901270962;34941.47587786135;35441;35796;36779.26441471102;45167.32249016202;45169.54830451653;46222.306665399374;46318.30522542097;47349.52650473451;8218;8425.915740842758;8578.099299573705;8590.78523036929;8636.481811091355;12545.435455404711;12639.431225594686;13352.265625390697;13400.865991339962;13506.122102063335;6693.665316734046;11539.249948753304;11852.881471185177;11945.283283003047;12314.568990085305;11600.129990250596;11753.471093800628;11960.880391196324;12110;12150.392480376122;11897.821532676844;11982.221155624857;12105.939470302592;12331.383430828602;12495.062870284582;8358.331333493428;11423.46230307379;11683.474243659226;12102.031837453158;12124.515019399125;8457.027441844266;8516.531590762568;8740.125987401208;11504.654860354203;12163.391830408622 12:34:45 INFO - PROCESS | 15571 | |3;mootools.html;1494.6935878144977;1517.3323737555477;1703.8381353771395;1826.1873466307497;1867.3744295660954;7070.787876363717;7652.6938922443105;7717.729879454207;7894.17111203324;7899.6050197490185;7827.452078354503;7839.725609603665;7889.763307100796;7896.368290536758;7897.644605992729;2339.169594793845;2348.3189874936247;2357.010055776578;2361.3860396296914;2363.8108951283943;2337.076854642415;2347.765223477647;2379.8096152307776;2382.5592265430864;2385.8568485890814;2315.641075633271;2319.420144963759;2346.002948746784;2382.0471811275456;2382.845115067515;2340.169239919821;2349.682792822964;2357.728861180969;2360.8111351091957;2361.645753137026;2313.5257272259146;2325.894526866974;2335.322756400642;2342.426105604121;2352.1297120065683;8036.4776289541;8053.919460805376;8069.112397636314;8075.838483230361;8090.635921383552;4778.4982576829625;4840.201366774513;4872.56146946773;4875.780589873464;4883.34074899891;3112.2997325601787;3117.890873819428;3126.8592913318957;3149.653538110806;3163.4147682678777;1087.1357270969597;1109.6615532262738;1113.560143743225;1130.2427373659668;1150.447785063166;11149.609763658233;11151.330920144736;11158.386288754115;11169.106471482262;11206.047485963703;4253.617174454314;4255.106427650228;4266.31738921771;4284.871453856389;4331.761753103609;9589.760255993657;9600.951995239979;9610.087041731025;9612.75968100803;9632.47021413829;4824.758762061953;4882.902341953141;4885.706857588556;4893.363862697826;4894.094592500399;4011.2980228460488;4347.3261644445165;4434.911301773946;4450.621697155713;4463.285874260103;3672.1003354177865;3761.586225515191;3780.2250538639514;3798.867039653654;3858.2090671412293;1193.7015746063485;1199.1905463811893;1209.6189700244395;1232.445399570179;1232.7287996640725;1193.8268951002055;1203.759248150356;1301.4859130643342;1466.1349803615706;1486.4425840309884;7477.551346919202;7571.583562904093;7803.570803605742;7809.921900781033;7811.804704882424;512.6565201315128;520.4015382310373;520.7422325948604;526.0426024635127;529.7616072767194;5809.883802324014;5841.795537156179;5842.444967728059;5881.500072493886;5894.823155305262;9127.634894604142;9680.080392362714;9688.806223875625;9807.313488055768;9840.212782977345;9535.52322383878;9543.522823858779;9584.472853992958;9649;9668.371555848847;7514.39884809214;7702.191269916578;7708.691652333844;7722.382209423233;7780.610969451504;7377.852442951218;7398.889016664647;7413.481056326221;7428.442866785121;7446.292602202782;8175.305099066646;8667.393282470166;8679.91320086791;8714.607842647223;8756.868646970173;8417.494950303002;8487.236148746642;8502.277306429023;8528.104549022264;8534.31725461974;6370.140031095742;6860.348266914635;6983.1620205575655;7016.5790052597;7046.436285097282;7474.738384156529;7509.812254693457;7513.2111128330735;7521.0974683038385;7561.886571701539;6741.528093033637;6837.1111755471475;6864.5881247125335;6894.965525172342;6954.687039083152;6794.558353706993;6859.211190712932;6895.138107736533;6934.237233904166;6947.305269473214;6915.273896241023;6944.062551555678;7054.294570542905;7128.928710712827;7166.713331466683;6522.5760325578685;6530.412262896362;6564.80305590833;6568.408843204134;6570.507211959218;6618.569792963442;6771.52599318043;6825.658717064226;6832.795016149524;6840.794776156723 12:34:45 INFO - PROCESS | 15571 | |4;prototype.html;355.3337492202121;360.320795300858;360.70242050308497;369.4882587616151;370.10250143402243;6199.597026193294;6226.377362263777;6253.124562561239;6295.559310848237;6320.873582528347;6363.872722545546;6383.946648802942;6395.0407438884195;6414.326495717953;6421.261554921185;4969.4036715594175;4981.1283025470575;4983.900321993558;4984.152694042022;4987.376577927759;4944.1594928862;4954.232094025432;4969;4980.27785971034;4988.927380613168;4956.430010548779;4960.032793605248;4960.206366981283;4961.429435614897;4964.329815474919;4844.055409195208;4911.115999120157;4935.099986505185;4939.777710003041;4949.50504949504;4304.139172165579;4322.459692538433;4328.870133895988;4329.913401731979;4337.804798784062;6053.697315134225;6076.756929722806;6082.635041897501;6090.330063693034;6111.991521398963;5563.916541251884;5698.6580805151825;5700;5708.942910570882;5753.769849206027;6742.292059333798;6752.932470675329;6753.49348798842;6758.1890173179045;6767.086443330137;4622.052479241747;4634.2585186370015;4665.043666048452;4673.042026384583;4676.929846052312;6969.05917701109;7073.575585464889;7080.575165490087;7085.539439936388;7092.645367731644;4693.530646935279;4776.8566942991765;4787.473377928425;4796.856094317176;4805.687630304019;4783.234682450791;4887.560119589254;4894.3147959285725;4894.363732714724;4900.26496025599;5655.943440565542;5663.801766938137;5671.574631902541;5675.347335056521;5684.8863022739315;6844.315568443216;6854.931450685429;6862.588244705334;6864.656767161622;6890.44876409896;1694.1190580897864;1714.9142542872808;1715.2110029386622;1715.485354393677;1721.0362197169625;1095.200503632337;1123.3428444359977;1131.575659127827;1133.2010932292715;1133.4672703829187;6505.512086593524;6509.934900650933;6512.902306465407;6520.739170433224;6563.835904102436;6991.720331186797;7010.92989070113;7051.89422158668;7062.788116356517;7072.7524536642;6343.111964324999;6354.904676429857;6370.458511026614;6373.745050198033;6382.904256436157;3791.033286511977;3802.8288727007352;3811.866584669523;3827.0241088522807;3827.2536855312946;7104.751333703295;7373.631318434057;7374.151972523121;7377.077865266841;7378.225286344857;7251.782446526613;7257;7283.7450689225625;7294.416446684252;7294.781156565312;7292.525985810906;7338.853222935511;7352.5956072415465;7356.337929586256;7377.668004939791;6981.197162326194;7112.715491380287;7127.429805615435;7130.643467826691;7131.8573628528175;6986.790396288119;6991.161060672752;6999.230084690578;7002.264762199896;7005.474589405713;7184.568925864465;7302.780916572511;7319.268073192638;7319.707211711472;7331.266873312626;4847.806087756591;4865.756712164307;4869.513048695102;4896.92654610174;4899;6848.828779280558;7054.682539285642;7103.680334385069;7109;7114.6442677866935;6842.178938527409;6848.9657551711925;6864.725410983505;6876.69054892521;6876.862462750817;6840.3501667341525;6856.485763567852;6876.759313424006;6884.862302754017;6891.37977582;6797.524173307821;6797.898031529432;6800.557963732539;6847.726090956506;6853.691583878638;6734.932650673627;6896;6902.516823822485;6923.515353925177;6932.549384290005;6732.3940845322195;6742.42689371409;6752.324767523209;6763.898541521783;6781.491388145811 12:34:45 INFO - PROCESS | 15571 | |5;yui.html;743.141671369568;745.1430854517301;775.6315750018741;803.2931020701783;853.5433543054467;14846.1834599097;15201.467948621786;16940.491785246446;17321.307147714077;17468.65062698745;15819.52541423759;15991.200439978013;16042.59893502663;16054.43809466669;16096.597585060379;847.4322204123222;856.3491746272815;858.3219256787131;871.2289623683055;877.2587163846539;842.2630198576246;848.3764433141636;855.3542075732844;863.8833757442759;865.7186414415308;882.5190271302156;892.281713220857;895.8297923394567;897.4794619120894;899.2491269789733;880.2869675562782;885.5306687455659;892.4823602310644;895.4224525181222;896.551724137931;652.282489261813;654.7970129259897;660.9504287178481;661.9073329733841;662.0499583098222;14550.27248637564;15012.699746005128;15061.096334219981;15215.087094774239;15304.540863774104;13380.531681391201;13549.796753048711;13697.178169309873;13807.792883106762;13817.585472435843;11258.887411125866;11354.659360219206;11457.197996140274;11496;11623.186376953616;3925.7644541327327;3930.3121953658283;3937.940930886039;3950.7036972227197;3960.3069462844173;54176.18735718967;54176.72911635456;54494.18258726162;54494.45505544973;55036;11153.498092585853;11208.66374008781;11248.550057997752;11497.54009839597;11569.595064172714;19028.238870445028;19221.13504892283;19239.80760192408;19240.4227873164;19261.711074333896;8022.719204827803;8236.917630823735;8287.12985136564;8325.084240733515;8347.29048030912;4463.196624607537;4481.574250446202;4520.674912048159;4553.362529245908;4588.49526552079;3403.5745531808525;3408.386490431746;3413.1296519387397;3440.2775417162175;3449.3273811606996;668.3717305732596;675.7262560074296;679.2969276798589;684.425082930331;690.3786592067079;676.0197713315712;705.3827900586987;755.2258934592087;777.4169372970272;797.1191833024541;9005.864912026325;9108.681196158102;9147.862782058275;9161.633534658673;9271.16559509634;751.0349201276333;751.1286907187746;752.7403045949138;754.8678981178272;757.6742000939649;4235.216484950294;4348.695591308578;4569.13186494565;4611.469680986663;4624.053232809044;61421;62955.68522157452;63308.683456582425;64419;64570.67714661397;51677;52245.47754522482;52668;53153.202701959504;53684.73157634187;49475.50524494781;52377;54521.72739136279;55321.44678553243;56156.71921640365;9091.772705682411;9314.068593140631;9401.153896149379;9416.435013899189;9457;37675;38396.6160338393;38691;39082.21835563216;39633.80183099066;47419.76290118528;48698.75650621866;48871.5112848867;49446.50553494419;49877.25184122168;12610;12818.87181128214;13018.544350947672;13061.804072938723;13107.279099649611;12655.746885062432;13436.395362208528;13841;13841.861581384057;13921.51274705421;12693.8095928563;12872.549460768829;13054.21674699483;13097;13214.27321497327;12354.814677779661;12558.434870431036;13008.154469959421;13169.473221071434;13330.400131993889;12040.21738586989;13082;13086.541971030969;13279;13895.235762033186;11162.832557511481;11340.319580825177;11385.886141138482;11590.36253006059;11673.299602023906;10472.790544189225;10591.576336946437;10705.250632455965;11070.612528561462;11208.607698730506 12:34:45 INFO - PROCESS | 15571 | __end_tp_report 12:34:45 INFO - PROCESS | 15571 | __start_cc_report 12:34:45 INFO - PROCESS | 15571 | _x_x_mozilla_cycle_collect,340 12:34:45 INFO - PROCESS | 15571 | __end_cc_report 12:34:45 INFO - PROCESS | 15571 | __startTimestamp1461008085462__endTimestamp 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | ------- Summary: start ------- 12:34:45 INFO - PROCESS | 15571 | Number of tests: 6 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | [#0] dojo.html Cycles:165 Average:5580.65 Median:5792.97 stddev:621.97 (10.7%) stddev-sans-first:598.50 12:34:45 INFO - PROCESS | 15571 | Values: 3338.9 3359.6 3399.8 3423.3 3430.6 5554.0 5574.2 5586.1 5588.5 5589.3 5526.8 5570.1 5594.4 5611.4 5621.1 5088.4 5141.1 5155.4 5188.2 5201.5 5009.0 5116.3 5194.8 5215.3 5240.7 5107.6 5152.6 5185.4 5199.1 5213.7 5128.1 5131.4 5135.3 5139.9 5153.8 4870.7 5021.0 5032.6 5088.0 5104.3 5272.8 5338.2 5349.3 5360.6 5361.8 5997.8 6018.5 6041.2 6046.9 6056.7 5892.6 5969.7 6056.6 6072.4 6078.1 5638.6 5656.9 5661.7 5678.9 5705.7 6150.1 6156.3 6172.6 6176.8 6189.5 5781.8 5872.7 5921.9 5956.7 5960.3 6025.3 6037.1 6041.6 6048.0 6062.0 5888.1 5890.1 5975.4 5982.6 5986.7 5828.7 5938.4 5965.9 5999.5 6029.9 4515.8 4561.3 4562.5 4568.6 4594.2 4074.7 4109.8 4128.9 4136.2 4142.8 5463.3 5651.5 5720.8 5745.5 5766.8 6028.6 6119.4 6122.9 6126.4 6126.6 5553.3 5700.5 5714.1 5714.5 5729.0 5073.7 5120.1 5130.9 5149.0 5165.4 6130.1 6167.9 6203.2 6223.0 6234.5 5867.3 5881.1 6056.9 6059.6 6062.7 6176.8 6240.3 6248.4 6265.2 6272.3 5983.0 5988.0 5992.9 5996.9 6035.9 5849.7 5993.3 6030.5 6039.4 6058.9 5888.3 5897.3 5897.7 5907.1 5908.2 5793.0 5854.7 5858.9 5894.2 5931.0 5555.5 5699.4 5749.7 5782.0 5829.0 5914.4 5923.7 5932.7 5956.9 5964.6 5780.5 5780.5 5795.9 5817.0 5844.5 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | [#1] ext.html Cycles:180 Average:51493.14 Median:20579.13 stddev:98700.54 (479.6%) stddev-sans-first:98903.21 12:34:45 INFO - PROCESS | 15571 | Values: 514.0 539.5 555.9 571.3 596.8 30817.8 38314.2 38992.6 39003.0 39292.8 41215.0 41866.4 41938.0 41973.6 42015.4 8883.5 9069.0 9080.9 9122.8 9138.0 8940.2 9027.4 9069.1 9074.5 9079.5 9024.5 9113.3 9123.8 9141.5 9153.8 8983.8 9031.5 9087.0 9150.4 9227.4 9050.2 9184.5 9214.7 9237.2 9263.7 40729.2 40790.2 41159.2 41175.6 41196.2 3652.6 3671.1 3712.3 3756.3 3929.2 30460.0 30735.8 30989.7 33135.0 33944.8 3932.1 3968.3 4003.5 4026.5 4056.9 279648.0 285181.0 285465.0 285675.0 285968.0 47135.3 47471.0 69888.0 70467.0 70716.3 48201.3 48385.8 48448.5 48465.3 48528.3 13511.9 13524.8 13571.0 13584.8 13628.7 10769.6 10788.2 10873.3 10934.2 10968.5 15769.8 15811.8 15834.2 15918.6 15931.7 6087.5 6107.3 6120.7 6212.5 6271.4 1062.4 1089.8 1092.6 1122.6 1127.8 29199.7 29340.9 30122.1 30131.2 30142.5 1064.8 1078.5 1081.9 1097.1 1097.6 15252.8 15504.5 15514.9 15708.0 15901.2 330549.0 554777.1 555902.0 557417.0 557571.0 58048.0 58647.4 58660.4 58669.4 59016.0 1444.8 1453.0 1482.2 1484.7 1498.9 29841.9 30117.7 30388.8 30668.8 30774.5 50771.0 51411.2 51546.7 51585.5 51686.0 248664.0 250840.0 250938.0 251786.0 251816.0 32207.8 32397.5 32719.2 35718.8 36205.0 46907.3 47498.0 51687.7 52065.7 52567.0 36754.6 37446.0 37546.0 37609.4 37702.0 36115.3 36548.6 36732.4 36792.6 36857.8 35851.5 36485.5 36629.6 36651.0 37032.3 32250.1 32614.7 33525.5 35370.3 35934.5 27211.3 27643.4 27777.3 27970.6 27980.9 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | [#2] jquery.html Cycles:180 Average:27366.90 Median:2457.13 stddev:80180.23 (3263.2%) stddev-sans-first:80379.54 12:34:45 INFO - PROCESS | 15571 | Values: 374.4 391.2 392.2 399.1 400.7 17210.6 18995.4 19485.8 19639.4 19719.9 16997.2 17284.8 17388.1 17390.3 17505.4 5066.9 5100.2 5254.9 5320.0 5371.8 5253.6 5292.1 5342.7 5367.3 5385.5 5237.1 5300.3 5321.0 5353.6 5361.2 5713.7 5792.2 5796.5 5853.3 5854.5 5219.1 5247.4 5264.7 5298.8 5311.4 13186.0 13807.2 13871.5 13944.9 13969.9 2413.0 2456.5 2457.7 2689.0 2820.3 11435.0 14076.2 14134.1 14309.0 14393.5 1950.4 1953.7 1958.3 1974.4 2055.8 63987.4 65865.3 66104.0 66144.3 68946.0 9591.3 10436.4 10909.4 10943.7 10947.1 14429.0 15023.6 15432.3 15444.2 15473.5 7187.2 7367.2 7389.0 7529.8 7705.9 7212.9 7239.4 7288.8 7347.9 7355.5 4618.1 4710.0 4748.7 4784.7 4811.1 1850.9 1890.4 1906.8 1976.0 1986.3 952.9 953.4 986.9 1080.1 1080.6 17815.4 17965.1 17975.6 17995.7 18662.0 958.3 991.9 1020.0 1022.3 1026.1 10079.5 10177.1 10454.1 10668.1 10749.5 479866.0 480368.0 489212.0 495754.0 501877.0 79537.2 80580.6 81138.6 81403.0 82546.0 1053.8 1060.8 1070.0 1077.5 1089.5 16391.1 16427.8 16546.3 16745.7 17005.2 27098.7 34941.5 35441.0 35796.0 36779.3 45167.3 45169.5 46222.3 46318.3 47349.5 8218.0 8425.9 8578.1 8590.8 8636.5 12545.4 12639.4 13352.3 13400.9 13506.1 6693.7 11539.2 11852.9 11945.3 12314.6 11600.1 11753.5 11960.9 12110.0 12150.4 11897.8 11982.2 12105.9 12331.4 12495.1 8358.3 11423.5 11683.5 12102.0 12124.5 8457.0 8516.5 8740.1 11504.7 12163.4 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | [#3] mootools.html Cycles:180 Average:5574.69 Median:6446.36 stddev:2907.69 (45.1%) stddev-sans-first:2899.67 12:34:45 INFO - PROCESS | 15571 | Values: 1494.7 1517.3 1703.8 1826.2 1867.4 7070.8 7652.7 7717.7 7894.2 7899.6 7827.5 7839.7 7889.8 7896.4 7897.6 2339.2 2348.3 2357.0 2361.4 2363.8 2337.1 2347.8 2379.8 2382.6 2385.9 2315.6 2319.4 2346.0 2382.0 2382.8 2340.2 2349.7 2357.7 2360.8 2361.6 2313.5 2325.9 2335.3 2342.4 2352.1 8036.5 8053.9 8069.1 8075.8 8090.6 4778.5 4840.2 4872.6 4875.8 4883.3 3112.3 3117.9 3126.9 3149.7 3163.4 1087.1 1109.7 1113.6 1130.2 1150.4 11149.6 11151.3 11158.4 11169.1 11206.0 4253.6 4255.1 4266.3 4284.9 4331.8 9589.8 9601.0 9610.1 9612.8 9632.5 4824.8 4882.9 4885.7 4893.4 4894.1 4011.3 4347.3 4434.9 4450.6 4463.3 3672.1 3761.6 3780.2 3798.9 3858.2 1193.7 1199.2 1209.6 1232.4 1232.7 1193.8 1203.8 1301.5 1466.1 1486.4 7477.6 7571.6 7803.6 7809.9 7811.8 512.7 520.4 520.7 526.0 529.8 5809.9 5841.8 5842.4 5881.5 5894.8 9127.6 9680.1 9688.8 9807.3 9840.2 9535.5 9543.5 9584.5 9649.0 9668.4 7514.4 7702.2 7708.7 7722.4 7780.6 7377.9 7398.9 7413.5 7428.4 7446.3 8175.3 8667.4 8679.9 8714.6 8756.9 8417.5 8487.2 8502.3 8528.1 8534.3 6370.1 6860.3 6983.2 7016.6 7046.4 7474.7 7509.8 7513.2 7521.1 7561.9 6741.5 6837.1 6864.6 6895.0 6954.7 6794.6 6859.2 6895.1 6934.2 6947.3 6915.3 6944.1 7054.3 7128.9 7166.7 6522.6 6530.4 6564.8 6568.4 6570.5 6618.6 6771.5 6825.7 6832.8 6840.8 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | [#4] prototype.html Cycles:180 Average:5710.79 Median:6383.43 stddev:1727.26 (27.1%) stddev-sans-first:1684.68 12:34:45 INFO - PROCESS | 15571 | Values: 355.3 360.3 360.7 369.5 370.1 6199.6 6226.4 6253.1 6295.6 6320.9 6363.9 6383.9 6395.0 6414.3 6421.3 4969.4 4981.1 4983.9 4984.2 4987.4 4944.2 4954.2 4969.0 4980.3 4988.9 4956.4 4960.0 4960.2 4961.4 4964.3 4844.1 4911.1 4935.1 4939.8 4949.5 4304.1 4322.5 4328.9 4329.9 4337.8 6053.7 6076.8 6082.6 6090.3 6112.0 5563.9 5698.7 5700.0 5708.9 5753.8 6742.3 6752.9 6753.5 6758.2 6767.1 4622.1 4634.3 4665.0 4673.0 4676.9 6969.1 7073.6 7080.6 7085.5 7092.6 4693.5 4776.9 4787.5 4796.9 4805.7 4783.2 4887.6 4894.3 4894.4 4900.3 5655.9 5663.8 5671.6 5675.3 5684.9 6844.3 6854.9 6862.6 6864.7 6890.4 1694.1 1714.9 1715.2 1715.5 1721.0 1095.2 1123.3 1131.6 1133.2 1133.5 6505.5 6509.9 6512.9 6520.7 6563.8 6991.7 7010.9 7051.9 7062.8 7072.8 6343.1 6354.9 6370.5 6373.7 6382.9 3791.0 3802.8 3811.9 3827.0 3827.3 7104.8 7373.6 7374.2 7377.1 7378.2 7251.8 7257.0 7283.7 7294.4 7294.8 7292.5 7338.9 7352.6 7356.3 7377.7 6981.2 7112.7 7127.4 7130.6 7131.9 6986.8 6991.2 6999.2 7002.3 7005.5 7184.6 7302.8 7319.3 7319.7 7331.3 4847.8 4865.8 4869.5 4896.9 4899.0 6848.8 7054.7 7103.7 7109.0 7114.6 6842.2 6849.0 6864.7 6876.7 6876.9 6840.4 6856.5 6876.8 6884.9 6891.4 6797.5 6797.9 6800.6 6847.7 6853.7 6734.9 6896.0 6902.5 6923.5 6932.5 6732.4 6742.4 6752.3 6763.9 6781.5 12:34:45 INFO - PROCESS | 15571 | 12:34:45 INFO - PROCESS | 15571 | [#5] yui.html Cycles:180 Average:15346.77 Median:4561.25 stddev:17545.55 (384.7%) stddev-sans-first:17560.49 12:34:45 INFO - PROCESS | 15571 | Values: 743.1 745.1 775.6 803.3 853.5 14846.2 15201.5 16940.5 17321.3 17468.7 15819.5 15991.2 16042.6 16054.4 16096.6 847.4 856.3 858.3 871.2 877.3 842.3 848.4 855.4 863.9 865.7 882.5 892.3 895.8 897.5 899.2 880.3 885.5 892.5 895.4 896.6 652.3 654.8 661.0 661.9 662.0 14550.3 15012.7 15061.1 15215.1 15304.5 13380.5 13549.8 13697.2 13807.8 13817.6 11258.9 11354.7 11457.2 11496.0 11623.2 3925.8 3930.3 3937.9 3950.7 3960.3 54176.2 54176.7 54494.2 54494.5 55036.0 11153.5 11208.7 11248.6 11497.5 11569.6 19028.2 19221.1 19239.8 19240.4 19261.7 8022.7 8236.9 8287.1 8325.1 8347.3 4463.2 4481.6 4520.7 4553.4 4588.5 3403.6 3408.4 3413.1 3440.3 3449.3 668.4 675.7 679.3 684.4 690.4 676.0 705.4 755.2 777.4 797.1 9005.9 9108.7 9147.9 9161.6 9271.2 751.0 751.1 752.7 754.9 757.7 4235.2 4348.7 4569.1 4611.5 4624.1 61421.0 62955.7 63308.7 64419.0 64570.7 51677.0 52245.5 52668.0 53153.2 53684.7 49475.5 52377.0 54521.7 55321.4 56156.7 9091.8 9314.1 9401.2 9416.4 9457.0 37675.0 38396.6 38691.0 39082.2 39633.8 47419.8 48698.8 48871.5 49446.5 49877.3 12610.0 12818.9 13018.5 13061.8 13107.3 12655.7 13436.4 13841.0 13841.9 13921.5 12693.8 12872.5 13054.2 13097.0 13214.3 12354.8 12558.4 13008.2 13169.5 13330.4 12040.2 13082.0 13086.5 13279.0 13895.2 11162.8 11340.3 11385.9 11590.4 11673.3 10472.8 10591.6 10705.3 11070.6 11208.6 12:34:45 INFO - PROCESS | 15571 | -------- Summary: end -------- 12:34:45 INFO - PROCESS | 15571 | 12:34:46 INFO - TEST-INFO | 15571: exit 0 12:34:46 INFO - TEST-OK | dromaeo_css | took 1109888ms 12:34:46 INFO - TEST-START | kraken 12:34:46 INFO - operating with platform_type : linux_ 12:34:46 INFO - Initialising browser for kraken test... 12:34:46 INFO - TEST-INFO | started process 15815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTphJal/profile http://localhost:54068/getInfo.html) 12:34:49 INFO - PROCESS | 15815 | 12:34:49 INFO - PROCESS | 15815 | (process:15897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:34:50 INFO - PROCESS | 15815 | __metrics Screen width/height:1600/1200 12:34:50 INFO - PROCESS | 15815 | colorDepth:24 12:34:50 INFO - PROCESS | 15815 | Browser inner width/height: 1024/697 12:34:50 INFO - PROCESS | 15815 | __metrics 12:34:51 ERROR - PROCESS | 15815 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:34:52 INFO - TEST-INFO | 15815: exit 0 12:34:52 INFO - Browser initialized. 12:34:52 INFO - Running cycle 1/1 for kraken test... 12:34:52 INFO - TEST-INFO | started process 15948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTphJal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:53 INFO - PROCESS | 15948 | 12:34:53 INFO - PROCESS | 15948 | (process:16018): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:35:03 INFO - PROCESS | 15948 | RSS: Main: 151453696 12:35:03 INFO - PROCESS | 15948 | 12:35:06 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:06 INFO - PROCESS | 15948 | RSS: Main: 155967488 12:35:06 INFO - PROCESS | 15948 | 12:35:09 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-dft) 12:35:10 INFO - PROCESS | 15948 | RSS: Main: 156061696 12:35:10 INFO - PROCESS | 15948 | 12:35:13 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-fft) 12:35:13 INFO - PROCESS | 15948 | RSS: Main: 156434432 12:35:13 INFO - PROCESS | 15948 | 12:35:15 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-oscillator) 12:35:16 INFO - PROCESS | 15948 | RSS: Main: 156381184 12:35:16 INFO - PROCESS | 15948 | 12:35:18 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:19 INFO - PROCESS | 15948 | RSS: Main: 156495872 12:35:19 INFO - PROCESS | 15948 | 12:35:22 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54068/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:22 INFO - PROCESS | 15948 | RSS: Main: 156815360 12:35:22 INFO - PROCESS | 15948 | 12:35:26 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54068/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:26 INFO - PROCESS | 15948 | RSS: Main: 156962816 12:35:26 INFO - PROCESS | 15948 | 12:35:29 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54068/tests/kraken/driver.html?testName=json-parse-financial) 12:35:30 INFO - PROCESS | 15948 | RSS: Main: 156819456 12:35:30 INFO - PROCESS | 15948 | 12:35:31 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:32 INFO - PROCESS | 15948 | RSS: Main: 156405760 12:35:32 INFO - PROCESS | 15948 | 12:35:34 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:34 INFO - PROCESS | 15948 | RSS: Main: 156688384 12:35:34 INFO - PROCESS | 15948 | 12:35:36 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:37 INFO - PROCESS | 15948 | RSS: Main: 157167616 12:35:37 INFO - PROCESS | 15948 | 12:35:39 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:40 INFO - PROCESS | 15948 | RSS: Main: 157872128 12:35:40 INFO - PROCESS | 15948 | 12:35:43 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:43 INFO - PROCESS | 15948 | RSS: Main: 157102080 12:35:43 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54068/tests/kraken/driver.html?testName=ai-astar) 12:35:45 INFO - PROCESS | 15948 | RSS: Main: 158773248 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | __start_tp_report 12:35:45 INFO - PROCESS | 15948 | _x_x_mozilla_page_load 12:35:45 INFO - PROCESS | 15948 | _x_x_mozilla_page_load_details 12:35:45 INFO - PROCESS | 15948 | |i|pagename|runs| 12:35:45 INFO - PROCESS | 15948 | |0;ai-astar;111;105;110;109;111;121;111;110;111;111 12:35:45 INFO - PROCESS | 15948 | |1;audio-beat-detection;156;135;162;170;132;155;164;136;177;129 12:35:45 INFO - PROCESS | 15948 | |2;audio-dft;161;162;165;161;163;161;164;161;165;163 12:35:45 INFO - PROCESS | 15948 | |3;audio-fft;94;73;77;169;77;73;72;75;160;74 12:35:45 INFO - PROCESS | 15948 | |4;audio-oscillator;93;92;148;93;93;93;148;94;94;143 12:35:45 INFO - PROCESS | 15948 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 12:35:45 INFO - PROCESS | 15948 | |6;imaging-darkroom;146;151;146;147;147;148;148;147;147;149 12:35:45 INFO - PROCESS | 15948 | |7;imaging-desaturate;96;96;95;98;96;96;96;97;96;96 12:35:45 INFO - PROCESS | 15948 | |8;json-parse-financial;56;55;55;55;54;58;54;69;55;53 12:35:45 INFO - PROCESS | 15948 | |9;json-stringify-tinderbox;65;63;65;63;66;64;63;64;64;67 12:35:45 INFO - PROCESS | 15948 | |10;stanford-crypto-aes;79;77;77;79;78;78;81;80;78;78 12:35:45 INFO - PROCESS | 15948 | |11;stanford-crypto-ccm;114;115;128;115;121;117;112;112;116;113 12:35:45 INFO - PROCESS | 15948 | |12;stanford-crypto-pbkdf2;137;152;145;145;142;143;140;147;147;136 12:35:45 INFO - PROCESS | 15948 | |13;stanford-crypto-sha256-iterative;69;67;70;66;69;65;68;71;69;66 12:35:45 INFO - PROCESS | 15948 | __end_tp_report 12:35:45 INFO - PROCESS | 15948 | __start_cc_report 12:35:45 INFO - PROCESS | 15948 | _x_x_mozilla_cycle_collect,844 12:35:45 INFO - PROCESS | 15948 | __end_cc_report 12:35:45 INFO - PROCESS | 15948 | __startTimestamp1461008145632__endTimestamp 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | ------- Summary: start ------- 12:35:45 INFO - PROCESS | 15948 | Number of tests: 14 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:3.97 (3.6%) stddev-sans-first:4.21 12:35:45 INFO - PROCESS | 15948 | Values: 111.0 105.0 110.0 109.0 111.0 121.0 111.0 110.0 111.0 111.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:159.00 stddev:17.29 (10.9%) stddev-sans-first:18.27 12:35:45 INFO - PROCESS | 15948 | Values: 156.0 135.0 162.0 170.0 132.0 155.0 164.0 136.0 177.0 129.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.64 12:35:45 INFO - PROCESS | 15948 | Values: 161.0 162.0 165.0 161.0 163.0 161.0 164.0 161.0 165.0 163.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#3] audio-fft Cycles:10 Average:94.40 Median:74.50 stddev:37.54 (50.4%) stddev-sans-first:39.82 12:35:45 INFO - PROCESS | 15948 | Values: 94.0 73.0 77.0 169.0 77.0 73.0 72.0 75.0 160.0 74.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:93.00 stddev:25.74 (27.7%) stddev-sans-first:26.63 12:35:45 INFO - PROCESS | 15948 | Values: 93.0 92.0 148.0 93.0 93.0 93.0 148.0 94.0 94.0 143.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:35:45 INFO - PROCESS | 15948 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.51 (1.0%) stddev-sans-first:1.48 12:35:45 INFO - PROCESS | 15948 | Values: 146.0 151.0 146.0 147.0 147.0 148.0 148.0 147.0 147.0 149.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 12:35:45 INFO - PROCESS | 15948 | Values: 96.0 96.0 95.0 98.0 96.0 96.0 96.0 97.0 96.0 96.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.00 stddev:4.62 (8.4%) stddev-sans-first:4.90 12:35:45 INFO - PROCESS | 15948 | Values: 56.0 55.0 55.0 55.0 54.0 58.0 54.0 69.0 55.0 53.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:1.35 (2.1%) stddev-sans-first:1.41 12:35:45 INFO - PROCESS | 15948 | Values: 65.0 63.0 65.0 63.0 66.0 64.0 63.0 64.0 64.0 67.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:1.27 (1.6%) stddev-sans-first:1.33 12:35:45 INFO - PROCESS | 15948 | Values: 79.0 77.0 77.0 79.0 78.0 78.0 81.0 80.0 78.0 78.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.50 stddev:4.90 (4.2%) stddev-sans-first:5.13 12:35:45 INFO - PROCESS | 15948 | Values: 114.0 115.0 128.0 115.0 121.0 117.0 112.0 112.0 116.0 113.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.00 stddev:4.88 (3.4%) stddev-sans-first:4.59 12:35:45 INFO - PROCESS | 15948 | Values: 137.0 152.0 145.0 145.0 142.0 143.0 140.0 147.0 147.0 136.0 12:35:45 INFO - PROCESS | 15948 | 12:35:45 INFO - PROCESS | 15948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.94 (2.8%) stddev-sans-first:2.03 12:35:45 INFO - PROCESS | 15948 | Values: 69.0 67.0 70.0 66.0 69.0 65.0 68.0 71.0 69.0 66.0 12:35:45 INFO - PROCESS | 15948 | -------- Summary: end -------- 12:35:45 INFO - PROCESS | 15948 | 12:35:46 INFO - TEST-INFO | 15948: exit 0 12:35:46 INFO - TEST-OK | kraken | took 60357ms 12:35:46 INFO - SUITE-END | took 1170s 12:35:46 INFO - Completed test suite (00:19:30) 12:35:46 INFO - javascript benchmark 12:35:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3338.9165270868225, 3359.5968483781944, 3399.7790143640646, 3423.281110966697, 3430.554027976364, 5554.0, 5574.1917421973785, 5586.106223004315, 5588.524975377093, 5589.301337332833, 5526.834194974157, 5570.136628822529, 5594.412586678391, 5611.382747897728, 5621.072523033705, 5088.414832294287, 5141.074606570815, 5155.381354237496, 5188.221766735001, 5201.505856943584, 5009.0482808266315, 5116.309298244727, 5194.792208311663, 5215.322008138936, 5240.711760853152, 5107.591392688576, 5152.613553983448, 5185.429602743695, 5199.09015922214, 5213.661112027725, 5128.051310507568, 5131.409887862887, 5135.306733590992, 5139.922901156504, 5153.819616313449, 4870.732109733964, 5021.046001259749, 5032.597392208651, 5087.974560127176, 5104.259882317043, 5272.841814745564, 5338.225957236179, 5349.3045904032615, 5360.59795515334, 5361.758720857571, 5997.760089596411, 6018.518518518508, 6041.214642096544, 6046.909296360514, 6056.666883321415, 5892.616979896293, 5969.701514924236, 6056.606320589148, 6072.423119803611, 6078.057901025348, 5638.577106717013, 5656.91514627281, 5661.745221464962, 5678.943210567924, 5705.65766054034, 6150.077488376779, 6156.26124865019, 6172.567920245539, 6176.752929882844, 6189.535784816067, 5781.797637082682, 5872.7357268923, 5921.851953701106, 5956.7319470623925, 5960.254968128984, 6025.3372129065765, 6037.0642550404755, 6041.577089603774, 6048.0, 6062.0, 5888.146218798251, 5890.1164825276555, 5975.43233392827, 5982.551308651869, 5986.670733109634, 5828.6794226317115, 5938.406159384027, 5965.9105113422465, 5999.460048595647, 6029.909551356734, 4515.848458643025, 4561.315802629632, 4562.498125206224, 4568.56598623137, 4594.2419500782, 4074.694397920168, 4109.753414795122, 4128.896777580524, 4136.21411931732, 4142.813573389144, 5463.262459567987, 5651.463111004448, 5720.8283751487525, 5745.511631511368, 5766.798162064308, 6028.638281703112, 6119.380693981235, 6122.947104152868, 6126.408290899671, 6126.622178332329, 5553.333599968029, 5700.515456186187, 5714.085746280575, 5714.542836573064, 5728.971355143281, 5073.746312684351, 5120.129577971754, 5130.897382052338, 5149.0474262261605, 5165.431802501722, 6130.080487926846, 6167.876642467215, 6203.193584833943, 6223.0, 6234.501239900887, 5867.295924489089, 5881.147233651182, 6056.9091463628965, 6059.606125601822, 6062.696865156813, 6176.752929882754, 6240.251169859464, 6248.375162483715, 6265.185525881606, 6272.310045895039, 5983.0, 5988.041913294026, 5992.860419201168, 5996.850078748066, 6035.9094613579955, 5849.707514624337, 5993.340732519507, 6030.547708921936, 6039.396060393926, 6058.939410605837, 5888.263967004124, 5897.321807992136, 5897.734601943009, 5907.113932910098, 5908.231929849264, 5792.971035144966, 5854.677992710442, 5858.853528661817, 5894.174815525744, 5930.970345148246, 5555.472230138131, 5699.430056994267, 5749.655020698771, 5782.017057100219, 5828.970855145697, 5914.4381283777975, 5923.703814809329, 5932.733027013881, 5956.910646340221, 5964.642121472725, 5780.45085716873, 5780.479756821906, 5795.884082318415, 5817.040188368872, 5844.47399734026], "unit": "score", "name": "dojo.html", "value": 5540.3233210108065}, {"lowerIsBetter": false, "replicates": [513.9665921715091, 539.5063516882053, 555.9249501317323, 571.2687759667625, 596.8030549918527, 30817.845910770444, 38314.233715325674, 38992.61007389925, 39003.0, 39292.80353598228, 41215.0, 41866.372004419885, 41938.0, 41973.58026419735, 42015.369769453486, 8883.51140687262, 9069.0, 9080.909190908105, 9122.771930701752, 9137.954310228439, 8940.19538241558, 9027.413218140833, 9069.093090690943, 9074.455532668027, 9079.546022698873, 9024.458532488072, 9113.3165012624, 9123.771905702344, 9141.497217653026, 9153.816923661523, 8983.820323593523, 9031.548422578877, 9086.999999999967, 9150.40522366044, 9227.44635321883, 9050.230730387924, 9184.494852783095, 9214.677486287948, 9237.214836738885, 9263.722088337361, 40729.1854162918, 40790.18419631621, 41159.176816463805, 41175.588244117476, 41196.1760764783, 3652.6347365263528, 3671.0822294426393, 3712.257548490286, 3756.34264003801, 3929.2337994091163, 30460.0, 30735.846320768476, 30989.690103098907, 33135.0, 33944.83027584871, 3932.075962148893, 3968.3452230381954, 4003.499562554681, 4026.5369482509595, 4056.8782936511952, 279648.0, 285181.0, 285465.0, 285675.0, 285968.0, 47135.29297060547, 47471.0, 69888.0, 70467.0, 70716.292837072, 48201.348925808714, 48385.758071210126, 48448.5155148444, 48465.273020904715, 48528.27207591889, 13511.932440337736, 13524.797128043087, 13571.0, 13584.796228056586, 13628.65928351799, 10769.62306319275, 10788.244822862482, 10873.347599144077, 10934.234603577674, 10968.451577421256, 15769.763453548207, 15811.762823557656, 15834.208289585475, 15918.60203494922, 15931.681366372608, 6087.4521293083835, 6107.267127944675, 6120.724567394478, 6212.534059945522, 6271.435570798559, 1062.3891262523925, 1089.7548051688466, 1092.5902786455079, 1122.5790328626765, 1127.7913585986619, 29199.708002920124, 29340.853295733385, 30122.09633710992, 30131.246718831768, 30142.54786178209, 1064.7870425914693, 1078.5254488025244, 1081.9459027048615, 1097.0839349143396, 1097.550004498152, 15252.763631846976, 15504.457343992906, 15514.9224253878, 15708.0, 15901.204939752966, 330549.0, 554777.1305717309, 555902.0, 557417.0, 557571.0, 58048.0, 58647.4135258642, 58660.41339586635, 58669.413305867245, 59016.0, 1444.833844107941, 1452.992735036318, 1482.2440555316866, 1484.747592909208, 1498.8576085271882, 29841.850790745906, 30117.69882301149, 30388.84805575958, 30668.846655766578, 30774.538381924736, 50771.0, 51411.2288315683, 51546.711332217, 51585.484145158065, 51686.0, 248664.0, 250840.0, 250938.0, 251786.0, 251816.0, 32207.838960805046, 32397.514037288987, 32719.18202044968, 35718.821405892806, 36205.0, 46907.29639055485, 47498.0, 51687.74156129195, 52065.7396713014, 52567.0, 36754.63245367619, 37446.0, 37546.0, 37609.4358584616, 37702.0, 36115.27769444544, 36548.63451365559, 36732.44901326536, 36792.63207367892, 36857.81571092128, 35851.46222806608, 36485.45271820872, 36629.63370366369, 36651.0, 37032.25935481222, 32250.06871392538, 32614.673853261163, 33525.49711754277, 35370.29259414849, 35934.460983085795, 27211.319717007234, 27643.44713105767, 27777.305567360978, 27970.58044129299, 27980.860095700205], "unit": "score", "name": "ext.html", "value": 18946.424019136837}, {"lowerIsBetter": false, "replicates": [374.39348255825564, 391.1980440097799, 392.174472734893, 399.08410198594225, 400.7054814711187, 17210.569735756613, 18995.43013709591, 19485.805141948575, 19639.410817675474, 19719.901400493014, 16997.2351244194, 17284.827151728477, 17388.130593470338, 17390.304387824504, 17505.3873114441, 5066.898662026757, 5100.183970564711, 5254.924304899562, 5319.973400132994, 5371.838844834661, 5253.57971362292, 5292.10034294169, 5342.732863356817, 5367.329083864517, 5385.488378604026, 5237.13587258102, 5300.310959575269, 5320.962412329597, 5353.625246232766, 5361.195820626898, 5713.685747283897, 5792.189093526909, 5796.478316951452, 5853.2976042875125, 5854.531637469014, 5219.060569097561, 5247.39654939683, 5264.710440925747, 5298.761555730001, 5311.362636483608, 13186.0, 13807.240601766898, 13871.514496992657, 13944.860551394459, 13969.945177685204, 2413.0, 2456.545539075277, 2457.7050753909643, 2689.0050681248063, 2820.3372207531215, 11435.0, 14076.155430674193, 14134.081284716563, 14309.0, 14393.496227631982, 1950.4246247357064, 1953.7264782930401, 1958.2754380879023, 1974.41241287157, 2055.835533157359, 63987.360126398606, 65865.3413465864, 66104.0, 66144.33855661478, 68945.96581051339, 9591.328606997582, 10436.37381757097, 10909.418134370471, 10943.671689849318, 10947.124230061576, 14429.0, 15023.624409389853, 15432.305546250445, 15444.227788610524, 15473.5357939262, 7187.209406965229, 7367.226441223702, 7388.963055184689, 7529.849403012018, 7705.9229407706325, 7212.891806622905, 7239.384652304613, 7288.817779555554, 7347.926520734831, 7355.535840668251, 4618.076384723069, 4710.0, 4748.667593268438, 4784.665073444826, 4811.061842940663, 1850.9259629614664, 1890.3667271464215, 1906.761654793151, 1975.9703604445945, 1986.3047933223256, 952.8856537215579, 953.3660116022767, 986.8815742110993, 1080.0819303591884, 1080.5947769586405, 17815.376461823773, 17965.101744912703, 17975.640487190445, 17995.73006404879, 18662.0, 958.3339578992673, 991.8809742830906, 1020.0258752890971, 1022.2639699416409, 1026.071405378134, 10079.49602519871, 10177.084062434416, 10454.059134677915, 10668.093212077061, 10749.462526873782, 479866.0, 480368.0, 489212.0, 495754.0, 501877.0, 79537.20462795414, 80580.59709701414, 81138.59430702927, 81403.0, 82546.0, 1053.7681710023783, 1060.7825395793843, 1069.9786004280027, 1077.504347999913, 1089.4716062709422, 16391.098489583186, 16427.753583696493, 16546.255418506436, 16745.665086697954, 17005.234764435878, 27098.72901270962, 34941.47587786135, 35441.0, 35796.0, 36779.26441471102, 45167.32249016202, 45169.54830451653, 46222.306665399374, 46318.30522542097, 47349.52650473451, 8218.0, 8425.915740842758, 8578.099299573705, 8590.78523036929, 8636.481811091355, 12545.435455404711, 12639.431225594686, 13352.265625390697, 13400.865991339962, 13506.122102063335, 6693.665316734046, 11539.249948753304, 11852.881471185177, 11945.283283003047, 12314.568990085305, 11600.129990250596, 11753.471093800628, 11960.880391196324, 12110.0, 12150.392480376122, 11897.821532676844, 11982.221155624857, 12105.939470302592, 12331.383430828602, 12495.062870284582, 8358.331333493428, 11423.46230307379, 11683.474243659226, 12102.031837453158, 12124.515019399125, 8457.027441844266, 8516.531590762568, 8740.125987401208, 11504.654860354203, 12163.391830408622], "unit": "score", "name": "jquery.html", "value": 8842.065795704619}, {"lowerIsBetter": false, "replicates": [1494.6935878144977, 1517.3323737555477, 1703.8381353771395, 1826.1873466307497, 1867.3744295660954, 7070.787876363717, 7652.6938922443105, 7717.729879454207, 7894.17111203324, 7899.6050197490185, 7827.452078354503, 7839.725609603665, 7889.763307100796, 7896.368290536758, 7897.644605992729, 2339.169594793845, 2348.3189874936247, 2357.010055776578, 2361.3860396296914, 2363.8108951283943, 2337.076854642415, 2347.765223477647, 2379.8096152307776, 2382.5592265430864, 2385.8568485890814, 2315.641075633271, 2319.420144963759, 2346.002948746784, 2382.0471811275456, 2382.845115067515, 2340.169239919821, 2349.682792822964, 2357.728861180969, 2360.8111351091957, 2361.645753137026, 2313.5257272259146, 2325.894526866974, 2335.322756400642, 2342.426105604121, 2352.1297120065683, 8036.4776289541, 8053.919460805376, 8069.112397636314, 8075.838483230361, 8090.635921383552, 4778.4982576829625, 4840.201366774513, 4872.56146946773, 4875.780589873464, 4883.34074899891, 3112.2997325601787, 3117.890873819428, 3126.8592913318957, 3149.653538110806, 3163.4147682678777, 1087.1357270969597, 1109.6615532262738, 1113.560143743225, 1130.2427373659668, 1150.447785063166, 11149.609763658233, 11151.330920144736, 11158.386288754115, 11169.106471482262, 11206.047485963703, 4253.617174454314, 4255.106427650228, 4266.31738921771, 4284.871453856389, 4331.761753103609, 9589.760255993657, 9600.951995239979, 9610.087041731025, 9612.75968100803, 9632.47021413829, 4824.758762061953, 4882.902341953141, 4885.706857588556, 4893.363862697826, 4894.094592500399, 4011.2980228460488, 4347.3261644445165, 4434.911301773946, 4450.621697155713, 4463.285874260103, 3672.1003354177865, 3761.586225515191, 3780.2250538639514, 3798.867039653654, 3858.2090671412293, 1193.7015746063485, 1199.1905463811893, 1209.6189700244395, 1232.445399570179, 1232.7287996640725, 1193.8268951002055, 1203.759248150356, 1301.4859130643342, 1466.1349803615706, 1486.4425840309884, 7477.551346919202, 7571.583562904093, 7803.570803605742, 7809.921900781033, 7811.804704882424, 512.6565201315128, 520.4015382310373, 520.7422325948604, 526.0426024635127, 529.7616072767194, 5809.883802324014, 5841.795537156179, 5842.444967728059, 5881.500072493886, 5894.823155305262, 9127.634894604142, 9680.080392362714, 9688.806223875625, 9807.313488055768, 9840.212782977345, 9535.52322383878, 9543.522823858779, 9584.472853992958, 9649.0, 9668.371555848847, 7514.39884809214, 7702.191269916578, 7708.691652333844, 7722.382209423233, 7780.610969451504, 7377.852442951218, 7398.889016664647, 7413.481056326221, 7428.442866785121, 7446.292602202782, 8175.305099066646, 8667.393282470166, 8679.91320086791, 8714.607842647223, 8756.868646970173, 8417.494950303002, 8487.236148746642, 8502.277306429023, 8528.104549022264, 8534.31725461974, 6370.140031095742, 6860.348266914635, 6983.1620205575655, 7016.5790052597, 7046.436285097282, 7474.738384156529, 7509.812254693457, 7513.2111128330735, 7521.0974683038385, 7561.886571701539, 6741.528093033637, 6837.1111755471475, 6864.5881247125335, 6894.965525172342, 6954.687039083152, 6794.558353706993, 6859.211190712932, 6895.138107736533, 6934.237233904166, 6947.305269473214, 6915.273896241023, 6944.062551555678, 7054.294570542905, 7128.928710712827, 7166.713331466683, 6522.5760325578685, 6530.412262896362, 6564.80305590833, 6568.408843204134, 6570.507211959218, 6618.569792963442, 6771.52599318043, 6825.658717064226, 6832.795016149524, 6840.794776156723], "unit": "score", "name": "mootools.html", "value": 4527.332069028471}, {"lowerIsBetter": false, "replicates": [355.3337492202121, 360.320795300858, 360.70242050308497, 369.4882587616151, 370.10250143402243, 6199.597026193294, 6226.377362263777, 6253.124562561239, 6295.559310848237, 6320.873582528347, 6363.872722545546, 6383.946648802942, 6395.0407438884195, 6414.326495717953, 6421.261554921185, 4969.4036715594175, 4981.1283025470575, 4983.900321993558, 4984.152694042022, 4987.376577927759, 4944.1594928862, 4954.232094025432, 4969.0, 4980.27785971034, 4988.927380613168, 4956.430010548779, 4960.032793605248, 4960.206366981283, 4961.429435614897, 4964.329815474919, 4844.055409195208, 4911.115999120157, 4935.099986505185, 4939.777710003041, 4949.50504949504, 4304.139172165579, 4322.459692538433, 4328.870133895988, 4329.913401731979, 4337.804798784062, 6053.697315134225, 6076.756929722806, 6082.635041897501, 6090.330063693034, 6111.991521398963, 5563.916541251884, 5698.6580805151825, 5700.0, 5708.942910570882, 5753.769849206027, 6742.292059333798, 6752.932470675329, 6753.49348798842, 6758.1890173179045, 6767.086443330137, 4622.052479241747, 4634.2585186370015, 4665.043666048452, 4673.042026384583, 4676.929846052312, 6969.05917701109, 7073.575585464889, 7080.575165490087, 7085.539439936388, 7092.645367731644, 4693.530646935279, 4776.8566942991765, 4787.473377928425, 4796.856094317176, 4805.687630304019, 4783.234682450791, 4887.560119589254, 4894.3147959285725, 4894.363732714724, 4900.26496025599, 5655.943440565542, 5663.801766938137, 5671.574631902541, 5675.347335056521, 5684.8863022739315, 6844.315568443216, 6854.931450685429, 6862.588244705334, 6864.656767161622, 6890.44876409896, 1694.1190580897864, 1714.9142542872808, 1715.2110029386622, 1715.485354393677, 1721.0362197169625, 1095.200503632337, 1123.3428444359977, 1131.575659127827, 1133.2010932292715, 1133.4672703829187, 6505.512086593524, 6509.934900650933, 6512.902306465407, 6520.739170433224, 6563.835904102436, 6991.720331186797, 7010.92989070113, 7051.89422158668, 7062.788116356517, 7072.7524536642, 6343.111964324999, 6354.904676429857, 6370.458511026614, 6373.745050198033, 6382.904256436157, 3791.033286511977, 3802.8288727007352, 3811.866584669523, 3827.0241088522807, 3827.2536855312946, 7104.751333703295, 7373.631318434057, 7374.151972523121, 7377.077865266841, 7378.225286344857, 7251.782446526613, 7257.0, 7283.7450689225625, 7294.416446684252, 7294.781156565312, 7292.525985810906, 7338.853222935511, 7352.5956072415465, 7356.337929586256, 7377.668004939791, 6981.197162326194, 7112.715491380287, 7127.429805615435, 7130.643467826691, 7131.8573628528175, 6986.790396288119, 6991.161060672752, 6999.230084690578, 7002.264762199896, 7005.474589405713, 7184.568925864465, 7302.780916572511, 7319.268073192638, 7319.707211711472, 7331.266873312626, 4847.806087756591, 4865.756712164307, 4869.513048695102, 4896.92654610174, 4899.0, 6848.828779280558, 7054.682539285642, 7103.680334385069, 7109.0, 7114.6442677866935, 6842.178938527409, 6848.9657551711925, 6864.725410983505, 6876.69054892521, 6876.862462750817, 6840.3501667341525, 6856.485763567852, 6876.759313424006, 6884.862302754017, 6891.37977582, 6797.524173307821, 6797.898031529432, 6800.557963732539, 6847.726090956506, 6853.691583878638, 6734.932650673627, 6896.0, 6902.516823822485, 6923.515353925177, 6932.549384290005, 6732.3940845322195, 6742.42689371409, 6752.324767523209, 6763.898541521783, 6781.491388145811], "unit": "score", "name": "prototype.html", "value": 5146.44848121995}, {"lowerIsBetter": false, "replicates": [743.141671369568, 745.1430854517301, 775.6315750018741, 803.2931020701783, 853.5433543054467, 14846.1834599097, 15201.467948621786, 16940.491785246446, 17321.307147714077, 17468.65062698745, 15819.52541423759, 15991.200439978013, 16042.59893502663, 16054.43809466669, 16096.597585060379, 847.4322204123222, 856.3491746272815, 858.3219256787131, 871.2289623683055, 877.2587163846539, 842.2630198576246, 848.3764433141636, 855.3542075732844, 863.8833757442759, 865.7186414415308, 882.5190271302156, 892.281713220857, 895.8297923394567, 897.4794619120894, 899.2491269789733, 880.2869675562782, 885.5306687455659, 892.4823602310644, 895.4224525181222, 896.551724137931, 652.282489261813, 654.7970129259897, 660.9504287178481, 661.9073329733841, 662.0499583098222, 14550.27248637564, 15012.699746005128, 15061.096334219981, 15215.087094774239, 15304.540863774104, 13380.531681391201, 13549.796753048711, 13697.178169309873, 13807.792883106762, 13817.585472435843, 11258.887411125866, 11354.659360219206, 11457.197996140274, 11496.0, 11623.186376953616, 3925.7644541327327, 3930.3121953658283, 3937.940930886039, 3950.7036972227197, 3960.3069462844173, 54176.18735718967, 54176.72911635456, 54494.18258726162, 54494.45505544973, 55036.0, 11153.498092585853, 11208.66374008781, 11248.550057997752, 11497.54009839597, 11569.595064172714, 19028.238870445028, 19221.13504892283, 19239.80760192408, 19240.4227873164, 19261.711074333896, 8022.719204827803, 8236.917630823735, 8287.12985136564, 8325.084240733515, 8347.29048030912, 4463.196624607537, 4481.574250446202, 4520.674912048159, 4553.362529245908, 4588.49526552079, 3403.5745531808525, 3408.386490431746, 3413.1296519387397, 3440.2775417162175, 3449.3273811606996, 668.3717305732596, 675.7262560074296, 679.2969276798589, 684.425082930331, 690.3786592067079, 676.0197713315712, 705.3827900586987, 755.2258934592087, 777.4169372970272, 797.1191833024541, 9005.864912026325, 9108.681196158102, 9147.862782058275, 9161.633534658673, 9271.16559509634, 751.0349201276333, 751.1286907187746, 752.7403045949138, 754.8678981178272, 757.6742000939649, 4235.216484950294, 4348.695591308578, 4569.13186494565, 4611.469680986663, 4624.053232809044, 61421.0, 62955.68522157452, 63308.683456582425, 64419.0, 64570.67714661397, 51677.0, 52245.47754522482, 52668.0, 53153.202701959504, 53684.73157634187, 49475.50524494781, 52377.0, 54521.72739136279, 55321.44678553243, 56156.71921640365, 9091.772705682411, 9314.068593140631, 9401.153896149379, 9416.435013899189, 9457.0, 37675.0, 38396.6160338393, 38691.0, 39082.21835563216, 39633.80183099066, 47419.76290118528, 48698.75650621866, 48871.5112848867, 49446.50553494419, 49877.25184122168, 12610.0, 12818.87181128214, 13018.544350947672, 13061.804072938723, 13107.279099649611, 12655.746885062432, 13436.395362208528, 13841.0, 13841.861581384057, 13921.51274705421, 12693.8095928563, 12872.549460768829, 13054.21674699483, 13097.0, 13214.27321497327, 12354.814677779661, 12558.434870431036, 13008.154469959421, 13169.473221071434, 13330.400131993889, 12040.21738586989, 13082.0, 13086.541971030969, 13279.0, 13895.235762033186, 11162.832557511481, 11340.319580825177, 11385.886141138482, 11590.36253006059, 11673.299602023906, 10472.790544189225, 10591.576336946437, 10705.250632455965, 11070.612528561462, 11208.607698730506], "unit": "score", "name": "yui.html", "value": 6995.822321775472}], "name": "dromaeo_css", "value": 7299.729769860422}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 109.0, 111.0, 121.0, 111.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [156.0, 135.0, 162.0, 170.0, 132.0, 155.0, 164.0, 136.0, 177.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 165.0, 161.0, 163.0, 161.0, 164.0, 161.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [94.0, 73.0, 77.0, 169.0, 77.0, 73.0, 72.0, 75.0, 160.0, 74.0], "unit": "score", "name": "audio-fft", "value": 94.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 148.0, 93.0, 93.0, 93.0, 148.0, 94.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 54.0, 58.0, 54.0, 69.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 65.0, 63.0, 66.0, 64.0, 63.0, 64.0, 64.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 77.0, 79.0, 78.0, 78.0, 81.0, 80.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 128.0, 115.0, 121.0, 117.0, 112.0, 112.0, 116.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [137.0, 152.0, 145.0, 145.0, 142.0, 143.0, 140.0, 147.0, 147.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 66.0, 69.0, 65.0, 68.0, 71.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1516.5000000000002}]} 12:35:46 INFO - Return code: 0 12:35:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:35:46 ERROR - # TBPL SUCCESS # 12:35:46 INFO - Running post-action listener: _resource_record_post_action 12:35:46 INFO - Running post-run listener: _resource_record_post_run 12:35:47 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 278528; Write bytes: 498491392; Read time: 52; Write time: 624704 12:35:47 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 245002240; Read time: 0; Write time: 421468 12:35:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 278528; Write bytes: 253489152; Read time: 52; Write time: 203236 12:35:47 INFO - Running post-run listener: _upload_blobber_files 12:35:47 INFO - Blob upload gear active. 12:35:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:47 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 12:35:47 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:35:47 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:35:48 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:49 INFO - (blobuploader) - INFO - Done attempting. 12:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:50 INFO - (blobuploader) - INFO - Done attempting. 12:35:50 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:50 INFO - Return code: 0 12:35:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53a362f7891d7fb3a6c1d4321d32722eb8a737d76221d37f92b758befe641927fd73d5b5c89a1e673e14ff9ee552143f972114ba15b45bb5c445fdac874296ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6d3f393c3113dd5f71bf63e7d22f03cf6274c7db6a9e6284f6d14f5ef07219fd8a4834a484bc1e93005b1d261cdbe4f70dffb50f95227107f18053eef0596c9"} 12:35:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:50 INFO - Contents: 12:35:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53a362f7891d7fb3a6c1d4321d32722eb8a737d76221d37f92b758befe641927fd73d5b5c89a1e673e14ff9ee552143f972114ba15b45bb5c445fdac874296ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6d3f393c3113dd5f71bf63e7d22f03cf6274c7db6a9e6284f6d14f5ef07219fd8a4834a484bc1e93005b1d261cdbe4f70dffb50f95227107f18053eef0596c9"} 12:35:50 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:50 INFO - Copying logs to upload dir... 12:35:50 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.334047 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-18 12:35:50.740132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:50.743686) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725 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/Mozilla-Aurora/sha512/53a362f7891d7fb3a6c1d4321d32722eb8a737d76221d37f92b758befe641927fd73d5b5c89a1e673e14ff9ee552143f972114ba15b45bb5c445fdac874296ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6d3f393c3113dd5f71bf63e7d22f03cf6274c7db6a9e6284f6d14f5ef07219fd8a4834a484bc1e93005b1d261cdbe4f70dffb50f95227107f18053eef0596c9"} build_url:https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53a362f7891d7fb3a6c1d4321d32722eb8a737d76221d37f92b758befe641927fd73d5b5c89a1e673e14ff9ee552143f972114ba15b45bb5c445fdac874296ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6d3f393c3113dd5f71bf63e7d22f03cf6274c7db6a9e6284f6d14f5ef07219fd8a4834a484bc1e93005b1d261cdbe4f70dffb50f95227107f18053eef0596c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:50.773058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:50.773444) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461006410.957470-1169907725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:50.859153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 12:35:50.859940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 12:35:50.860716) ========= ========= Total master_lag: 0.23 =========