builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1467826302.11 results: success (0) buildid: 20160706073423 builduid: d561b80e55da49529f455fb67012b9a1 revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.115340) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.115799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.116083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.403617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.403950) ========= 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=ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 10:31:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-07-06 10:31:42 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.530723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.531064) ========= 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=ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017603 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:42.787679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 10:31:42.790272) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --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-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --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=ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 10:31:43,185 truncating revision to first 12 chars 2016-07-06 10:31:43,185 Setting DEBUG logging. 2016-07-06 10:31:43,185 attempt 1/10 2016-07-06 10:31:43,185 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01a1714a1d04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 10:31:43,935 unpacking tar archive at: mozilla-beta-01a1714a1d04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088162 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 10:31:43.898702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:43.899049) ========= script_repo_revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:43.899437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:43.899726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 10:31:43.909838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-06 10:31:43.910188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:31:44 INFO - MultiFileLogger online at 20160706 10:31:44 in /builds/slave/test 10:31:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:31:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:31:44 INFO - {'append_to_log': False, 10:31:44 INFO - 'base_work_dir': '/builds/slave/test', 10:31:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:31:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:31:44 INFO - 'branch': 'Mozilla-Beta', 10:31:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:44 INFO - 'config_files': ('talos/linux_config.py',), 10:31:44 INFO - 'default_actions': ('clobber', 10:31:44 INFO - 'read-buildbot-config', 10:31:44 INFO - 'download-and-extract', 10:31:44 INFO - 'populate-webroot', 10:31:44 INFO - 'create-virtualenv', 10:31:44 INFO - 'install', 10:31:44 INFO - 'run-tests'), 10:31:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:44 INFO - 'download_minidump_stackwalk': True, 10:31:44 INFO - 'download_symbols': 'ondemand', 10:31:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:31:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:31:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:31:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:31:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:44 INFO - 'installer_path': 'installer.exe', 10:31:44 INFO - 'log_level': 'info', 10:31:44 INFO - 'log_name': 'talos', 10:31:44 INFO - 'log_to_console': True, 10:31:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:31:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:31:44 INFO - 'opt_config_files': (), 10:31:44 INFO - 'pip_index': False, 10:31:44 INFO - 'sps_profile': False, 10:31:44 INFO - 'sps_profile_interval': 0, 10:31:44 INFO - 'suite': 'dromaeojs-e10s', 10:31:44 INFO - 'system_bits': '32', 10:31:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:44 INFO - 'title': 'talos-linux64-ix-035', 10:31:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:44 INFO - 'use_talos_json': True, 10:31:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:31:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:44 INFO - 'work_dir': 'build'} 10:31:44 INFO - ##### 10:31:44 INFO - ##### Running clobber step. 10:31:44 INFO - ##### 10:31:44 INFO - Running pre-action listener: _resource_record_pre_action 10:31:44 INFO - Running main action method: clobber 10:31:44 INFO - rmtree: /builds/slave/test/build 10:31:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:31:44 INFO - Running post-action listener: _resource_record_post_action 10:31:44 INFO - ##### 10:31:44 INFO - ##### Running read-buildbot-config step. 10:31:44 INFO - ##### 10:31:44 INFO - Running pre-action listener: _resource_record_pre_action 10:31:44 INFO - Running main action method: read_buildbot_config 10:31:44 INFO - Using buildbot properties: 10:31:44 INFO - { 10:31:44 INFO - "project": "", 10:31:44 INFO - "product": "firefox", 10:31:44 INFO - "script_repo_revision": "production", 10:31:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:31:44 INFO - "repository": "", 10:31:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:31:44 INFO - "buildid": "20160706073423", 10:31:44 INFO - "pgo_build": "True", 10:31:44 INFO - "basedir": "/builds/slave/test", 10:31:44 INFO - "buildnumber": 84, 10:31:44 INFO - "slavename": "talos-linux64-ix-035", 10:31:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:31:44 INFO - "platform": "ubuntu64_hw", 10:31:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:31:44 INFO - "branch": "mozilla-beta", 10:31:44 INFO - "repo_path": "releases/mozilla-beta", 10:31:44 INFO - "revision": "01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d", 10:31:44 INFO - "stage_platform": "linux64-pgo", 10:31:44 INFO - "builduid": "d561b80e55da49529f455fb67012b9a1", 10:31:44 INFO - "slavebuilddir": "test" 10:31:44 INFO - } 10:31:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:31:44 INFO - Running post-action listener: _resource_record_post_action 10:31:44 INFO - ##### 10:31:44 INFO - ##### Running download-and-extract step. 10:31:44 INFO - ##### 10:31:44 INFO - Running pre-action listener: _resource_record_pre_action 10:31:44 INFO - Running main action method: download_and_extract 10:31:44 INFO - mkdir: /builds/slave/test/build/tests 10:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:44 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:31:46 INFO - Downloaded 1327 bytes. 10:31:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:31:46 INFO - Using the following test package requirements: 10:31:46 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:31:46 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:31:46 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:31:46 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'jsshell-linux-x86_64.zip'], 10:31:46 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:31:46 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:31:46 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:31:46 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:31:46 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:31:46 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:31:46 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:31:46 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:31: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')]} 10:31:46 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:31:47 INFO - Downloaded 24237047 bytes. 10:31:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:31:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:31:49 INFO - Return code: 0 10:31:49 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:31: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')]} 10:31:49 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:31:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:31:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:31:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:31:50 INFO - Downloaded 24237047 bytes. 10:31:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:31:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:31:51 INFO - Return code: 0 10:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:51 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:31:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:31:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:31:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:31:52 INFO - Downloaded 10840145 bytes. 10:31:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:31:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:31:52 INFO - Return code: 0 10:31:52 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')]} 10:31:52 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:31:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:31:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:31:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:31:53 INFO - Downloaded 56025129 bytes. 10:31:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:31:53 INFO - mkdir: /builds/slave/test/properties 10:31:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:53 INFO - Contents: 10:31:53 INFO - build_url:https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:31:54 INFO - Running post-action listener: _resource_record_post_action 10:31:54 INFO - Running post-action listener: set_extra_try_arguments 10:31:54 INFO - ##### 10:31:54 INFO - ##### Running populate-webroot step. 10:31:54 INFO - ##### 10:31:54 INFO - Running pre-action listener: _resource_record_pre_action 10:31:54 INFO - Running main action method: populate_webroot 10:31:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:31:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:31:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:31:54 INFO - '--tppagecycles', 10:31:54 INFO - '7'], 10:31:54 INFO - 'tests': ['tsvgm']}}, 10:31:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:31:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:31:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['damp', 'tps']}, 10:31:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'tests': ['damp', 'tps']}, 10:31:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['dromaeo_dom']}, 10:31:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['a11yr', 10:31:54 INFO - 'ts_paint', 10:31:54 INFO - 'tpaint', 10:31:54 INFO - 'sessionrestore', 10:31:54 INFO - 'sessionrestore_no_auto_restore', 10:31:54 INFO - 'tabpaint']}, 10:31:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:54 INFO - 'ts_paint', 10:31:54 INFO - 'tpaint', 10:31:54 INFO - 'sessionrestore', 10:31:54 INFO - 'sessionrestore_no_auto_restore', 10:31:54 INFO - 'tabpaint']}, 10:31:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:31:54 INFO - 'ts_paint', 10:31:54 INFO - 'tpaint', 10:31:54 INFO - 'sessionrestore', 10:31:54 INFO - 'sessionrestore_no_auto_restore', 10:31:54 INFO - 'tabpaint']}, 10:31:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:31:54 INFO - 'ts_paint', 10:31:54 INFO - 'tpaint', 10:31:54 INFO - 'sessionrestore', 10:31:54 INFO - 'sessionrestore_no_auto_restore', 10:31:54 INFO - 'tabpaint']}, 10:31:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['a11yr', 10:31:54 INFO - 'ts_paint', 10:31:54 INFO - 'tpaint', 10:31:54 INFO - 'sessionrestore', 10:31:54 INFO - 'sessionrestore_no_auto_restore', 10:31:54 INFO - 'tabpaint']}, 10:31:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['a11yr', 10:31:54 INFO - 'ts_paint', 10:31:54 INFO - 'tpaint', 10:31:54 INFO - 'sessionrestore', 10:31:54 INFO - 'sessionrestore_no_auto_restore', 10:31:54 INFO - 'tabpaint']}, 10:31:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['tsvgx', 10:31:54 INFO - 'tsvgr_opacity', 10:31:54 INFO - 'tart', 10:31:54 INFO - 'tscrollx', 10:31:54 INFO - 'cart']}, 10:31:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:54 INFO - 'tsvgr_opacity', 10:31:54 INFO - 'tart', 10:31:54 INFO - 'tscrollx', 10:31:54 INFO - 'cart']}, 10:31:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'talos_options': ['--disable-e10s'], 10:31:54 INFO - 'tests': ['tp5o']}, 10:31:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'tests': ['tp5o']}, 10:31:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'talos_options': ['--disable-e10s', 10:31:54 INFO - '--xperf_path', 10:31:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:54 INFO - 'tests': ['tp5n']}, 10:31:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:54 INFO - 'talos_options': ['--xperf_path', 10:31:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:54 INFO - 'tests': ['tp5n']}}, 10:31:54 INFO - 'talos.zip': {'path': '', 10:31:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:31:54 INFO - Running post-action listener: _resource_record_post_action 10:31:54 INFO - ##### 10:31:54 INFO - ##### Running create-virtualenv step. 10:31:54 INFO - ##### 10:31:54 INFO - Running pre-action listener: _resource_record_pre_action 10:31:54 INFO - Running main action method: create_virtualenv 10:31:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:54 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 10:31:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:31:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:54 INFO - Using real prefix '/usr' 10:31:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:55 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:57 INFO - Installing pip.................done. 10:31:57 INFO - Return code: 0 10:31:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:57 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:31:57 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 10:31:57 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 10:31:57 INFO - Using env: {'DISPLAY': ':0', 10:31:57 INFO - 'HOME': '/home/cltbld', 10:31:57 INFO - 'LANG': 'en_US.UTF-8', 10:31:57 INFO - 'LANGUAGE': 'en_US:en', 10:31:57 INFO - 'LOGNAME': 'cltbld', 10:31:57 INFO - 'MAIL': '/var/mail/cltbld', 10:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:57 INFO - 'MOZ_NO_REMOTE': '1', 10:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:57 INFO - 'NO_EM_RESTART': '1', 10:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:57 INFO - 'PWD': '/builds/slave/test', 10:31:57 INFO - 'SHELL': '/bin/bash', 10:31:57 INFO - 'SHLVL': '1', 10:31:57 INFO - 'TERM': 'linux', 10:31:57 INFO - 'TMOUT': '86400', 10:31:57 INFO - 'USER': 'cltbld', 10:31:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:57 INFO - '_': '/tools/buildbot/bin/python'} 10:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:57 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 10:31:57 INFO - Cleaning up... 10:31:57 INFO - Return code: 0 10:31:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:57 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:31:57 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 10:31:57 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 10:31:57 INFO - Using env: {'DISPLAY': ':0', 10:31:57 INFO - 'HOME': '/home/cltbld', 10:31:57 INFO - 'LANG': 'en_US.UTF-8', 10:31:57 INFO - 'LANGUAGE': 'en_US:en', 10:31:57 INFO - 'LOGNAME': 'cltbld', 10:31:57 INFO - 'MAIL': '/var/mail/cltbld', 10:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:57 INFO - 'MOZ_NO_REMOTE': '1', 10:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:57 INFO - 'NO_EM_RESTART': '1', 10:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:57 INFO - 'PWD': '/builds/slave/test', 10:31:57 INFO - 'SHELL': '/bin/bash', 10:31:57 INFO - 'SHLVL': '1', 10:31:57 INFO - 'TERM': 'linux', 10:31:57 INFO - 'TMOUT': '86400', 10:31:57 INFO - 'USER': 'cltbld', 10:31:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:57 INFO - '_': '/tools/buildbot/bin/python'} 10:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:57 INFO - Downloading/unpacking psutil>=0.7.1 10:31:57 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 10:31:57 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 10:31:57 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 10:31:57 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 10:31:57 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 10:31:57 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 10:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:59 INFO - Installing collected packages: psutil 10:31:59 INFO - Running setup.py install for psutil 10:31:59 INFO - building 'psutil._psutil_linux' extension 10:31:59 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 10:31:59 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 10:31:59 INFO - building 'psutil._psutil_posix' extension 10:31:59 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 10:32:00 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 10:32:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:00 INFO - Successfully installed psutil 10:32:00 INFO - Cleaning up... 10:32:00 INFO - Return code: 0 10:32:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:00 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:00 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 10:32:00 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 10:32:00 INFO - Using env: {'DISPLAY': ':0', 10:32:00 INFO - 'HOME': '/home/cltbld', 10:32:00 INFO - 'LANG': 'en_US.UTF-8', 10:32:00 INFO - 'LANGUAGE': 'en_US:en', 10:32:00 INFO - 'LOGNAME': 'cltbld', 10:32:00 INFO - 'MAIL': '/var/mail/cltbld', 10:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:00 INFO - 'MOZ_NO_REMOTE': '1', 10:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:00 INFO - 'NO_EM_RESTART': '1', 10:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:00 INFO - 'PWD': '/builds/slave/test', 10:32:00 INFO - 'SHELL': '/bin/bash', 10:32:00 INFO - 'SHLVL': '1', 10:32:00 INFO - 'TERM': 'linux', 10:32:00 INFO - 'TMOUT': '86400', 10:32:00 INFO - 'USER': 'cltbld', 10:32:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:00 INFO - '_': '/tools/buildbot/bin/python'} 10:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:32:02 INFO - Installing collected packages: mozsystemmonitor 10:32:02 INFO - Running setup.py install for mozsystemmonitor 10:32:02 INFO - Successfully installed mozsystemmonitor 10:32:02 INFO - Cleaning up... 10:32:02 INFO - Return code: 0 10:32:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:02 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:02 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 10:32:02 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 10:32:02 INFO - Using env: {'DISPLAY': ':0', 10:32:02 INFO - 'HOME': '/home/cltbld', 10:32:02 INFO - 'LANG': 'en_US.UTF-8', 10:32:02 INFO - 'LANGUAGE': 'en_US:en', 10:32:02 INFO - 'LOGNAME': 'cltbld', 10:32:02 INFO - 'MAIL': '/var/mail/cltbld', 10:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:02 INFO - 'MOZ_NO_REMOTE': '1', 10:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:02 INFO - 'NO_EM_RESTART': '1', 10:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:02 INFO - 'PWD': '/builds/slave/test', 10:32:02 INFO - 'SHELL': '/bin/bash', 10:32:02 INFO - 'SHLVL': '1', 10:32:02 INFO - 'TERM': 'linux', 10:32:02 INFO - 'TMOUT': '86400', 10:32:02 INFO - 'USER': 'cltbld', 10:32:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:02 INFO - '_': '/tools/buildbot/bin/python'} 10:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:02 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 10:32:02 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 10:32:02 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 10:32:02 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 10:32:02 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 10:32:02 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 10:32:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:04 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 10:32:04 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 10:32:04 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 10:32:04 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 10:32:04 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 10:32:04 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 10:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:05 INFO - Downloading docopt-0.6.1.tar.gz 10:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:05 INFO - Running setup.py install for blobuploader 10:32:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:05 INFO - Running setup.py install for requests 10:32:06 INFO - Running setup.py install for docopt 10:32:06 INFO - Successfully installed blobuploader requests docopt 10:32:06 INFO - Cleaning up... 10:32:06 INFO - Return code: 0 10:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:06 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:06 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 10:32:06 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 10:32:06 INFO - Using env: {'DISPLAY': ':0', 10:32:06 INFO - 'HOME': '/home/cltbld', 10:32:06 INFO - 'LANG': 'en_US.UTF-8', 10:32:06 INFO - 'LANGUAGE': 'en_US:en', 10:32:06 INFO - 'LOGNAME': 'cltbld', 10:32:06 INFO - 'MAIL': '/var/mail/cltbld', 10:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:06 INFO - 'MOZ_NO_REMOTE': '1', 10:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:06 INFO - 'NO_EM_RESTART': '1', 10:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:06 INFO - 'PWD': '/builds/slave/test', 10:32:06 INFO - 'SHELL': '/bin/bash', 10:32:06 INFO - 'SHLVL': '1', 10:32:06 INFO - 'TERM': 'linux', 10:32:06 INFO - 'TMOUT': '86400', 10:32:06 INFO - 'USER': 'cltbld', 10:32:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:06 INFO - '_': '/tools/buildbot/bin/python'} 10:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:06 INFO - Running setup.py (path:/tmp/pip-RYClhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:06 INFO - Running setup.py (path:/tmp/pip-fQnhP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:06 INFO - Running setup.py (path:/tmp/pip-8TqcwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:06 INFO - Running setup.py (path:/tmp/pip-l2VRoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:06 INFO - Running setup.py (path:/tmp/pip-T8ubQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:06 INFO - Running setup.py (path:/tmp/pip-D7KqSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:06 INFO - Running setup.py (path:/tmp/pip-9MMRma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:06 INFO - Running setup.py (path:/tmp/pip-39FucO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:07 INFO - Running setup.py (path:/tmp/pip-P2Z2KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:07 INFO - Running setup.py (path:/tmp/pip-JgpaOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:07 INFO - Running setup.py (path:/tmp/pip-WFtFSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:07 INFO - Running setup.py (path:/tmp/pip-LJ7Fb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:07 INFO - Running setup.py (path:/tmp/pip-gfioI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:07 INFO - Running setup.py (path:/tmp/pip-arClOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:07 INFO - Running setup.py (path:/tmp/pip-MXRjBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:07 INFO - Running setup.py (path:/tmp/pip-3FOv89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:07 INFO - Running setup.py (path:/tmp/pip-7ajzv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:07 INFO - Running setup.py install for manifestparser 10:32:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:07 INFO - Running setup.py install for mozcrash 10:32:07 INFO - Running setup.py install for mozdebug 10:32:07 INFO - Running setup.py install for mozdevice 10:32:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Running setup.py install for mozfile 10:32:08 INFO - Running setup.py install for mozhttpd 10:32:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Running setup.py install for mozinfo 10:32:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Running setup.py install for mozInstall 10:32:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Running setup.py install for mozleak 10:32:08 INFO - Running setup.py install for mozlog 10:32:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Running setup.py install for moznetwork 10:32:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Running setup.py install for mozprocess 10:32:08 INFO - Running setup.py install for mozprofile 10:32:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:32:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:32:09 INFO - Running setup.py install for mozrunner 10:32:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:32:09 INFO - Running setup.py install for mozscreenshot 10:32:09 INFO - Running setup.py install for moztest 10:32:09 INFO - Running setup.py install for mozversion 10:32:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:32:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:09 INFO - Cleaning up... 10:32:09 INFO - Return code: 0 10:32:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:09 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:09 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 10:32:09 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 10:32:09 INFO - Using env: {'DISPLAY': ':0', 10:32:09 INFO - 'HOME': '/home/cltbld', 10:32:09 INFO - 'LANG': 'en_US.UTF-8', 10:32:09 INFO - 'LANGUAGE': 'en_US:en', 10:32:09 INFO - 'LOGNAME': 'cltbld', 10:32:09 INFO - 'MAIL': '/var/mail/cltbld', 10:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:09 INFO - 'MOZ_NO_REMOTE': '1', 10:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:09 INFO - 'NO_EM_RESTART': '1', 10:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:09 INFO - 'PWD': '/builds/slave/test', 10:32:09 INFO - 'SHELL': '/bin/bash', 10:32:09 INFO - 'SHLVL': '1', 10:32:09 INFO - 'TERM': 'linux', 10:32:09 INFO - 'TMOUT': '86400', 10:32:09 INFO - 'USER': 'cltbld', 10:32:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:09 INFO - '_': '/tools/buildbot/bin/python'} 10:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:09 INFO - Running setup.py (path:/tmp/pip-sgR8YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:09 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)) 10:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:09 INFO - Running setup.py (path:/tmp/pip-6E83xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:09 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)) 10:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:09 INFO - Running setup.py (path:/tmp/pip-oLwfk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:09 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)) 10:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:09 INFO - Running setup.py (path:/tmp/pip-m6y2gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:09 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)) 10:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:09 INFO - Running setup.py (path:/tmp/pip-jGVRyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:10 INFO - Running setup.py (path:/tmp/pip-zIibWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:10 INFO - Running setup.py (path:/tmp/pip-iMkYJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:10 INFO - Running setup.py (path:/tmp/pip-QczxDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:10 INFO - Running setup.py (path:/tmp/pip-20W7T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:10 INFO - Running setup.py (path:/tmp/pip-NZNiqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:10 INFO - Running setup.py (path:/tmp/pip-9C_2SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:10 INFO - Running setup.py (path:/tmp/pip-M1RnSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:10 INFO - Running setup.py (path:/tmp/pip-YjAzPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:10 INFO - Running setup.py (path:/tmp/pip-LuraPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:10 INFO - Running setup.py (path:/tmp/pip-F1iI6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:10 INFO - Running setup.py (path:/tmp/pip-vmRCLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:10 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)) 10:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:10 INFO - Running setup.py (path:/tmp/pip-Wdgl89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:10 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)) 10:32:10 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)) 10:32:10 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)) 10:32:10 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)) 10:32:10 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)) 10:32:10 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)) 10:32:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:12 INFO - Downloading blessings-1.6.tar.gz 10:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:12 INFO - Installing collected packages: blessings 10:32:12 INFO - Running setup.py install for blessings 10:32:12 INFO - Successfully installed blessings 10:32:12 INFO - Cleaning up... 10:32:13 INFO - Return code: 0 10:32:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:13 INFO - Reading from file tmpfile_stdout 10:32:13 INFO - Current package versions: 10:32:13 INFO - argparse == 1.2.1 10:32:13 INFO - blessings == 1.6 10:32:13 INFO - blobuploader == 1.2.4 10:32:13 INFO - docopt == 0.6.1 10:32:13 INFO - manifestparser == 1.1 10:32:13 INFO - mozInstall == 1.12 10:32:13 INFO - mozcrash == 0.17 10:32:13 INFO - mozdebug == 0.1 10:32:13 INFO - mozdevice == 0.48 10:32:13 INFO - mozfile == 1.2 10:32:13 INFO - mozhttpd == 0.7 10:32:13 INFO - mozinfo == 0.9 10:32:13 INFO - mozleak == 0.1 10:32:13 INFO - mozlog == 3.1 10:32:13 INFO - moznetwork == 0.27 10:32:13 INFO - mozprocess == 0.22 10:32:13 INFO - mozprofile == 0.28 10:32:13 INFO - mozrunner == 6.11 10:32:13 INFO - mozscreenshot == 0.1 10:32:13 INFO - mozsystemmonitor == 0.0 10:32:13 INFO - moztest == 0.7 10:32:13 INFO - mozversion == 1.4 10:32:13 INFO - psutil == 3.1.1 10:32:13 INFO - requests == 1.2.3 10:32:13 INFO - wsgiref == 0.1.2 10:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:13 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 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:13 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 10:32:13 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 10:32:13 INFO - Using env: {'DISPLAY': ':0', 10:32:13 INFO - 'HOME': '/home/cltbld', 10:32:13 INFO - 'LANG': 'en_US.UTF-8', 10:32:13 INFO - 'LANGUAGE': 'en_US:en', 10:32:13 INFO - 'LOGNAME': 'cltbld', 10:32:13 INFO - 'MAIL': '/var/mail/cltbld', 10:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:13 INFO - 'MOZ_NO_REMOTE': '1', 10:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:13 INFO - 'NO_EM_RESTART': '1', 10:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:13 INFO - 'PWD': '/builds/slave/test', 10:32:13 INFO - 'SHELL': '/bin/bash', 10:32:13 INFO - 'SHLVL': '1', 10:32:13 INFO - 'TERM': 'linux', 10:32:13 INFO - 'TMOUT': '86400', 10:32:13 INFO - 'USER': 'cltbld', 10:32:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:13 INFO - '_': '/tools/buildbot/bin/python'} 10:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 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)) 10:32:13 INFO - Cleaning up... 10:32:13 INFO - Return code: 0 10:32:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:32:13 INFO - Using env: {'DISPLAY': ':0', 10:32:13 INFO - 'HOME': '/home/cltbld', 10:32:13 INFO - 'LANG': 'en_US.UTF-8', 10:32:13 INFO - 'LANGUAGE': 'en_US:en', 10:32:13 INFO - 'LOGNAME': 'cltbld', 10:32:13 INFO - 'MAIL': '/var/mail/cltbld', 10:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:13 INFO - 'MOZ_NO_REMOTE': '1', 10:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:13 INFO - 'NO_EM_RESTART': '1', 10:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:13 INFO - 'PWD': '/builds/slave/test', 10:32:13 INFO - 'SHELL': '/bin/bash', 10:32:13 INFO - 'SHLVL': '1', 10:32:13 INFO - 'TERM': 'linux', 10:32:13 INFO - 'TMOUT': '86400', 10:32:13 INFO - 'USER': 'cltbld', 10:32:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:13 INFO - '_': '/tools/buildbot/bin/python'} 10:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:13 INFO - Downloading/unpacking jsonschema 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:15 INFO - Downloading/unpacking functools32 (from jsonschema) 10:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:15 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:15 INFO - warning: no files found matching '*.txt' 10:32:15 INFO - no previously-included directories found matching 'build' 10:32:15 INFO - no previously-included directories found matching 'dist' 10:32:15 INFO - no previously-included directories found matching '.git*' 10:32:15 INFO - Installing collected packages: jsonschema, functools32 10:32:15 INFO - Running setup.py install for functools32 10:32:15 INFO - warning: no files found matching '*.txt' 10:32:15 INFO - no previously-included directories found matching 'build' 10:32:15 INFO - no previously-included directories found matching 'dist' 10:32:15 INFO - no previously-included directories found matching '.git*' 10:32:16 INFO - Successfully installed jsonschema functools32 10:32:16 INFO - Cleaning up... 10:32:16 INFO - Return code: 0 10:32:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:32: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')]} 10:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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')]} 10:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9438b40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', '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 10:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:32:16 INFO - Using env: {'DISPLAY': ':0', 10:32:16 INFO - 'HOME': '/home/cltbld', 10:32:16 INFO - 'LANG': 'en_US.UTF-8', 10:32:16 INFO - 'LANGUAGE': 'en_US:en', 10:32:16 INFO - 'LOGNAME': 'cltbld', 10:32:16 INFO - 'MAIL': '/var/mail/cltbld', 10:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:16 INFO - 'MOZ_NO_REMOTE': '1', 10:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:16 INFO - 'NO_EM_RESTART': '1', 10:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:16 INFO - 'PWD': '/builds/slave/test', 10:32:16 INFO - 'SHELL': '/bin/bash', 10:32:16 INFO - 'SHLVL': '1', 10:32:16 INFO - 'TERM': 'linux', 10:32:16 INFO - 'TMOUT': '86400', 10:32:16 INFO - 'USER': 'cltbld', 10:32:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:16 INFO - '_': '/tools/buildbot/bin/python'} 10:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:16 INFO - Downloading/unpacking flake8 10:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:32:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:32:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:18 INFO - no previously-included directories found matching 'docs/_build' 10:32:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:32:18 INFO - Running setup.py install for pep8 10:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:19 INFO - no previously-included directories found matching 'docs/_build' 10:32:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:32:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:32:19 INFO - Cleaning up... 10:32:19 INFO - Return code: 0 10:32:19 INFO - Running post-action listener: _resource_record_post_action 10:32:19 INFO - Running post-action listener: _start_resource_monitoring 10:32:19 INFO - Starting resource monitoring. 10:32:19 INFO - ##### 10:32:19 INFO - ##### Running install step. 10:32:19 INFO - ##### 10:32:19 INFO - Running pre-action listener: _resource_record_pre_action 10:32:19 INFO - Running main action method: install 10:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:19 INFO - Reading from file tmpfile_stdout 10:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:32:19 INFO - Reading from file tmpfile_stdout 10:32:19 INFO - Output received: 10:32:19 INFO - Usage: mozinstall [options] installer 10:32:19 INFO - Options: 10:32:19 INFO - -h, --help show this help message and exit 10:32:19 INFO - -d DEST, --destination=DEST 10:32:19 INFO - Directory to install application into. [default: 10:32:19 INFO - "/builds/slave/test"] 10:32:19 INFO - --app=APP Application being installed. [default: firefox] 10:32:19 INFO - mkdir: /builds/slave/test/build/application 10:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:32:32 INFO - Reading from file tmpfile_stdout 10:32:32 INFO - Output received: 10:32:32 INFO - /builds/slave/test/build/application/firefox/firefox 10:32:32 INFO - Running post-action listener: _resource_record_post_action 10:32:32 INFO - ##### 10:32:32 INFO - ##### Running run-tests step. 10:32:32 INFO - ##### 10:32:32 INFO - Running pre-action listener: _resource_record_pre_action 10:32:32 INFO - Running main action method: run_tests 10:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:32 INFO - Python 2.7.3 10:32:32 INFO - Return code: 0 10:32:32 INFO - grabbing minidump binary from tooltool 10:32: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')]} 10:32:32 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 0x1b75410>, '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 0x1b76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b767a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:32 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 10:32:32 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 10:32:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:32 INFO - Return code: 0 10:32:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:32:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:32:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:32:33 INFO - Return code: 0 10:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 10:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 10:32:33 INFO - Using env: {'DISPLAY': ':0', 10:32:33 INFO - 'HOME': '/home/cltbld', 10:32:33 INFO - 'LANG': 'en_US.UTF-8', 10:32:33 INFO - 'LANGUAGE': 'en_US:en', 10:32:33 INFO - 'LOGNAME': 'cltbld', 10:32:33 INFO - 'MAIL': '/var/mail/cltbld', 10:32:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:33 INFO - 'MOZ_NO_REMOTE': '1', 10:32:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:33 INFO - 'NO_EM_RESTART': '1', 10:32:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:33 INFO - 'PWD': '/builds/slave/test', 10:32:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:33 INFO - 'SHELL': '/bin/bash', 10:32:33 INFO - 'SHLVL': '1', 10:32:33 INFO - 'TERM': 'linux', 10:32:33 INFO - 'TMOUT': '86400', 10:32:33 INFO - 'USER': 'cltbld', 10:32:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566', 10:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:33 INFO - '_': '/tools/buildbot/bin/python'} 10:32:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 10:32:33 INFO - mozversion application_buildid: 20160706073423 10:32:33 INFO - mozversion application_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 10:32:33 INFO - mozversion application_display_name: Firefox 10:32:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:33 INFO - mozversion application_name: Firefox 10:32:33 INFO - mozversion application_remotingname: firefox 10:32:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:32:33 INFO - mozversion application_vendor: Mozilla 10:32:33 INFO - mozversion application_version: 48.0 10:32:33 INFO - mozversion platform_buildid: 20160706073423 10:32:33 INFO - mozversion platform_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 10:32:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:32:33 INFO - mozversion platform_version: 48.0 10:32:33 INFO - using testdate: 1467826353 10:32:33 INFO - actual date: 1467826353 10:32:33 INFO - starting webserver on 'localhost:33510' 10:32:33 INFO - SUITE-START | Running 2 tests 10:32:33 INFO - TEST-START | dromaeo_css 10:32:33 INFO - operating with platform_type : linux_ 10:32:33 INFO - Initialising browser for dromaeo_css test... 10:32:33 INFO - TEST-INFO | started process 28593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkCgBX/profile http://localhost:33510/getInfo.html) 10:32:37 INFO - PROCESS | 28593 | 10:32:37 INFO - PROCESS | 28593 | (process:28669): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:32:37 INFO - PROCESS | 28593 | __metrics Screen width/height:1600/1200 10:32:37 INFO - PROCESS | 28593 | colorDepth:24 10:32:37 INFO - PROCESS | 28593 | Browser inner width/height: 1024/697 10:32:37 INFO - PROCESS | 28593 | __metrics 10:32:38 ERROR - PROCESS | 28593 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:32:39 INFO - TEST-INFO | 28593: exit 0 10:32:39 INFO - Browser initialized. 10:32:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:39 INFO - TEST-INFO | started process 28719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkCgBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:41 INFO - PROCESS | 28719 | 10:32:41 INFO - PROCESS | 28719 | (process:28790): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:32:51 INFO - PROCESS | 28719 | RSS: Main: 151154688 10:32:51 INFO - PROCESS | 28719 | 10:33:40 INFO - PROCESS | 28719 | 1467826420660 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] 10:35:47 INFO - PROCESS | 28719 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33510/tests/dromaeo/cssquery-ext.html) 10:35:48 INFO - PROCESS | 28719 | RSS: Main: 155410432 10:35:48 INFO - PROCESS | 28719 | 10:38:50 INFO - PROCESS | 28719 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-ext.html (next: http://localhost:33510/tests/dromaeo/cssquery-jquery.html) 10:38:51 INFO - PROCESS | 28719 | RSS: Main: 152666112 10:38:51 INFO - PROCESS | 28719 | 10:41:53 INFO - PROCESS | 28719 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33510/tests/dromaeo/cssquery-mootools.html) 10:41:53 INFO - PROCESS | 28719 | RSS: Main: 152895488 10:41:53 INFO - PROCESS | 28719 | 10:44:55 INFO - PROCESS | 28719 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33510/tests/dromaeo/cssquery-prototype.html) 10:44:56 INFO - PROCESS | 28719 | RSS: Main: 153513984 10:44:56 INFO - PROCESS | 28719 | 10:47:58 INFO - PROCESS | 28719 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33510/tests/dromaeo/cssquery-yui.html) 10:47:59 INFO - PROCESS | 28719 | RSS: Main: 152453120 10:47:59 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-yui.html (next: http://localhost:33510/tests/dromaeo/cssquery-dojo.html) 10:51:01 INFO - PROCESS | 28719 | RSS: Main: 156229632 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | __start_tp_report 10:51:01 INFO - PROCESS | 28719 | _x_x_mozilla_page_load 10:51:01 INFO - PROCESS | 28719 | _x_x_mozilla_page_load_details 10:51:01 INFO - PROCESS | 28719 | |i|pagename|runs| 10:51:01 INFO - PROCESS | 28719 | |0;dojo.html;3288.4080865444216;3388.1190890368503;3398.456247000477;3436.707879830214;3445.793252404856;5565.193047008182;5589.273394458724;5622.943770562288;5624.437556244384;5651.180578816069;5521.089020311654;5598.440155984399;5630.268065151535;5632.859178520539;5640.435956404358;5062.544371006608;5122.359705036871;5130.230465430178;5149.485051494858;5169.198774190007;5037.24441333801;5096.694198348111;5220.765065572039;5244.895102097956;5268.473152684739;5088.821891233808;5124.769385377648;5164.535191832734;5169.483051694838;5181.326427564431;5151.201563757623;5155.226715992593;5170.948290517084;5173.844784656466;5201.635885488017;4944.456109827916;4953.975230123862;5064.088464076464;5083.161278389061;5144.176931690911;5298.046351656701;5321.467853214686;5336.91994620081;5338.252644629755;5373.919391209135;5822.214001109881;5824.970875145639;5851.912221316684;5874.853128671774;5884.264466941632;5801.622894511843;5853.151293062525;5877.67672777997;5927.2590926134235;5936;5607.803726869581;5615.46653067962;5620.662760234399;5634.352049514277;5640.210370548127;6089.969550152309;6113.388661133851;6113.541484388688;6116.296625887991;6135.355787642323;5629.24005259293;5834.591578589543;5876.588638795243;5884.146798714162;5948.375420580864;5966.284045914518;5982.820515384546;5993.220881285492;5998.820035398945;5998.940010599838;5928.851778705567;5955.464008239279;5977.731002104829;5980.910286345708;5985.730642121115;5835.67903765297;5973.462388385066;6026.337102918676;6029.577929544977;6057.485113765291;4552.294394368878;4571.954280457219;4582.610478109332;4593.127305811885;4626.329182268552;4038.4749982502676;4106.2198182345255;4111.239420707178;4114.074333275049;4133.6693064554765;5564;5655.491005809415;5707.6575405475805;5710.600257981984;5799.652020878761;5986.2517185351835;6036.637801731822;6037;6054.122152287893;6058.363871793486;5610.85972850682;5739.282589676291;5758.165066065397;5762.078067509178;5772.538196944234;5066.46802085783;5077.543021128043;5136.640435169577;5150.8969820604125;5170.922436163461;6317.778877739257;6360.936390636034;6365.2361716594305;6366.6180029198395;6368.872622547523;5855.2973643163095;5939.07944268639;6030.7889223876955;6040.063790112539;6044.516438684983;6256.311805701278;6271.874562508816;6312.968435157794;6313;6313.779017734358;5911;5922.585419020627;5944.609987742087;5971.850703732268;6001.789937352171;5820.592558520862;6000.039993601003;6015.819525414245;6033.245844269466;6081.817545473643;5811.970940145272;5820.592558520862;5821;5873.353931067664;5873.9412605873395;5753.1945527627;5810.360860305447;5842.737076831468;5851.590388672752;5853.414658534112;5521.199426083115;5692.089265717631;5763.9135412968;5812.418758124154;5858.326292476419;5748.310202775527;5753.367129615655;5768.048272035067;5780.855478613068;5782.855428614318;5640.041192997118;5643.802466913638;5648.858778530405;5654.660720356792;5683.175939488834 10:51:01 INFO - PROCESS | 28719 | |1;ext.html;665.8035879415572;684.110656147009;684.2063206680245;733.3729661139726;748.0200936772828;33812.66187338126;34685.82657086714;43398.78300608497;44387.334189987094;44599.77700111503;46902;47366.76316618412;47578;47621.28568071482;47657.76171119139;8867.467951922888;9004.099590040976;9019.95490022549;9022.188003079722;9046.592903319366;8783.560821958876;8826.735197944072;8829.55852207387;8846.24806891415;8854.380193386465;8900.73297801067;8907.955460222689;8943.776405589848;8946.910530894706;8974.28205743539;8927.375083744108;8943.955280223623;8946.23956963659;8967.596458159365;9009.819803603892;8840;8893.11068893112;8917.019127895926;8937.910620893774;8968.237699795525;44476;44732.3290150648;45124.77437612824;45167;45266;3878.5927477614728;3879.6120387960977;3971.205758848242;3976.383660532622;4212.662986961066;34124.48813267803;34690.653093468994;35043.4743478848;35157;35276.29447411063;4634.328022436762;4676.672632915697;4754.833580824655;4757.096151731194;4783.521647835223;328189;330112;331156;332743.33628331946;333795;39250.41124383137;64663;65424.672876636265;65632.34367656262;65735.34264657387;37435.25129497449;37676.623233767314;37763.81118094392;37949.24101517954;37961;16682.249298781582;16846.410375636795;16867.662646746998;16891.662166756843;16942.830571694372;14420.278986050866;14424.134551926918;14439.92780036093;14462.349194286282;14491.20298383578;9229.815403691888;9279.396839205565;9308.441493510276;9349.579268932914;9424.198943089914;3511.9297614048087;3660.9450858237146;3663.168415792104;3682.6133256007734;3689.594144644087;1120.910327173824;1122.6575894352302;1131.3538801044624;1136.720248265282;1224.3266203588169;33641.4618840338;33778.32443351119;33959.4906076409;34163.829180853936;34515.13712157216;1232.6548566401423;1251.3492983648453;1287.2726909296218;1311.9868801311866;1328.634625477982;17520.38678646241;17558.91220543915;17571.73642395365;17722.379716709853;17840.643187136186;497211;569040;572964;582421;591772;57676.134857977166;58681.41318586845;58743.706281468316;58862.705686471294;59047;1473.7347277490155;1571.2065406969407;1573.8268790433044;1584.1208129488246;1600.0639625819026;31134;31421.214469638442;32664.673353266164;34508.48237276392;34958;55749.72125139349;56472;56680.71659641675;56683;56738.716306419854;450958;452233;455543;455723;456095;31241.68758312388;31292;31351.372972539964;31573;31690.841545793046;50633.240501391774;50980;51139.744301279745;51474.48525514697;51798.741006294724;42902.356464653676;43133.784331078146;43253;43527.25890964326;44285.77857110694;40799.18401631891;42071;42649.5735042658;42906;43719.56280437282;43246.13507729891;43285.78357108194;44329.11341773211;44489.777551112034;44550.55449445464;36353.27293454169;37890;37931.43102853404;38640.03399915025;38926.610733892296;29239.7076029237;29614;30277.202485264326;30459;30694.38611227718 10:51:01 INFO - PROCESS | 28719 | |2;jquery.html;414.23573506879796;418.6901692747368;428.15866821695363;433.6509110166316;435.71678409034126;12066.879331206685;12584.874151258484;19106.42680719579;19754.604907901834;19803.108860101274;20822.063007164677;20952.685709714366;21136.260230891923;21303.57392852142;21338.039788209528;5878.41215878413;6493.220813502375;6791.3208679132185;6799.7280108795585;6821.4542836572955;6651.933480665204;6695.464362850985;6698.263191048981;6717.563358381714;6761.661916904135;6550.11573437587;6675.7997260082275;6720.294369091248;6730.798076057726;6741.494387920901;6456.354364563553;6635.270120286765;6671.399574038335;6675.566088204299;6692.9330706693045;6525.0212468129685;6529.5755775874895;6542.542022058457;6546.44355229806;6551.541392102555;26213.868930655415;26286.21141365762;26354.20937371882;26501.204963851116;26813.731862681514;2544.75824796644;2637.8549179795104;2748.9862550687117;2811.9437611247863;2900.303927057491;15772.684546309125;15868.603284917854;16109.19454027294;16481.752773708406;17083.231254593447;2137.8717276963275;2175.630142875715;2178.3900507857825;2254.222293308806;2300.068472268734;95652.043479565;96404;96504.51747741287;96915.51542242314;97271;17448.47654570365;18876.433706988813;18950.52623684419;18985.525361866064;19107.044647767558;33659;33701.325973480394;34023.63905443804;34300.48549271763;34325.485117723256;10962.506687199095;11081.501332440059;11140.108791296676;11202.159838012181;11276.1542884284;9358.532073396304;9368.156865882103;9381;9487.952560237154;9493.335466517416;9298.72103836886;9298.86051709225;9357.20463760588;9376.156145946898;9442.669506567237;3707.8516859325323;3785.545734511876;3820.426935959573;3834.2714884172474;3968.444417781513;971.6647756523988;1129.9661010169707;1139.515705825021;1166.422620802708;1204.4278967490372;18353.265869365077;18483.353082642043;18586.628267434848;19093.331733389266;19235.4229373119;1078.0674716370283;1083.5015892689294;1085.913126949842;1111.0944580167138;1111.8443417921496;10476.580936762444;10758.24692271549;10808.51361688726;10818.729531761612;10869.076128529005;513710;517148;530258;536144;537174;77100.61449692716;86872;90584;93401.53299233597;102501;1157.438642258504;1162.3084264862393;1165;1196.6709154982275;1215.9148859579745;17522.82477175212;17537.386191483747;17553;17954.64090718152;18061;40062.599374005884;40247;40669.1866162681;40765.592344076176;40994.59005409908;58221.5444613888;61351.386486134565;61435.38564614476;61686.383136168064;61849.38150618436;9038.114878934442;9066.682666106919;9178.357514974155;9212.907870921474;9324.860127098234;13115;13991.090579112732;13994.020418570602;14070.718585628434;14156.433742650179;11342.829857552308;11393.316401015965;11522.193446458667;11691.766164676828;11857.703557411134;11359.148063895405;11455.255408398427;11693.707657308636;11698.76602467963;11698.824517632072;12077.698057548632;12098.818517722066;12131.514739410677;12132.968697660797;12427.44076516541;8383.95200599925;8412.284955778583;8542.957285213533;8558.871616925875;8625.91374086251;11091.544904444481;12147.635570932885;12233.816492752794;12280.263184208976;12284.201526900722 10:51:01 INFO - PROCESS | 28719 | |3;mootools.html;1606.4698649445681;1608.4048901906292;1850;1917.1372882203011;1925.4416219296395;7515.511491753045;8283.088860225385;8297.751067467978;8413.074561798197;8457.900472938525;8283.751487455385;8344.666213351458;8444.028936672285;8512.27645650119;8569.057403685589;2428.4900170964074;2445.303088619744;2459.56957532432;2465.1125594785863;2465.963010554843;2431.6170053609276;2459.8155138364605;2462.642916777066;2463.88912498938;2468.5803413419762;2402.723686776017;2403.4351927297157;2418.5646583614944;2423.8060955123638;2433.744456832034;2434.379233295516;2435.1842132885504;2439.231642032763;2451.031842422251;2460.0405841721745;2452.1785201957364;2460.0651752333997;2461.212412028152;2474.5174690935273;2477.925662230136;8648.827023459495;8649.610767515476;8671.349648776368;8686.218240358336;8706.259967902735;5298.576113910916;5395.433479484676;5461.481159289861;5472.945270547283;5473.507384335389;3473.235888104613;3523.312953973976;3538.486919396699;3632.891013269606;3708.5364329458816;1217.3791366403198;1228.9508419663202;1236.1779416687891;1254.6047994881674;1259.5465632372338;11804.055675545937;11884.821727674092;11909.761804763943;11976.760464790743;12002.399880005965;4386.824527018947;4388.714733542373;4466.218411777926;4466.687331886802;4476.753778542212;9737.707868763948;9741.366811157252;9754.170895473964;9763.90236097644;9779.85330220033;5130;5159.2003239497935;5174.793008279702;5175.042617115846;5192.1173400522;4314.374415709704;4787.832425865078;4816.8554943351755;4819.6867203632355;4867.342908707279;3895.337792575269;3903.5706072332023;4007.959920400817;4094.28350038742;4106.07613287014;1205.318994767971;1240.0637518673343;1243.8383010208615;1249.1131296779206;1249.7188132670258;1085.6742977106837;1097.9725506862233;1100.3782862682558;1101.2841652925501;1105.8396532502902;5909.674967876808;6089.451949324582;6215.906761398583;6216.285127210338;6234.844128896723;1036.8548403223556;1054.4674939155677;1075.983860242097;1081.4538657977828;1118.8098023336051;4290.957090429119;4296.656267498593;4303.677224208197;4311.1808756336195;4313.439252897166;10142.847857282146;10378.06597406237;10454.425006624557;10473.214508911862;10505.159587233004;10203.94898025505;10204;10509.211809114347;10580.312279701795;10617.097546708615;7922.168172341821;8009.919900801034;8053;8135.267825895816;8141.877871831927;5845.912311315419;6019.578629495893;6028.849278768066;6174.104754810617;6214.4407003369915;9283.257339412965;9303.72088837336;9378.67174648884;9459.006804285726;9480.620775168916;9414.57634406467;9543.713688589354;9552.665656701982;9568.808623827623;9922.454265015205;7237.276272372721;7472.476926615085;7477.177510473734;7521.5111017783665;7686.346660533917;8062.475939064177;8140.715074972348;8147.75556733299;8242.381821363302;8295.585220738818;7217.927820721726;7234.276572342934;7300.96349518249;7409.777706668809;7442.1441534222095;7453.25467453272;7550.207228240955;7574.242575742382;7599.848003039798;7624.8475030500185;6932.376086152069;6983.930160698328;6986.510944234058;7001.649917504003;7016.789496315118;5103.948960510347;5122.513361230677;5237.685738855681;5361.597880159082;5379.515843574097;5139.383274007143;5142.460041695568;5146.459621739664;5222.190560463135;5290.1800220965815 10:51:01 INFO - PROCESS | 28719 | |4;prototype.html;343.59970634211146;351.0906751513579;356.791277102895;358.6753987641184;359.6673077403402;6292.968535157329;6353.682315884211;6442.581232219908;6448.226212854458;6452.3225061368585;6351.396617321347;6355.650439225841;6376.9362306376925;6430.96784516078;6482.092507049017;4880.219164933611;4881.707097574148;4881.8779530511665;4881.975590122044;4894.2903279024695;4880.389951256093;4894.535019173173;4899.118158731427;4900.681455705386;4910.582600478963;4855.878603034935;4856.927146092811;4858.975705121487;4876.658633895629;4879.56083952446;4675.812967481296;4859.173940430118;4861.246506791471;4874.293227481995;4878.780454879521;4211.620954114144;4223.176480586287;4228.090960443519;4232.32282834748;4236.364545318196;6184.536159787989;6187.504999600066;6189.38106189382;6195.87608247837;6208.255009398856;5646.520045796112;5650.7174641267775;5659.207710920475;5660.405657405954;5664.348599910981;6759.425448836855;6790.151231096113;6796.490263230228;6797.28628494006;6802.523823332369;4626.444826620794;4710.764461776897;4715.198416269242;4715.457722361938;4723.07899959508;6858.211305699859;6977.6511174441075;6980.7905762827195;6991.091158149459;6992.580445173306;4690.202665546865;4729.266963620645;4730.479647238801;4731.266653668687;4733.006068725606;4766.142094422968;4793.736344501016;4796.8081276749235;4803.831865884677;4805.639577031737;5514.641548299348;5536.141898005815;5561.221428999943;5563.5271001964475;5572.331320241597;6576.967115164489;6677.332266773381;6712.295209003082;6741.460683145337;6742.157230346207;1672.991635041817;1707.581642497596;1710.0252855872034;1712.1695977450927;1714.0487029698388;1097.4896673046912;1109.5284504085732;1121.2319561100671;1126.3298337489346;1127.464454384161;6461.418472337512;6590.3080176581725;6593.967030164818;6594.637294948824;6596.208454985336;6944;7000;7002.544834585736;7041.788746337618;7062.364387205176;6627.10534077903;6628.966855165693;6633.767818126343;6637.800865974028;6650.268470468244;3746.569144548357;3774.8867533974026;3798.3163030654746;3807.8476860925252;3814.389697648363;7323.340899319087;7522.172561018284;7565.810854728676;7571.583562904093;7572.318491335806;7168.247334029852;7174.605396703127;7197.244289349647;7198.244184360671;7233.421326293884;7416.814579635552;7432.070991126109;7451.366633836076;7451.5901625411125;7467.477276590586;7029.61337126463;7034.648267586703;7038.507304488637;7042.260562641054;7044.823879403056;6782.118324617768;6971.5468494547695;7007.369336759716;7009.754658587129;7018.438524918097;7425.517341372793;7438.962805185939;7471.290227428385;7479.663415146223;7493.550386976799;4656.138614356355;4690.437147542317;4699.835505757282;4700.2949557566635;4710.481846996896;7010.334018268256;7021;7024.648767561704;7038.225795162631;7040.260772618802;6705.2959439258175;6818;6832.624205668736;6847.417969472651;6850.38346548813;6775.288594697486;6824.112865327475;6824.2152152503095;6842.828929276808;6848.863022739418;6678.3989440950545;6703.765368212089;6713.63075030878;6730.966345168439;6734.393904548614;6829.351211634887;6845.794626161223;6865.210500792473;6880.380765731108;6889.276625954403;6505.674716264073;6553.967230163818;6667.566608170453;6687.465002799861;6705.8994115087335 10:51:01 INFO - PROCESS | 28719 | |5;yui.html;854.9145085491448;906.7461110888953;943.4669411782343;960.2653969713168;972.3533849989752;14288.428462861486;14451.927740361283;14474.059186152906;14520.128792272471;14526.564203073898;14473.927630361834;15298.082115073103;15298.23508824557;15315.157666328376;15320.080795152271;892.9151730585584;906.1889608800103;911.7492689510404;923.529000209891;927.972160835176;924.7179610218881;928.2295694573488;929.1823195587873;932.9346945713803;933.4865823796919;970.6457143142773;972.2270794718181;976.5361453309656;977.081543349253;980.5783513089368;963.1716723617718;963.3978763272954;966.4442945306477;966.8308046091976;967.5404183013083;712.273481049332;712.4834494991142;712.9714811407538;714.6248219684655;716.5342527357208;15643;15644.843551564452;15656.373745050185;15665.686686266325;15716.842831571652;14725.410983560645;14974.951753377269;15059.924700376429;15070.698586028328;15095.773563396559;11961.162718609701;11976.341301228429;12016.399180041051;12255.1421400502;12372.329735485775;3937.76373417593;3942.546607140187;3994.1612261424843;4071.918561628751;4122.835086596532;58497.7075114626;58753;58914.41085589175;58969.41030589682;59306.40693593052;11566.363849988164;11696.35670038156;11793;11809.173357864867;11907.285562866256;20752.792472075085;20792.37622871316;20816.895915520327;20872.895635521727;20903.68644470334;8508.404411691246;8593.398462107718;8634.568271586395;8727.825443491094;8913.598888050054;5094.363204599425;5100.2349647553165;5156.793728250903;5201.219817027476;5205.427402985669;3731.626837316301;3778.1688028634208;3785.8296376662565;3786.091338078841;3804.4483549885113;690.7478770248923;702.3748863511479;706.5831159615851;710.8045287545966;712.3909057755544;740.5852722475431;749.4304328710219;767.731294047079;806.4475834053692;831.098258389654;9900.950495247622;10145.289829711997;10351.585936562604;10423.843642345371;10568.15454763617;760.3916866506883;777.4713195027435;836.9117954746964;839.1524560194126;860.324645153564;4071.531773845986;4610.74640894754;4647.3029045643425;4713.34013238147;4748.857534273978;64475;66479.66760166168;66502.33497664961;66788.6660566694;66875;55680.443195567525;56615.150772738445;57452.42547574554;57473;59374.40625593775;52731.47268527265;54190.45809541933;54533.45466545363;55387.44612553984;55471.722641386536;9297.209737172416;9334.206592439446;9356.859647105435;9373.1564159226;9456.101670341306;39560.802195988836;39752.20495590014;39801.00497487586;40189.19621607493;40653.390199146445;46470.30294545517;47878.28182577334;50666.74666626643;51415.48584514107;51588.48411515987;11599.8260026098;11621.709457263636;11744.58893938708;11835.349055802013;11948.701282468008;13054.282014489294;13126.14680045794;13250.536231231861;13481.191128532319;13645.931770341085;12078.51685932553;12288.68205584505;12349.19730217533;12554.937225313815;12653.936730316289;12416.317102559446;12476.313802740573;12572.30852303132;12730;12828.679283017998;12339.75320493603;12386.690332741753;12495.750084998432;12568.245905245714;12786.360681965678;10409.843852342372;10564.841527376942;10566.366018038942;10602.840957385491;10944.726381840199;10367.429791361246;10682.359058456517;10790.460476976277;10878.238523303293;10933.83599246028 10:51:01 INFO - PROCESS | 28719 | __end_tp_report 10:51:01 INFO - PROCESS | 28719 | __start_cc_report 10:51:01 INFO - PROCESS | 28719 | _x_x_mozilla_cycle_collect,331 10:51:01 INFO - PROCESS | 28719 | __end_cc_report 10:51:01 INFO - PROCESS | 28719 | __startTimestamp1467827461258__endTimestamp 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | ------- Summary: start ------- 10:51:01 INFO - PROCESS | 28719 | Number of tests: 6 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | [#0] dojo.html Cycles:165 Average:5559.94 Median:5758.17 stddev:613.38 (10.7%) stddev-sans-first:588.81 10:51:01 INFO - PROCESS | 28719 | Values: 3288.4 3388.1 3398.5 3436.7 3445.8 5565.2 5589.3 5622.9 5624.4 5651.2 5521.1 5598.4 5630.3 5632.9 5640.4 5062.5 5122.4 5130.2 5149.5 5169.2 5037.2 5096.7 5220.8 5244.9 5268.5 5088.8 5124.8 5164.5 5169.5 5181.3 5151.2 5155.2 5170.9 5173.8 5201.6 4944.5 4954.0 5064.1 5083.2 5144.2 5298.0 5321.5 5336.9 5338.3 5373.9 5822.2 5825.0 5851.9 5874.9 5884.3 5801.6 5853.2 5877.7 5927.3 5936.0 5607.8 5615.5 5620.7 5634.4 5640.2 6090.0 6113.4 6113.5 6116.3 6135.4 5629.2 5834.6 5876.6 5884.1 5948.4 5966.3 5982.8 5993.2 5998.8 5998.9 5928.9 5955.5 5977.7 5980.9 5985.7 5835.7 5973.5 6026.3 6029.6 6057.5 4552.3 4572.0 4582.6 4593.1 4626.3 4038.5 4106.2 4111.2 4114.1 4133.7 5564.0 5655.5 5707.7 5710.6 5799.7 5986.3 6036.6 6037.0 6054.1 6058.4 5610.9 5739.3 5758.2 5762.1 5772.5 5066.5 5077.5 5136.6 5150.9 5170.9 6317.8 6360.9 6365.2 6366.6 6368.9 5855.3 5939.1 6030.8 6040.1 6044.5 6256.3 6271.9 6313.0 6313.0 6313.8 5911.0 5922.6 5944.6 5971.9 6001.8 5820.6 6000.0 6015.8 6033.2 6081.8 5812.0 5820.6 5821.0 5873.4 5873.9 5753.2 5810.4 5842.7 5851.6 5853.4 5521.2 5692.1 5763.9 5812.4 5858.3 5748.3 5753.4 5768.0 5780.9 5782.9 5640.0 5643.8 5648.9 5654.7 5683.2 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | [#1] ext.html Cycles:180 Average:60991.91 Median:43269.39 stddev:122109.66 (282.2%) stddev-sans-first:122368.20 10:51:01 INFO - PROCESS | 28719 | Values: 665.8 684.1 684.2 733.4 748.0 33812.7 34685.8 43398.8 44387.3 44599.8 46902.0 47366.8 47578.0 47621.3 47657.8 8867.5 9004.1 9020.0 9022.2 9046.6 8783.6 8826.7 8829.6 8846.2 8854.4 8900.7 8908.0 8943.8 8946.9 8974.3 8927.4 8944.0 8946.2 8967.6 9009.8 8840.0 8893.1 8917.0 8937.9 8968.2 44476.0 44732.3 45124.8 45167.0 45266.0 3878.6 3879.6 3971.2 3976.4 4212.7 34124.5 34690.7 35043.5 35157.0 35276.3 4634.3 4676.7 4754.8 4757.1 4783.5 328189.0 330112.0 331156.0 332743.3 333795.0 39250.4 64663.0 65424.7 65632.3 65735.3 37435.3 37676.6 37763.8 37949.2 37961.0 16682.2 16846.4 16867.7 16891.7 16942.8 14420.3 14424.1 14439.9 14462.3 14491.2 9229.8 9279.4 9308.4 9349.6 9424.2 3511.9 3660.9 3663.2 3682.6 3689.6 1120.9 1122.7 1131.4 1136.7 1224.3 33641.5 33778.3 33959.5 34163.8 34515.1 1232.7 1251.3 1287.3 1312.0 1328.6 17520.4 17558.9 17571.7 17722.4 17840.6 497211.0 569040.0 572964.0 582421.0 591772.0 57676.1 58681.4 58743.7 58862.7 59047.0 1473.7 1571.2 1573.8 1584.1 1600.1 31134.0 31421.2 32664.7 34508.5 34958.0 55749.7 56472.0 56680.7 56683.0 56738.7 450958.0 452233.0 455543.0 455723.0 456095.0 31241.7 31292.0 31351.4 31573.0 31690.8 50633.2 50980.0 51139.7 51474.5 51798.7 42902.4 43133.8 43253.0 43527.3 44285.8 40799.2 42071.0 42649.6 42906.0 43719.6 43246.1 43285.8 44329.1 44489.8 44550.6 36353.3 37890.0 37931.4 38640.0 38926.6 29239.7 29614.0 30277.2 30459.0 30694.4 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | [#2] jquery.html Cycles:180 Average:31939.19 Median:26657.47 stddev:86729.76 (325.3%) stddev-sans-first:86940.76 10:51:01 INFO - PROCESS | 28719 | Values: 414.2 418.7 428.2 433.7 435.7 12066.9 12584.9 19106.4 19754.6 19803.1 20822.1 20952.7 21136.3 21303.6 21338.0 5878.4 6493.2 6791.3 6799.7 6821.5 6651.9 6695.5 6698.3 6717.6 6761.7 6550.1 6675.8 6720.3 6730.8 6741.5 6456.4 6635.3 6671.4 6675.6 6692.9 6525.0 6529.6 6542.5 6546.4 6551.5 26213.9 26286.2 26354.2 26501.2 26813.7 2544.8 2637.9 2749.0 2811.9 2900.3 15772.7 15868.6 16109.2 16481.8 17083.2 2137.9 2175.6 2178.4 2254.2 2300.1 95652.0 96404.0 96504.5 96915.5 97271.0 17448.5 18876.4 18950.5 18985.5 19107.0 33659.0 33701.3 34023.6 34300.5 34325.5 10962.5 11081.5 11140.1 11202.2 11276.2 9358.5 9368.2 9381.0 9488.0 9493.3 9298.7 9298.9 9357.2 9376.2 9442.7 3707.9 3785.5 3820.4 3834.3 3968.4 971.7 1130.0 1139.5 1166.4 1204.4 18353.3 18483.4 18586.6 19093.3 19235.4 1078.1 1083.5 1085.9 1111.1 1111.8 10476.6 10758.2 10808.5 10818.7 10869.1 513710.0 517148.0 530258.0 536144.0 537174.0 77100.6 86872.0 90584.0 93401.5 102501.0 1157.4 1162.3 1165.0 1196.7 1215.9 17522.8 17537.4 17553.0 17954.6 18061.0 40062.6 40247.0 40669.2 40765.6 40994.6 58221.5 61351.4 61435.4 61686.4 61849.4 9038.1 9066.7 9178.4 9212.9 9324.9 13115.0 13991.1 13994.0 14070.7 14156.4 11342.8 11393.3 11522.2 11691.8 11857.7 11359.1 11455.3 11693.7 11698.8 11698.8 12077.7 12098.8 12131.5 12133.0 12427.4 8384.0 8412.3 8543.0 8558.9 8625.9 11091.5 12147.6 12233.8 12280.3 12284.2 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | [#3] mootools.html Cycles:180 Average:5701.32 Median:5113.23 stddev:3069.72 (60.0%) stddev-sans-first:3062.90 10:51:01 INFO - PROCESS | 28719 | Values: 1606.5 1608.4 1850.0 1917.1 1925.4 7515.5 8283.1 8297.8 8413.1 8457.9 8283.8 8344.7 8444.0 8512.3 8569.1 2428.5 2445.3 2459.6 2465.1 2466.0 2431.6 2459.8 2462.6 2463.9 2468.6 2402.7 2403.4 2418.6 2423.8 2433.7 2434.4 2435.2 2439.2 2451.0 2460.0 2452.2 2460.1 2461.2 2474.5 2477.9 8648.8 8649.6 8671.3 8686.2 8706.3 5298.6 5395.4 5461.5 5472.9 5473.5 3473.2 3523.3 3538.5 3632.9 3708.5 1217.4 1229.0 1236.2 1254.6 1259.5 11804.1 11884.8 11909.8 11976.8 12002.4 4386.8 4388.7 4466.2 4466.7 4476.8 9737.7 9741.4 9754.2 9763.9 9779.9 5130.0 5159.2 5174.8 5175.0 5192.1 4314.4 4787.8 4816.9 4819.7 4867.3 3895.3 3903.6 4008.0 4094.3 4106.1 1205.3 1240.1 1243.8 1249.1 1249.7 1085.7 1098.0 1100.4 1101.3 1105.8 5909.7 6089.5 6215.9 6216.3 6234.8 1036.9 1054.5 1076.0 1081.5 1118.8 4291.0 4296.7 4303.7 4311.2 4313.4 10142.8 10378.1 10454.4 10473.2 10505.2 10203.9 10204.0 10509.2 10580.3 10617.1 7922.2 8009.9 8053.0 8135.3 8141.9 5845.9 6019.6 6028.8 6174.1 6214.4 9283.3 9303.7 9378.7 9459.0 9480.6 9414.6 9543.7 9552.7 9568.8 9922.5 7237.3 7472.5 7477.2 7521.5 7686.3 8062.5 8140.7 8147.8 8242.4 8295.6 7217.9 7234.3 7301.0 7409.8 7442.1 7453.3 7550.2 7574.2 7599.8 7624.8 6932.4 6983.9 6986.5 7001.6 7016.8 5103.9 5122.5 5237.7 5361.6 5379.5 5139.4 5142.5 5146.5 5222.2 5290.2 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | [#4] prototype.html Cycles:180 Average:5691.26 Median:6493.88 stddev:1743.80 (26.9%) stddev-sans-first:1701.87 10:51:01 INFO - PROCESS | 28719 | Values: 343.6 351.1 356.8 358.7 359.7 6293.0 6353.7 6442.6 6448.2 6452.3 6351.4 6355.7 6376.9 6431.0 6482.1 4880.2 4881.7 4881.9 4882.0 4894.3 4880.4 4894.5 4899.1 4900.7 4910.6 4855.9 4856.9 4859.0 4876.7 4879.6 4675.8 4859.2 4861.2 4874.3 4878.8 4211.6 4223.2 4228.1 4232.3 4236.4 6184.5 6187.5 6189.4 6195.9 6208.3 5646.5 5650.7 5659.2 5660.4 5664.3 6759.4 6790.2 6796.5 6797.3 6802.5 4626.4 4710.8 4715.2 4715.5 4723.1 6858.2 6977.7 6980.8 6991.1 6992.6 4690.2 4729.3 4730.5 4731.3 4733.0 4766.1 4793.7 4796.8 4803.8 4805.6 5514.6 5536.1 5561.2 5563.5 5572.3 6577.0 6677.3 6712.3 6741.5 6742.2 1673.0 1707.6 1710.0 1712.2 1714.0 1097.5 1109.5 1121.2 1126.3 1127.5 6461.4 6590.3 6594.0 6594.6 6596.2 6944.0 7000.0 7002.5 7041.8 7062.4 6627.1 6629.0 6633.8 6637.8 6650.3 3746.6 3774.9 3798.3 3807.8 3814.4 7323.3 7522.2 7565.8 7571.6 7572.3 7168.2 7174.6 7197.2 7198.2 7233.4 7416.8 7432.1 7451.4 7451.6 7467.5 7029.6 7034.6 7038.5 7042.3 7044.8 6782.1 6971.5 7007.4 7009.8 7018.4 7425.5 7439.0 7471.3 7479.7 7493.6 4656.1 4690.4 4699.8 4700.3 4710.5 7010.3 7021.0 7024.6 7038.2 7040.3 6705.3 6818.0 6832.6 6847.4 6850.4 6775.3 6824.1 6824.2 6842.8 6848.9 6678.4 6703.8 6713.6 6731.0 6734.4 6829.4 6845.8 6865.2 6880.4 6889.3 6505.7 6554.0 6667.6 6687.5 6705.9 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - PROCESS | 28719 | [#5] yui.html Cycles:180 Average:15802.44 Median:4629.02 stddev:18441.61 (398.4%) stddev-sans-first:18459.19 10:51:01 INFO - PROCESS | 28719 | Values: 854.9 906.7 943.5 960.3 972.4 14288.4 14451.9 14474.1 14520.1 14526.6 14473.9 15298.1 15298.2 15315.2 15320.1 892.9 906.2 911.7 923.5 928.0 924.7 928.2 929.2 932.9 933.5 970.6 972.2 976.5 977.1 980.6 963.2 963.4 966.4 966.8 967.5 712.3 712.5 713.0 714.6 716.5 15643.0 15644.8 15656.4 15665.7 15716.8 14725.4 14975.0 15059.9 15070.7 15095.8 11961.2 11976.3 12016.4 12255.1 12372.3 3937.8 3942.5 3994.2 4071.9 4122.8 58497.7 58753.0 58914.4 58969.4 59306.4 11566.4 11696.4 11793.0 11809.2 11907.3 20752.8 20792.4 20816.9 20872.9 20903.7 8508.4 8593.4 8634.6 8727.8 8913.6 5094.4 5100.2 5156.8 5201.2 5205.4 3731.6 3778.2 3785.8 3786.1 3804.4 690.7 702.4 706.6 710.8 712.4 740.6 749.4 767.7 806.4 831.1 9901.0 10145.3 10351.6 10423.8 10568.2 760.4 777.5 836.9 839.2 860.3 4071.5 4610.7 4647.3 4713.3 4748.9 64475.0 66479.7 66502.3 66788.7 66875.0 55680.4 56615.2 57452.4 57473.0 59374.4 52731.5 54190.5 54533.5 55387.4 55471.7 9297.2 9334.2 9356.9 9373.2 9456.1 39560.8 39752.2 39801.0 40189.2 40653.4 46470.3 47878.3 50666.7 51415.5 51588.5 11599.8 11621.7 11744.6 11835.3 11948.7 13054.3 13126.1 13250.5 13481.2 13645.9 12078.5 12288.7 12349.2 12554.9 12653.9 12416.3 12476.3 12572.3 12730.0 12828.7 12339.8 12386.7 12495.8 12568.2 12786.4 10409.8 10564.8 10566.4 10602.8 10944.7 10367.4 10682.4 10790.5 10878.2 10933.8 10:51:01 INFO - PROCESS | 28719 | -------- Summary: end -------- 10:51:01 INFO - PROCESS | 28719 | 10:51:01 INFO - TEST-INFO | 28719: exit 0 10:51:01 INFO - TEST-OK | dromaeo_css | took 1108035ms 10:51:01 INFO - TEST-START | kraken 10:51:01 INFO - operating with platform_type : linux_ 10:51:01 INFO - Initialising browser for kraken test... 10:51:01 INFO - TEST-INFO | started process 28962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPxxYJZ/profile http://localhost:33510/getInfo.html) 10:51:05 INFO - PROCESS | 28962 | 10:51:05 INFO - PROCESS | 28962 | (process:29040): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:51:05 INFO - PROCESS | 28962 | __metrics Screen width/height:1600/1200 10:51:05 INFO - PROCESS | 28962 | colorDepth:24 10:51:05 INFO - PROCESS | 28962 | Browser inner width/height: 1024/697 10:51:05 INFO - PROCESS | 28962 | __metrics 10:51:06 ERROR - PROCESS | 28962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:51:07 INFO - TEST-INFO | 28962: exit 0 10:51:07 INFO - Browser initialized. 10:51:07 INFO - Running cycle 1/1 for kraken test... 10:51:07 INFO - TEST-INFO | started process 29090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPxxYJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:09 INFO - PROCESS | 29090 | 10:51:09 INFO - PROCESS | 29090 | (process:29159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:51:19 INFO - PROCESS | 29090 | RSS: Main: 150908928 10:51:19 INFO - PROCESS | 29090 | 10:51:21 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:22 INFO - PROCESS | 29090 | RSS: Main: 155918336 10:51:22 INFO - PROCESS | 29090 | 10:51:25 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-dft) 10:51:25 INFO - PROCESS | 29090 | RSS: Main: 155869184 10:51:25 INFO - PROCESS | 29090 | 10:51:28 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-fft) 10:51:29 INFO - PROCESS | 29090 | RSS: Main: 155762688 10:51:29 INFO - PROCESS | 29090 | 10:51:31 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-oscillator) 10:51:31 INFO - PROCESS | 29090 | RSS: Main: 155512832 10:51:31 INFO - PROCESS | 29090 | 10:51:33 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:34 INFO - PROCESS | 29090 | RSS: Main: 155942912 10:51:34 INFO - PROCESS | 29090 | 10:51:37 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33510/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:38 INFO - PROCESS | 29090 | RSS: Main: 156434432 10:51:38 INFO - PROCESS | 29090 | 10:51:41 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33510/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:42 INFO - PROCESS | 29090 | RSS: Main: 156487680 10:51:42 INFO - PROCESS | 29090 | 10:51:44 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33510/tests/kraken/driver.html?testName=json-parse-financial) 10:51:45 INFO - PROCESS | 29090 | RSS: Main: 156397568 10:51:45 INFO - PROCESS | 29090 | 10:51:47 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:47 INFO - PROCESS | 29090 | RSS: Main: 156336128 10:51:47 INFO - PROCESS | 29090 | 10:51:49 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:49 INFO - PROCESS | 29090 | RSS: Main: 156876800 10:51:49 INFO - PROCESS | 29090 | 10:51:51 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:52 INFO - PROCESS | 29090 | RSS: Main: 156442624 10:51:52 INFO - PROCESS | 29090 | 10:51:55 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:55 INFO - PROCESS | 29090 | RSS: Main: 156921856 10:51:55 INFO - PROCESS | 29090 | 10:51:58 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:58 INFO - PROCESS | 29090 | RSS: Main: 156823552 10:51:58 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33510/tests/kraken/driver.html?testName=ai-astar) 10:52:00 INFO - PROCESS | 29090 | RSS: Main: 158302208 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | __start_tp_report 10:52:00 INFO - PROCESS | 29090 | _x_x_mozilla_page_load 10:52:00 INFO - PROCESS | 29090 | _x_x_mozilla_page_load_details 10:52:00 INFO - PROCESS | 29090 | |i|pagename|runs| 10:52:00 INFO - PROCESS | 29090 | |0;ai-astar;110;112;104;110;110;110;101;111;109;110 10:52:00 INFO - PROCESS | 29090 | |1;audio-beat-detection;157;132;159;180;136;163;157;128;178;127 10:52:00 INFO - PROCESS | 29090 | |2;audio-dft;163;163;161;164;161;162;163;163;163;161 10:52:00 INFO - PROCESS | 29090 | |3;audio-fft;73;73;78;166;75;77;76;74;163;74 10:52:00 INFO - PROCESS | 29090 | |4;audio-oscillator;91;91;150;92;92;91;138;92;92;151 10:52:00 INFO - PROCESS | 29090 | |5;imaging-gaussian-blur;117;116;118;118;118;117;118;117;117;117 10:52:00 INFO - PROCESS | 29090 | |6;imaging-darkroom;147;146;146;147;148;146;146;147;148;146 10:52:00 INFO - PROCESS | 29090 | |7;imaging-desaturate;95;95;94;96;95;95;96;95;95;95 10:52:00 INFO - PROCESS | 29090 | |8;json-parse-financial;54;56;56;53;53;55;56;80;57;53 10:52:00 INFO - PROCESS | 29090 | |9;json-stringify-tinderbox;59;59;58;58;58;59;59;58;59;58 10:52:00 INFO - PROCESS | 29090 | |10;stanford-crypto-aes;72;74;73;74;76;74;73;73;73;73 10:52:00 INFO - PROCESS | 29090 | |11;stanford-crypto-ccm;117;123;120;114;113;115;123;115;134;127 10:52:00 INFO - PROCESS | 29090 | |12;stanford-crypto-pbkdf2;158;162;164;163;160;159;158;161;159;158 10:52:00 INFO - PROCESS | 29090 | |13;stanford-crypto-sha256-iterative;68;69;66;69;67;64;69;65;65;66 10:52:00 INFO - PROCESS | 29090 | __end_tp_report 10:52:00 INFO - PROCESS | 29090 | __start_cc_report 10:52:00 INFO - PROCESS | 29090 | _x_x_mozilla_cycle_collect,860 10:52:00 INFO - PROCESS | 29090 | __end_cc_report 10:52:00 INFO - PROCESS | 29090 | __startTimestamp1467827520896__endTimestamp 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | ------- Summary: start ------- 10:52:00 INFO - PROCESS | 29090 | Number of tests: 14 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.43 (3.1%) stddev-sans-first:3.61 10:52:00 INFO - PROCESS | 29090 | Values: 110.0 112.0 104.0 110.0 110.0 110.0 101.0 111.0 109.0 110.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.00 stddev:19.82 (12.5%) stddev-sans-first:20.93 10:52:00 INFO - PROCESS | 29090 | Values: 157.0 132.0 159.0 180.0 136.0 163.0 157.0 128.0 178.0 127.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 10:52:00 INFO - PROCESS | 29090 | Values: 163.0 163.0 161.0 164.0 161.0 162.0 163.0 163.0 163.0 161.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.50 stddev:37.78 (50.7%) stddev-sans-first:39.38 10:52:00 INFO - PROCESS | 29090 | Values: 73.0 73.0 78.0 166.0 75.0 77.0 76.0 74.0 163.0 74.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:91.50 stddev:26.67 (29.2%) stddev-sans-first:27.57 10:52:00 INFO - PROCESS | 29090 | Values: 91.0 91.0 150.0 92.0 92.0 91.0 138.0 92.0 92.0 151.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:52:00 INFO - PROCESS | 29090 | Values: 117.0 116.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:52:00 INFO - PROCESS | 29090 | Values: 147.0 146.0 146.0 147.0 148.0 146.0 146.0 147.0 148.0 146.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:52:00 INFO - PROCESS | 29090 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.00 stddev:8.11 (14.5%) stddev-sans-first:8.51 10:52:00 INFO - PROCESS | 29090 | Values: 54.0 56.0 56.0 53.0 53.0 55.0 56.0 80.0 57.0 53.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:52:00 INFO - PROCESS | 29090 | Values: 59.0 59.0 58.0 58.0 58.0 59.0 59.0 58.0 59.0 58.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.50 stddev:1.08 (1.5%) stddev-sans-first:1.00 10:52:00 INFO - PROCESS | 29090 | Values: 72.0 74.0 73.0 74.0 76.0 74.0 73.0 73.0 73.0 73.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:121.50 stddev:6.72 (5.5%) stddev-sans-first:7.04 10:52:00 INFO - PROCESS | 29090 | Values: 117.0 123.0 120.0 114.0 113.0 115.0 123.0 115.0 134.0 127.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:2.20 (1.4%) stddev-sans-first:2.19 10:52:00 INFO - PROCESS | 29090 | Values: 158.0 162.0 164.0 163.0 160.0 159.0 158.0 161.0 159.0 158.0 10:52:00 INFO - PROCESS | 29090 | 10:52:00 INFO - PROCESS | 29090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.87 (2.8%) stddev-sans-first:1.94 10:52:00 INFO - PROCESS | 29090 | Values: 68.0 69.0 66.0 69.0 67.0 64.0 69.0 65.0 65.0 66.0 10:52:00 INFO - PROCESS | 29090 | -------- Summary: end -------- 10:52:00 INFO - PROCESS | 29090 | 10:52:01 INFO - TEST-INFO | 29090: exit 0 10:52:01 INFO - TEST-OK | kraken | took 59903ms 10:52:01 INFO - SUITE-END | took 1167s 10:52:02 INFO - Completed test suite (00:19:28) 10:52:02 INFO - javascript benchmark 10:52:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.4080865444216, 3388.1190890368503, 3398.456247000477, 3436.707879830214, 3445.793252404856, 5565.193047008182, 5589.273394458724, 5622.943770562288, 5624.437556244384, 5651.180578816069, 5521.089020311654, 5598.440155984399, 5630.268065151535, 5632.859178520539, 5640.435956404358, 5062.544371006608, 5122.359705036871, 5130.230465430178, 5149.485051494858, 5169.198774190007, 5037.24441333801, 5096.694198348111, 5220.765065572039, 5244.895102097956, 5268.473152684739, 5088.821891233808, 5124.769385377648, 5164.535191832734, 5169.483051694838, 5181.326427564431, 5151.201563757623, 5155.226715992593, 5170.948290517084, 5173.844784656466, 5201.635885488017, 4944.456109827916, 4953.975230123862, 5064.088464076464, 5083.161278389061, 5144.176931690911, 5298.046351656701, 5321.467853214686, 5336.91994620081, 5338.252644629755, 5373.919391209135, 5822.214001109881, 5824.970875145639, 5851.912221316684, 5874.853128671774, 5884.264466941632, 5801.622894511843, 5853.151293062525, 5877.67672777997, 5927.2590926134235, 5936.0, 5607.803726869581, 5615.46653067962, 5620.662760234399, 5634.352049514277, 5640.210370548127, 6089.969550152309, 6113.388661133851, 6113.541484388688, 6116.296625887991, 6135.355787642323, 5629.24005259293, 5834.591578589543, 5876.588638795243, 5884.146798714162, 5948.375420580864, 5966.284045914518, 5982.820515384546, 5993.220881285492, 5998.820035398945, 5998.940010599838, 5928.851778705567, 5955.464008239279, 5977.731002104829, 5980.910286345708, 5985.730642121115, 5835.67903765297, 5973.462388385066, 6026.337102918676, 6029.577929544977, 6057.485113765291, 4552.294394368878, 4571.954280457219, 4582.610478109332, 4593.127305811885, 4626.329182268552, 4038.4749982502676, 4106.2198182345255, 4111.239420707178, 4114.074333275049, 4133.6693064554765, 5564.0, 5655.491005809415, 5707.6575405475805, 5710.600257981984, 5799.652020878761, 5986.2517185351835, 6036.637801731822, 6037.0, 6054.122152287893, 6058.363871793486, 5610.85972850682, 5739.282589676291, 5758.165066065397, 5762.078067509178, 5772.538196944234, 5066.46802085783, 5077.543021128043, 5136.640435169577, 5150.8969820604125, 5170.922436163461, 6317.778877739257, 6360.936390636034, 6365.2361716594305, 6366.6180029198395, 6368.872622547523, 5855.2973643163095, 5939.07944268639, 6030.7889223876955, 6040.063790112539, 6044.516438684983, 6256.311805701278, 6271.874562508816, 6312.968435157794, 6313.0, 6313.779017734358, 5911.0, 5922.585419020627, 5944.609987742087, 5971.850703732268, 6001.789937352171, 5820.592558520862, 6000.039993601003, 6015.819525414245, 6033.245844269466, 6081.817545473643, 5811.970940145272, 5820.592558520862, 5821.0, 5873.353931067664, 5873.9412605873395, 5753.1945527627, 5810.360860305447, 5842.737076831468, 5851.590388672752, 5853.414658534112, 5521.199426083115, 5692.089265717631, 5763.9135412968, 5812.418758124154, 5858.326292476419, 5748.310202775527, 5753.367129615655, 5768.048272035067, 5780.855478613068, 5782.855428614318, 5640.041192997118, 5643.802466913638, 5648.858778530405, 5654.660720356792, 5683.175939488834], "value": 5520.687070613793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.8035879415572, 684.110656147009, 684.2063206680245, 733.3729661139726, 748.0200936772828, 33812.66187338126, 34685.82657086714, 43398.78300608497, 44387.334189987094, 44599.77700111503, 46902.0, 47366.76316618412, 47578.0, 47621.28568071482, 47657.76171119139, 8867.467951922888, 9004.099590040976, 9019.95490022549, 9022.188003079722, 9046.592903319366, 8783.560821958876, 8826.735197944072, 8829.55852207387, 8846.24806891415, 8854.380193386465, 8900.73297801067, 8907.955460222689, 8943.776405589848, 8946.910530894706, 8974.28205743539, 8927.375083744108, 8943.955280223623, 8946.23956963659, 8967.596458159365, 9009.819803603892, 8840.0, 8893.11068893112, 8917.019127895926, 8937.910620893774, 8968.237699795525, 44476.0, 44732.3290150648, 45124.77437612824, 45167.0, 45266.0, 3878.5927477614728, 3879.6120387960977, 3971.205758848242, 3976.383660532622, 4212.662986961066, 34124.48813267803, 34690.653093468994, 35043.4743478848, 35157.0, 35276.29447411063, 4634.328022436762, 4676.672632915697, 4754.833580824655, 4757.096151731194, 4783.521647835223, 328189.0, 330112.0, 331156.0, 332743.33628331946, 333795.0, 39250.41124383137, 64663.0, 65424.672876636265, 65632.34367656262, 65735.34264657387, 37435.25129497449, 37676.623233767314, 37763.81118094392, 37949.24101517954, 37961.0, 16682.249298781582, 16846.410375636795, 16867.662646746998, 16891.662166756843, 16942.830571694372, 14420.278986050866, 14424.134551926918, 14439.92780036093, 14462.349194286282, 14491.20298383578, 9229.815403691888, 9279.396839205565, 9308.441493510276, 9349.579268932914, 9424.198943089914, 3511.9297614048087, 3660.9450858237146, 3663.168415792104, 3682.6133256007734, 3689.594144644087, 1120.910327173824, 1122.6575894352302, 1131.3538801044624, 1136.720248265282, 1224.3266203588169, 33641.4618840338, 33778.32443351119, 33959.4906076409, 34163.829180853936, 34515.13712157216, 1232.6548566401423, 1251.3492983648453, 1287.2726909296218, 1311.9868801311866, 1328.634625477982, 17520.38678646241, 17558.91220543915, 17571.73642395365, 17722.379716709853, 17840.643187136186, 497211.0, 569040.0, 572964.0, 582421.0, 591772.0, 57676.134857977166, 58681.41318586845, 58743.706281468316, 58862.705686471294, 59047.0, 1473.7347277490155, 1571.2065406969407, 1573.8268790433044, 1584.1208129488246, 1600.0639625819026, 31134.0, 31421.214469638442, 32664.673353266164, 34508.48237276392, 34958.0, 55749.72125139349, 56472.0, 56680.71659641675, 56683.0, 56738.716306419854, 450958.0, 452233.0, 455543.0, 455723.0, 456095.0, 31241.68758312388, 31292.0, 31351.372972539964, 31573.0, 31690.841545793046, 50633.240501391774, 50980.0, 51139.744301279745, 51474.48525514697, 51798.741006294724, 42902.356464653676, 43133.784331078146, 43253.0, 43527.25890964326, 44285.77857110694, 40799.18401631891, 42071.0, 42649.5735042658, 42906.0, 43719.56280437282, 43246.13507729891, 43285.78357108194, 44329.11341773211, 44489.777551112034, 44550.55449445464, 36353.27293454169, 37890.0, 37931.43102853404, 38640.03399915025, 38926.610733892296, 29239.7076029237, 29614.0, 30277.202485264326, 30459.0, 30694.38611227718], "value": 20081.512656054125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.23573506879796, 418.6901692747368, 428.15866821695363, 433.6509110166316, 435.71678409034126, 12066.879331206685, 12584.874151258484, 19106.42680719579, 19754.604907901834, 19803.108860101274, 20822.063007164677, 20952.685709714366, 21136.260230891923, 21303.57392852142, 21338.039788209528, 5878.41215878413, 6493.220813502375, 6791.3208679132185, 6799.7280108795585, 6821.4542836572955, 6651.933480665204, 6695.464362850985, 6698.263191048981, 6717.563358381714, 6761.661916904135, 6550.11573437587, 6675.7997260082275, 6720.294369091248, 6730.798076057726, 6741.494387920901, 6456.354364563553, 6635.270120286765, 6671.399574038335, 6675.566088204299, 6692.9330706693045, 6525.0212468129685, 6529.5755775874895, 6542.542022058457, 6546.44355229806, 6551.541392102555, 26213.868930655415, 26286.21141365762, 26354.20937371882, 26501.204963851116, 26813.731862681514, 2544.75824796644, 2637.8549179795104, 2748.9862550687117, 2811.9437611247863, 2900.303927057491, 15772.684546309125, 15868.603284917854, 16109.19454027294, 16481.752773708406, 17083.231254593447, 2137.8717276963275, 2175.630142875715, 2178.3900507857825, 2254.222293308806, 2300.068472268734, 95652.043479565, 96404.0, 96504.51747741287, 96915.51542242314, 97271.0, 17448.47654570365, 18876.433706988813, 18950.52623684419, 18985.525361866064, 19107.044647767558, 33659.0, 33701.325973480394, 34023.63905443804, 34300.48549271763, 34325.485117723256, 10962.506687199095, 11081.501332440059, 11140.108791296676, 11202.159838012181, 11276.1542884284, 9358.532073396304, 9368.156865882103, 9381.0, 9487.952560237154, 9493.335466517416, 9298.72103836886, 9298.86051709225, 9357.20463760588, 9376.156145946898, 9442.669506567237, 3707.8516859325323, 3785.545734511876, 3820.426935959573, 3834.2714884172474, 3968.444417781513, 971.6647756523988, 1129.9661010169707, 1139.515705825021, 1166.422620802708, 1204.4278967490372, 18353.265869365077, 18483.353082642043, 18586.628267434848, 19093.331733389266, 19235.4229373119, 1078.0674716370283, 1083.5015892689294, 1085.913126949842, 1111.0944580167138, 1111.8443417921496, 10476.580936762444, 10758.24692271549, 10808.51361688726, 10818.729531761612, 10869.076128529005, 513710.0, 517148.0, 530258.0, 536144.0, 537174.0, 77100.61449692716, 86872.0, 90584.0, 93401.53299233597, 102501.0, 1157.438642258504, 1162.3084264862393, 1165.0, 1196.6709154982275, 1215.9148859579745, 17522.82477175212, 17537.386191483747, 17553.0, 17954.64090718152, 18061.0, 40062.599374005884, 40247.0, 40669.1866162681, 40765.592344076176, 40994.59005409908, 58221.5444613888, 61351.386486134565, 61435.38564614476, 61686.383136168064, 61849.38150618436, 9038.114878934442, 9066.682666106919, 9178.357514974155, 9212.907870921474, 9324.860127098234, 13115.0, 13991.090579112732, 13994.020418570602, 14070.718585628434, 14156.433742650179, 11342.829857552308, 11393.316401015965, 11522.193446458667, 11691.766164676828, 11857.703557411134, 11359.148063895405, 11455.255408398427, 11693.707657308636, 11698.76602467963, 11698.824517632072, 12077.698057548632, 12098.818517722066, 12131.514739410677, 12132.968697660797, 12427.44076516541, 8383.95200599925, 8412.284955778583, 8542.957285213533, 8558.871616925875, 8625.91374086251, 11091.544904444481, 12147.635570932885, 12233.816492752794, 12280.263184208976, 12284.201526900722], "value": 10774.311455735222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1606.4698649445681, 1608.4048901906292, 1850.0, 1917.1372882203011, 1925.4416219296395, 7515.511491753045, 8283.088860225385, 8297.751067467978, 8413.074561798197, 8457.900472938525, 8283.751487455385, 8344.666213351458, 8444.028936672285, 8512.27645650119, 8569.057403685589, 2428.4900170964074, 2445.303088619744, 2459.56957532432, 2465.1125594785863, 2465.963010554843, 2431.6170053609276, 2459.8155138364605, 2462.642916777066, 2463.88912498938, 2468.5803413419762, 2402.723686776017, 2403.4351927297157, 2418.5646583614944, 2423.8060955123638, 2433.744456832034, 2434.379233295516, 2435.1842132885504, 2439.231642032763, 2451.031842422251, 2460.0405841721745, 2452.1785201957364, 2460.0651752333997, 2461.212412028152, 2474.5174690935273, 2477.925662230136, 8648.827023459495, 8649.610767515476, 8671.349648776368, 8686.218240358336, 8706.259967902735, 5298.576113910916, 5395.433479484676, 5461.481159289861, 5472.945270547283, 5473.507384335389, 3473.235888104613, 3523.312953973976, 3538.486919396699, 3632.891013269606, 3708.5364329458816, 1217.3791366403198, 1228.9508419663202, 1236.1779416687891, 1254.6047994881674, 1259.5465632372338, 11804.055675545937, 11884.821727674092, 11909.761804763943, 11976.760464790743, 12002.399880005965, 4386.824527018947, 4388.714733542373, 4466.218411777926, 4466.687331886802, 4476.753778542212, 9737.707868763948, 9741.366811157252, 9754.170895473964, 9763.90236097644, 9779.85330220033, 5130.0, 5159.2003239497935, 5174.793008279702, 5175.042617115846, 5192.1173400522, 4314.374415709704, 4787.832425865078, 4816.8554943351755, 4819.6867203632355, 4867.342908707279, 3895.337792575269, 3903.5706072332023, 4007.959920400817, 4094.28350038742, 4106.07613287014, 1205.318994767971, 1240.0637518673343, 1243.8383010208615, 1249.1131296779206, 1249.7188132670258, 1085.6742977106837, 1097.9725506862233, 1100.3782862682558, 1101.2841652925501, 1105.8396532502902, 5909.674967876808, 6089.451949324582, 6215.906761398583, 6216.285127210338, 6234.844128896723, 1036.8548403223556, 1054.4674939155677, 1075.983860242097, 1081.4538657977828, 1118.8098023336051, 4290.957090429119, 4296.656267498593, 4303.677224208197, 4311.1808756336195, 4313.439252897166, 10142.847857282146, 10378.06597406237, 10454.425006624557, 10473.214508911862, 10505.159587233004, 10203.94898025505, 10204.0, 10509.211809114347, 10580.312279701795, 10617.097546708615, 7922.168172341821, 8009.919900801034, 8053.0, 8135.267825895816, 8141.877871831927, 5845.912311315419, 6019.578629495893, 6028.849278768066, 6174.104754810617, 6214.4407003369915, 9283.257339412965, 9303.72088837336, 9378.67174648884, 9459.006804285726, 9480.620775168916, 9414.57634406467, 9543.713688589354, 9552.665656701982, 9568.808623827623, 9922.454265015205, 7237.276272372721, 7472.476926615085, 7477.177510473734, 7521.5111017783665, 7686.346660533917, 8062.475939064177, 8140.715074972348, 8147.75556733299, 8242.381821363302, 8295.585220738818, 7217.927820721726, 7234.276572342934, 7300.96349518249, 7409.777706668809, 7442.1441534222095, 7453.25467453272, 7550.207228240955, 7574.242575742382, 7599.848003039798, 7624.8475030500185, 6932.376086152069, 6983.930160698328, 6986.510944234058, 7001.649917504003, 7016.789496315118, 5103.948960510347, 5122.513361230677, 5237.685738855681, 5361.597880159082, 5379.515843574097, 5139.383274007143, 5142.460041695568, 5146.459621739664, 5222.190560463135, 5290.1800220965815], "value": 4679.156458545454, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.59970634211146, 351.0906751513579, 356.791277102895, 358.6753987641184, 359.6673077403402, 6292.968535157329, 6353.682315884211, 6442.581232219908, 6448.226212854458, 6452.3225061368585, 6351.396617321347, 6355.650439225841, 6376.9362306376925, 6430.96784516078, 6482.092507049017, 4880.219164933611, 4881.707097574148, 4881.8779530511665, 4881.975590122044, 4894.2903279024695, 4880.389951256093, 4894.535019173173, 4899.118158731427, 4900.681455705386, 4910.582600478963, 4855.878603034935, 4856.927146092811, 4858.975705121487, 4876.658633895629, 4879.56083952446, 4675.812967481296, 4859.173940430118, 4861.246506791471, 4874.293227481995, 4878.780454879521, 4211.620954114144, 4223.176480586287, 4228.090960443519, 4232.32282834748, 4236.364545318196, 6184.536159787989, 6187.504999600066, 6189.38106189382, 6195.87608247837, 6208.255009398856, 5646.520045796112, 5650.7174641267775, 5659.207710920475, 5660.405657405954, 5664.348599910981, 6759.425448836855, 6790.151231096113, 6796.490263230228, 6797.28628494006, 6802.523823332369, 4626.444826620794, 4710.764461776897, 4715.198416269242, 4715.457722361938, 4723.07899959508, 6858.211305699859, 6977.6511174441075, 6980.7905762827195, 6991.091158149459, 6992.580445173306, 4690.202665546865, 4729.266963620645, 4730.479647238801, 4731.266653668687, 4733.006068725606, 4766.142094422968, 4793.736344501016, 4796.8081276749235, 4803.831865884677, 4805.639577031737, 5514.641548299348, 5536.141898005815, 5561.221428999943, 5563.5271001964475, 5572.331320241597, 6576.967115164489, 6677.332266773381, 6712.295209003082, 6741.460683145337, 6742.157230346207, 1672.991635041817, 1707.581642497596, 1710.0252855872034, 1712.1695977450927, 1714.0487029698388, 1097.4896673046912, 1109.5284504085732, 1121.2319561100671, 1126.3298337489346, 1127.464454384161, 6461.418472337512, 6590.3080176581725, 6593.967030164818, 6594.637294948824, 6596.208454985336, 6944.0, 7000.0, 7002.544834585736, 7041.788746337618, 7062.364387205176, 6627.10534077903, 6628.966855165693, 6633.767818126343, 6637.800865974028, 6650.268470468244, 3746.569144548357, 3774.8867533974026, 3798.3163030654746, 3807.8476860925252, 3814.389697648363, 7323.340899319087, 7522.172561018284, 7565.810854728676, 7571.583562904093, 7572.318491335806, 7168.247334029852, 7174.605396703127, 7197.244289349647, 7198.244184360671, 7233.421326293884, 7416.814579635552, 7432.070991126109, 7451.366633836076, 7451.5901625411125, 7467.477276590586, 7029.61337126463, 7034.648267586703, 7038.507304488637, 7042.260562641054, 7044.823879403056, 6782.118324617768, 6971.5468494547695, 7007.369336759716, 7009.754658587129, 7018.438524918097, 7425.517341372793, 7438.962805185939, 7471.290227428385, 7479.663415146223, 7493.550386976799, 4656.138614356355, 4690.437147542317, 4699.835505757282, 4700.2949557566635, 4710.481846996896, 7010.334018268256, 7021.0, 7024.648767561704, 7038.225795162631, 7040.260772618802, 6705.2959439258175, 6818.0, 6832.624205668736, 6847.417969472651, 6850.38346548813, 6775.288594697486, 6824.112865327475, 6824.2152152503095, 6842.828929276808, 6848.863022739418, 6678.3989440950545, 6703.765368212089, 6713.63075030878, 6730.966345168439, 6734.393904548614, 6829.351211634887, 6845.794626161223, 6865.210500792473, 6880.380765731108, 6889.276625954403, 6505.674716264073, 6553.967230163818, 6667.566608170453, 6687.465002799861, 6705.8994115087335], "value": 5119.75605994771, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.9145085491448, 906.7461110888953, 943.4669411782343, 960.2653969713168, 972.3533849989752, 14288.428462861486, 14451.927740361283, 14474.059186152906, 14520.128792272471, 14526.564203073898, 14473.927630361834, 15298.082115073103, 15298.23508824557, 15315.157666328376, 15320.080795152271, 892.9151730585584, 906.1889608800103, 911.7492689510404, 923.529000209891, 927.972160835176, 924.7179610218881, 928.2295694573488, 929.1823195587873, 932.9346945713803, 933.4865823796919, 970.6457143142773, 972.2270794718181, 976.5361453309656, 977.081543349253, 980.5783513089368, 963.1716723617718, 963.3978763272954, 966.4442945306477, 966.8308046091976, 967.5404183013083, 712.273481049332, 712.4834494991142, 712.9714811407538, 714.6248219684655, 716.5342527357208, 15643.0, 15644.843551564452, 15656.373745050185, 15665.686686266325, 15716.842831571652, 14725.410983560645, 14974.951753377269, 15059.924700376429, 15070.698586028328, 15095.773563396559, 11961.162718609701, 11976.341301228429, 12016.399180041051, 12255.1421400502, 12372.329735485775, 3937.76373417593, 3942.546607140187, 3994.1612261424843, 4071.918561628751, 4122.835086596532, 58497.7075114626, 58753.0, 58914.41085589175, 58969.41030589682, 59306.40693593052, 11566.363849988164, 11696.35670038156, 11793.0, 11809.173357864867, 11907.285562866256, 20752.792472075085, 20792.37622871316, 20816.895915520327, 20872.895635521727, 20903.68644470334, 8508.404411691246, 8593.398462107718, 8634.568271586395, 8727.825443491094, 8913.598888050054, 5094.363204599425, 5100.2349647553165, 5156.793728250903, 5201.219817027476, 5205.427402985669, 3731.626837316301, 3778.1688028634208, 3785.8296376662565, 3786.091338078841, 3804.4483549885113, 690.7478770248923, 702.3748863511479, 706.5831159615851, 710.8045287545966, 712.3909057755544, 740.5852722475431, 749.4304328710219, 767.731294047079, 806.4475834053692, 831.098258389654, 9900.950495247622, 10145.289829711997, 10351.585936562604, 10423.843642345371, 10568.15454763617, 760.3916866506883, 777.4713195027435, 836.9117954746964, 839.1524560194126, 860.324645153564, 4071.531773845986, 4610.74640894754, 4647.3029045643425, 4713.34013238147, 4748.857534273978, 64475.0, 66479.66760166168, 66502.33497664961, 66788.6660566694, 66875.0, 55680.443195567525, 56615.150772738445, 57452.42547574554, 57473.0, 59374.40625593775, 52731.47268527265, 54190.45809541933, 54533.45466545363, 55387.44612553984, 55471.722641386536, 9297.209737172416, 9334.206592439446, 9356.859647105435, 9373.1564159226, 9456.101670341306, 39560.802195988836, 39752.20495590014, 39801.00497487586, 40189.19621607493, 40653.390199146445, 46470.30294545517, 47878.28182577334, 50666.74666626643, 51415.48584514107, 51588.48411515987, 11599.8260026098, 11621.709457263636, 11744.58893938708, 11835.349055802013, 11948.701282468008, 13054.282014489294, 13126.14680045794, 13250.536231231861, 13481.191128532319, 13645.931770341085, 12078.51685932553, 12288.68205584505, 12349.19730217533, 12554.937225313815, 12653.936730316289, 12416.317102559446, 12476.313802740573, 12572.30852303132, 12730.0, 12828.679283017998, 12339.75320493603, 12386.690332741753, 12495.750084998432, 12568.245905245714, 12786.360681965678, 10409.843852342372, 10564.841527376942, 10566.366018038942, 10602.840957385491, 10944.726381840199, 10367.429791361246, 10682.359058456517, 10790.460476976277, 10878.238523303293, 10933.83599246028], "value": 7243.549578565319, "unit": "score"}], "name": "dromaeo_css", "value": 7693.036696947516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 104.0, 110.0, 110.0, 110.0, 101.0, 111.0, 109.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 159.0, 180.0, 136.0, 163.0, 157.0, 128.0, 178.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 164.0, 161.0, 162.0, 163.0, 163.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 78.0, 166.0, 75.0, 77.0, 76.0, 74.0, 163.0, 74.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 150.0, 92.0, 92.0, 91.0, 138.0, 92.0, 92.0, 151.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 53.0, 53.0, 55.0, 56.0, 80.0, 57.0, 53.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 74.0, 76.0, 74.0, 73.0, 73.0, 73.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 123.0, 120.0, 114.0, 113.0, 115.0, 123.0, 115.0, 134.0, 127.0], "value": 120.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 164.0, 163.0, 160.0, 159.0, 158.0, 161.0, 159.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 69.0, 67.0, 64.0, 69.0, 65.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1519.1999999999998, "alertThreshold": 2.0}]} 10:52:02 INFO - Return code: 0 10:52:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:52:02 ERROR - # TBPL SUCCESS # 10:52:02 INFO - Running post-action listener: _resource_record_post_action 10:52:02 INFO - Running post-run listener: _resource_record_post_run 10:52:03 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 466472960; Read time: 8; Write time: 330760 10:52:03 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242569216; Read time: 0; Write time: 219956 10:52:03 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223457280; Read time: 8; Write time: 110804 10:52:03 INFO - Running post-run listener: _upload_blobber_files 10:52:03 INFO - Blob upload gear active. 10:52:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:52:03 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 10:52:03 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:52:03 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:52:03 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:52:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:04 INFO - (blobuploader) - INFO - Done attempting. 10:52:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:52:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:05 INFO - (blobuploader) - INFO - Done attempting. 10:52:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:05 INFO - Return code: 0 10:52:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:52:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a8ce8610beb111866aa7e768c0e7595a76b7d7c08e7c83b64038189b5ff16078aa2a2c136a1771f710b88456659116d145a3a39854c3d4d674d2d3629fe179c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9ae669a0c73fbe361cd15053d0d3848a2c1c8afbb837a0f9f166b17cd4bca4a49f53556211cf4c1a181c5494e83c005625a3fa573e8a430d0d9b89cdb00337"} 10:52:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:52:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:52:05 INFO - Contents: 10:52:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a8ce8610beb111866aa7e768c0e7595a76b7d7c08e7c83b64038189b5ff16078aa2a2c136a1771f710b88456659116d145a3a39854c3d4d674d2d3629fe179c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9ae669a0c73fbe361cd15053d0d3848a2c1c8afbb837a0f9f166b17cd4bca4a49f53556211cf4c1a181c5494e83c005625a3fa573e8a430d0d9b89cdb00337"} 10:52:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:05 INFO - Copying logs to upload dir... 10:52:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:52:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.126283 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-06 10:52:05.061869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:52:05.066254) ========= 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=ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566 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-Beta/sha512/8a8ce8610beb111866aa7e768c0e7595a76b7d7c08e7c83b64038189b5ff16078aa2a2c136a1771f710b88456659116d145a3a39854c3d4d674d2d3629fe179c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9ae669a0c73fbe361cd15053d0d3848a2c1c8afbb837a0f9f166b17cd4bca4a49f53556211cf4c1a181c5494e83c005625a3fa573e8a430d0d9b89cdb00337"} build_url:https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a8ce8610beb111866aa7e768c0e7595a76b7d7c08e7c83b64038189b5ff16078aa2a2c136a1771f710b88456659116d145a3a39854c3d4d674d2d3629fe179c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9ae669a0c73fbe361cd15053d0d3848a2c1c8afbb837a0f9f166b17cd4bca4a49f53556211cf4c1a181c5494e83c005625a3fa573e8a430d0d9b89cdb00337"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:52:05.097848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:52:05.098351) ========= 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=ed14279e38b05397cf4aa391000001a4-1467826262.312021-1347087566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:52:05.179517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:52:05.179834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:52:05.180130) ========= ========= Total master_lag: 0.40 =========