builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1460767520.55 results: success (0) buildid: 20160415145632 builduid: 12b723d2206b4b58ab423d564e4f6ce9 revision: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.546605) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.547251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.547581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.565444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.566063) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 17:45:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-04-15 17:45:21 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089452 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.675014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.675817) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013434 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:20.728139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 17:45:20.728498) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 --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=a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 17:45:21,161 truncating revision to first 12 chars 2016-04-15 17:45:21,161 Setting DEBUG logging. 2016-04-15 17:45:21,161 attempt 1/10 2016-04-15 17:45:21,161 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce4b3f7285ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 17:45:21,889 unpacking tar archive at: mozilla-aurora-ce4b3f7285ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 17:45:21.771711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:21.772094) ========= script_repo_revision: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:21.772877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:21.773438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:45:21.780934) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-15 17:45:21.781266) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:45:22 INFO - MultiFileLogger online at 20160415 17:45:22 in /builds/slave/test 17:45:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:45:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:45:22 INFO - {'append_to_log': False, 17:45:22 INFO - 'base_work_dir': '/builds/slave/test', 17:45:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:45:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:45:22 INFO - 'branch': 'Mozilla-Aurora', 17:45:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:45:22 INFO - 'config_files': ('talos/linux_config.py',), 17:45:22 INFO - 'default_actions': ('clobber', 17:45:22 INFO - 'read-buildbot-config', 17:45:22 INFO - 'download-and-extract', 17:45:22 INFO - 'populate-webroot', 17:45:22 INFO - 'create-virtualenv', 17:45:22 INFO - 'install', 17:45:22 INFO - 'run-tests'), 17:45:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:45:22 INFO - 'download_minidump_stackwalk': True, 17:45:22 INFO - 'download_symbols': 'ondemand', 17:45:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:45:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:45:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:45:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:45:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:45:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:45:22 INFO - 'installer_path': 'installer.exe', 17:45:22 INFO - 'log_level': 'info', 17:45:22 INFO - 'log_name': 'talos', 17:45:22 INFO - 'log_to_console': True, 17:45:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:45:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:45:22 INFO - 'opt_config_files': (), 17:45:22 INFO - 'pip_index': False, 17:45:22 INFO - 'sps_profile': False, 17:45:22 INFO - 'sps_profile_interval': 0, 17:45:22 INFO - 'suite': 'dromaeojs-e10s', 17:45:22 INFO - 'system_bits': '32', 17:45:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:45:22 INFO - 'title': 'talos-linux64-ix-064', 17:45:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:45:22 INFO - 'use_talos_json': True, 17:45:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:45:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:45:22 INFO - 'work_dir': 'build'} 17:45:22 INFO - ##### 17:45:22 INFO - ##### Running clobber step. 17:45:22 INFO - ##### 17:45:22 INFO - Running pre-action listener: _resource_record_pre_action 17:45:22 INFO - Running main action method: clobber 17:45:22 INFO - rmtree: /builds/slave/test/build 17:45:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:45:23 INFO - Running post-action listener: _resource_record_post_action 17:45:23 INFO - ##### 17:45:23 INFO - ##### Running read-buildbot-config step. 17:45:23 INFO - ##### 17:45:23 INFO - Running pre-action listener: _resource_record_pre_action 17:45:23 INFO - Running main action method: read_buildbot_config 17:45:23 INFO - Using buildbot properties: 17:45:23 INFO - { 17:45:23 INFO - "project": "", 17:45:23 INFO - "product": "firefox", 17:45:23 INFO - "script_repo_revision": "production", 17:45:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:45:23 INFO - "repository": "", 17:45:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:45:23 INFO - "buildid": "20160415145632", 17:45:23 INFO - "pgo_build": "True", 17:45:23 INFO - "basedir": "/builds/slave/test", 17:45:23 INFO - "buildnumber": 204, 17:45:23 INFO - "slavename": "talos-linux64-ix-064", 17:45:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:45:23 INFO - "platform": "ubuntu64_hw", 17:45:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:45:23 INFO - "branch": "mozilla-aurora", 17:45:23 INFO - "repo_path": "releases/mozilla-aurora", 17:45:23 INFO - "revision": "ce4b3f7285ab1ec78032fd0529bfe47ea8189a92", 17:45:23 INFO - "stage_platform": "linux64-pgo", 17:45:23 INFO - "builduid": "12b723d2206b4b58ab423d564e4f6ce9", 17:45:23 INFO - "slavebuilddir": "test" 17:45:23 INFO - } 17:45:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 17:45:23 INFO - Running post-action listener: _resource_record_post_action 17:45:23 INFO - ##### 17:45:23 INFO - ##### Running download-and-extract step. 17:45:23 INFO - ##### 17:45:23 INFO - Running pre-action listener: _resource_record_pre_action 17:45:23 INFO - Running main action method: download_and_extract 17:45:23 INFO - mkdir: /builds/slave/test/build/tests 17:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:23 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:45:23 INFO - Downloaded 1448 bytes. 17:45:23 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:45:23 INFO - Using the following test package requirements: 17:45:23 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:45:23 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:45:23 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:45:23 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'jsshell-linux-x86_64.zip'], 17:45:23 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:45:23 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:45:23 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:45:23 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:45:23 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:45:23 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:45:23 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:45:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:45:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:23 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:45:25 INFO - Downloaded 23352311 bytes. 17:45:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:45:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:45:26 INFO - Return code: 0 17:45:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:26 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:45:27 INFO - Downloaded 23352311 bytes. 17:45:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:45:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:45:29 INFO - Return code: 0 17:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:29 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:45:30 INFO - Downloaded 10845168 bytes. 17:45:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:45:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:45:30 INFO - Return code: 0 17:45:30 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')]} 17:45:30 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:45:31 INFO - Downloaded 60573235 bytes. 17:45:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:45:31 INFO - mkdir: /builds/slave/test/properties 17:45:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:45:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:45:31 INFO - Contents: 17:45:31 INFO - build_url:https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:45:33 INFO - Running post-action listener: _resource_record_post_action 17:45:33 INFO - Running post-action listener: set_extra_try_arguments 17:45:33 INFO - ##### 17:45:33 INFO - ##### Running populate-webroot step. 17:45:33 INFO - ##### 17:45:33 INFO - Running pre-action listener: _resource_record_pre_action 17:45:33 INFO - Running main action method: populate_webroot 17:45:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:45:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:45:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:45:33 INFO - '--tppagecycles', 17:45:33 INFO - '7'], 17:45:33 INFO - 'tests': ['tsvgm']}}, 17:45:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:45:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:45:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:45:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:45:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'tests': ['damp', 'tps']}, 17:45:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['damp', 'tps']}, 17:45:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:45:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:45:33 INFO - 'other': {'tests': ['a11yr', 17:45:33 INFO - 'ts_paint', 17:45:33 INFO - 'tpaint', 17:45:33 INFO - 'sessionrestore', 17:45:33 INFO - 'sessionrestore_no_auto_restore', 17:45:33 INFO - 'tabpaint']}, 17:45:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['a11yr', 17:45:33 INFO - 'ts_paint', 17:45:33 INFO - 'tpaint', 17:45:33 INFO - 'sessionrestore', 17:45:33 INFO - 'sessionrestore_no_auto_restore', 17:45:33 INFO - 'tabpaint']}, 17:45:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['a11yr', 17:45:33 INFO - 'ts_paint', 17:45:33 INFO - 'tpaint', 17:45:33 INFO - 'sessionrestore', 17:45:33 INFO - 'sessionrestore_no_auto_restore', 17:45:33 INFO - 'tabpaint']}, 17:45:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['a11yr', 17:45:33 INFO - 'ts_paint', 17:45:33 INFO - 'tpaint', 17:45:33 INFO - 'sessionrestore', 17:45:33 INFO - 'sessionrestore_no_auto_restore', 17:45:33 INFO - 'tabpaint']}, 17:45:33 INFO - 'other_l64': {'tests': ['a11yr', 17:45:33 INFO - 'ts_paint', 17:45:33 INFO - 'tpaint', 17:45:33 INFO - 'sessionrestore', 17:45:33 INFO - 'sessionrestore_no_auto_restore', 17:45:33 INFO - 'tabpaint']}, 17:45:33 INFO - 'other_nol64': {'tests': ['a11yr', 17:45:33 INFO - 'ts_paint', 17:45:33 INFO - 'tpaint', 17:45:33 INFO - 'sessionrestore', 17:45:33 INFO - 'sessionrestore_no_auto_restore', 17:45:33 INFO - 'tabpaint']}, 17:45:33 INFO - 'svgr': {'tests': ['tsvgx', 17:45:33 INFO - 'tsvgr_opacity', 17:45:33 INFO - 'tart', 17:45:33 INFO - 'tscrollx', 17:45:33 INFO - 'cart']}, 17:45:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['tsvgx', 17:45:33 INFO - 'tsvgr_opacity', 17:45:33 INFO - 'tart', 17:45:33 INFO - 'tscrollx', 17:45:33 INFO - 'cart']}, 17:45:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'tests': ['tp5o']}, 17:45:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'talos_options': ['--e10s'], 17:45:33 INFO - 'tests': ['tp5o']}, 17:45:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'talos_options': ['--xperf_path', 17:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:33 INFO - 'tests': ['tp5n']}, 17:45:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:33 INFO - 'talos_options': ['--e10s', 17:45:33 INFO - '--xperf_path', 17:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:33 INFO - 'tests': ['tp5n']}}, 17:45:33 INFO - 'talos.zip': {'path': '', 17:45:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:45:33 INFO - Running post-action listener: _resource_record_post_action 17:45:33 INFO - ##### 17:45:33 INFO - ##### Running create-virtualenv step. 17:45:33 INFO - ##### 17:45:33 INFO - Running pre-action listener: _resource_record_pre_action 17:45:33 INFO - Running main action method: create_virtualenv 17:45:33 INFO - Creating virtualenv /builds/slave/test/build/venv 17:45:33 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 17:45:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:45:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:45:33 INFO - Using real prefix '/usr' 17:45:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:45:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:45:36 INFO - Installing pip.................done. 17:45:36 INFO - Return code: 0 17:45:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:45:36 INFO - Using env: {'DISPLAY': ':0', 17:45:36 INFO - 'HOME': '/home/cltbld', 17:45:36 INFO - 'LANG': 'en_US.UTF-8', 17:45:36 INFO - 'LANGUAGE': 'en_US:en', 17:45:36 INFO - 'LOGNAME': 'cltbld', 17:45:36 INFO - 'MAIL': '/var/mail/cltbld', 17:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:36 INFO - 'MOZ_NO_REMOTE': '1', 17:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:36 INFO - 'NO_EM_RESTART': '1', 17:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:36 INFO - 'PWD': '/builds/slave/test', 17:45:36 INFO - 'SHELL': '/bin/bash', 17:45:36 INFO - 'SHLVL': '1', 17:45:36 INFO - 'TERM': 'linux', 17:45:36 INFO - 'TMOUT': '86400', 17:45:36 INFO - 'USER': 'cltbld', 17:45:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:36 INFO - '_': '/tools/buildbot/bin/python'} 17:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:36 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 17:45:36 INFO - Cleaning up... 17:45:36 INFO - Return code: 0 17:45:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:45:36 INFO - Using env: {'DISPLAY': ':0', 17:45:36 INFO - 'HOME': '/home/cltbld', 17:45:36 INFO - 'LANG': 'en_US.UTF-8', 17:45:36 INFO - 'LANGUAGE': 'en_US:en', 17:45:36 INFO - 'LOGNAME': 'cltbld', 17:45:36 INFO - 'MAIL': '/var/mail/cltbld', 17:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:36 INFO - 'MOZ_NO_REMOTE': '1', 17:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:36 INFO - 'NO_EM_RESTART': '1', 17:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:36 INFO - 'PWD': '/builds/slave/test', 17:45:36 INFO - 'SHELL': '/bin/bash', 17:45:36 INFO - 'SHLVL': '1', 17:45:36 INFO - 'TERM': 'linux', 17:45:36 INFO - 'TMOUT': '86400', 17:45:36 INFO - 'USER': 'cltbld', 17:45:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:36 INFO - '_': '/tools/buildbot/bin/python'} 17:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:36 INFO - Downloading/unpacking psutil>=0.7.1 17:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:45:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:38 INFO - Installing collected packages: psutil 17:45:38 INFO - Running setup.py install for psutil 17:45:38 INFO - building 'psutil._psutil_linux' extension 17:45:38 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 17:45:39 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 17:45:39 INFO - building 'psutil._psutil_posix' extension 17:45:39 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 17:45:39 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 17:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:39 INFO - Successfully installed psutil 17:45:39 INFO - Cleaning up... 17:45:39 INFO - Return code: 0 17:45:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:45:39 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')]} 17:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:39 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')]} 17:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:39 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:39 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 17:45:39 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 17:45:39 INFO - Using env: {'DISPLAY': ':0', 17:45:39 INFO - 'HOME': '/home/cltbld', 17:45:39 INFO - 'LANG': 'en_US.UTF-8', 17:45:39 INFO - 'LANGUAGE': 'en_US:en', 17:45:39 INFO - 'LOGNAME': 'cltbld', 17:45:39 INFO - 'MAIL': '/var/mail/cltbld', 17:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:39 INFO - 'MOZ_NO_REMOTE': '1', 17:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:39 INFO - 'NO_EM_RESTART': '1', 17:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:39 INFO - 'PWD': '/builds/slave/test', 17:45:39 INFO - 'SHELL': '/bin/bash', 17:45:39 INFO - 'SHLVL': '1', 17:45:39 INFO - 'TERM': 'linux', 17:45:39 INFO - 'TMOUT': '86400', 17:45:39 INFO - 'USER': 'cltbld', 17:45:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:39 INFO - '_': '/tools/buildbot/bin/python'} 17:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:45:39 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 17:45:39 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 17:45:39 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 17:45:39 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 17:45:39 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 17:45:39 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 17:45:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:45:41 INFO - Installing collected packages: mozsystemmonitor 17:45:41 INFO - Running setup.py install for mozsystemmonitor 17:45:41 INFO - Successfully installed mozsystemmonitor 17:45:41 INFO - Cleaning up... 17:45:41 INFO - Return code: 0 17:45:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:45:41 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')]} 17:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:41 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')]} 17:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:41 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:41 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 17:45:41 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 17:45:41 INFO - Using env: {'DISPLAY': ':0', 17:45:41 INFO - 'HOME': '/home/cltbld', 17:45:41 INFO - 'LANG': 'en_US.UTF-8', 17:45:41 INFO - 'LANGUAGE': 'en_US:en', 17:45:41 INFO - 'LOGNAME': 'cltbld', 17:45:41 INFO - 'MAIL': '/var/mail/cltbld', 17:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:41 INFO - 'MOZ_NO_REMOTE': '1', 17:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:41 INFO - 'NO_EM_RESTART': '1', 17:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:41 INFO - 'PWD': '/builds/slave/test', 17:45:41 INFO - 'SHELL': '/bin/bash', 17:45:41 INFO - 'SHLVL': '1', 17:45:41 INFO - 'TERM': 'linux', 17:45:41 INFO - 'TMOUT': '86400', 17:45:41 INFO - 'USER': 'cltbld', 17:45:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:41 INFO - '_': '/tools/buildbot/bin/python'} 17:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:45:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:45:44 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 17:45:44 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 17:45:44 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 17:45:44 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 17:45:44 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 17:45:44 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 17:45:44 INFO - Downloading docopt-0.6.1.tar.gz 17:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:45:44 INFO - Running setup.py install for blobuploader 17:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:45:44 INFO - Running setup.py install for requests 17:45:44 INFO - Running setup.py install for docopt 17:45:44 INFO - Successfully installed blobuploader requests docopt 17:45:44 INFO - Cleaning up... 17:45:45 INFO - Return code: 0 17:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:45 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')]} 17:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:45 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')]} 17:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:45 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:45 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 17:45:45 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 17:45:45 INFO - Using env: {'DISPLAY': ':0', 17:45:45 INFO - 'HOME': '/home/cltbld', 17:45:45 INFO - 'LANG': 'en_US.UTF-8', 17:45:45 INFO - 'LANGUAGE': 'en_US:en', 17:45:45 INFO - 'LOGNAME': 'cltbld', 17:45:45 INFO - 'MAIL': '/var/mail/cltbld', 17:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:45 INFO - 'MOZ_NO_REMOTE': '1', 17:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:45 INFO - 'NO_EM_RESTART': '1', 17:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:45 INFO - 'PWD': '/builds/slave/test', 17:45:45 INFO - 'SHELL': '/bin/bash', 17:45:45 INFO - 'SHLVL': '1', 17:45:45 INFO - 'TERM': 'linux', 17:45:45 INFO - 'TMOUT': '86400', 17:45:45 INFO - 'USER': 'cltbld', 17:45:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:45 INFO - '_': '/tools/buildbot/bin/python'} 17:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:45 INFO - Running setup.py (path:/tmp/pip-2YcOaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:45 INFO - Running setup.py (path:/tmp/pip-3Fb2Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:45 INFO - Running setup.py (path:/tmp/pip-1h7P_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:45 INFO - Running setup.py (path:/tmp/pip-xFFils-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:45 INFO - Running setup.py (path:/tmp/pip-0Y128n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:45 INFO - Running setup.py (path:/tmp/pip-aILbLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:45 INFO - Running setup.py (path:/tmp/pip-yYm2Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:45 INFO - Running setup.py (path:/tmp/pip-7byZVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:45 INFO - Running setup.py (path:/tmp/pip-NR_eu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:45 INFO - Running setup.py (path:/tmp/pip-WFej3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:45 INFO - Running setup.py (path:/tmp/pip-N86pTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:46 INFO - Running setup.py (path:/tmp/pip-LGWXIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:46 INFO - Running setup.py (path:/tmp/pip-Q0Ot9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:46 INFO - Running setup.py (path:/tmp/pip-kuZg5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:46 INFO - Running setup.py (path:/tmp/pip-dBVot1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:46 INFO - Running setup.py (path:/tmp/pip-AxxPdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:46 INFO - Running setup.py (path:/tmp/pip-6fUSG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:45:46 INFO - Running setup.py install for manifestparser 17:45:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:45:46 INFO - Running setup.py install for mozcrash 17:45:46 INFO - Running setup.py install for mozdebug 17:45:46 INFO - Running setup.py install for mozdevice 17:45:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:45:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:45:46 INFO - Running setup.py install for mozfile 17:45:47 INFO - Running setup.py install for mozhttpd 17:45:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for mozinfo 17:45:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for mozInstall 17:45:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for mozleak 17:45:47 INFO - Running setup.py install for mozlog 17:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for moznetwork 17:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for mozprocess 17:45:47 INFO - Running setup.py install for mozprofile 17:45:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for mozrunner 17:45:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:45:47 INFO - Running setup.py install for mozscreenshot 17:45:48 INFO - Running setup.py install for moztest 17:45:48 INFO - Running setup.py install for mozversion 17:45:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:45:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:45:48 INFO - Cleaning up... 17:45:48 INFO - Return code: 0 17:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:48 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:48 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 17:45:48 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 17:45:48 INFO - Using env: {'DISPLAY': ':0', 17:45:48 INFO - 'HOME': '/home/cltbld', 17:45:48 INFO - 'LANG': 'en_US.UTF-8', 17:45:48 INFO - 'LANGUAGE': 'en_US:en', 17:45:48 INFO - 'LOGNAME': 'cltbld', 17:45:48 INFO - 'MAIL': '/var/mail/cltbld', 17:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:48 INFO - 'MOZ_NO_REMOTE': '1', 17:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:48 INFO - 'NO_EM_RESTART': '1', 17:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:48 INFO - 'PWD': '/builds/slave/test', 17:45:48 INFO - 'SHELL': '/bin/bash', 17:45:48 INFO - 'SHLVL': '1', 17:45:48 INFO - 'TERM': 'linux', 17:45:48 INFO - 'TMOUT': '86400', 17:45:48 INFO - 'USER': 'cltbld', 17:45:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:48 INFO - '_': '/tools/buildbot/bin/python'} 17:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:48 INFO - Running setup.py (path:/tmp/pip-TT17AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:48 INFO - Running setup.py (path:/tmp/pip-ImkSrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:48 INFO - Running setup.py (path:/tmp/pip-t0QyRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:48 INFO - Running setup.py (path:/tmp/pip-GGOpbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:48 INFO - Running setup.py (path:/tmp/pip-uhohAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:48 INFO - Running setup.py (path:/tmp/pip-ZtedDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:48 INFO - Running setup.py (path:/tmp/pip-OSQA8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:48 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)) 17:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:48 INFO - Running setup.py (path:/tmp/pip-KK9U6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:49 INFO - Running setup.py (path:/tmp/pip-54O3i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:49 INFO - Running setup.py (path:/tmp/pip-h8jNmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:49 INFO - Running setup.py (path:/tmp/pip-VeDKiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:49 INFO - Running setup.py (path:/tmp/pip-VI5SGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:49 INFO - Running setup.py (path:/tmp/pip-_YJyXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:49 INFO - Running setup.py (path:/tmp/pip-rNXLcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:49 INFO - Running setup.py (path:/tmp/pip-2h3vZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:49 INFO - Running setup.py (path:/tmp/pip-_kS0ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:49 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)) 17:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:49 INFO - Running setup.py (path:/tmp/pip-3IE8y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:49 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)) 17:45:49 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)) 17:45:49 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)) 17:45:49 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)) 17:45:49 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)) 17:45:49 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)) 17:45:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:45:49 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 17:45:49 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 17:45:49 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 17:45:49 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 17:45:49 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 17:45:49 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 17:45:51 INFO - Downloading blessings-1.6.tar.gz 17:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:45:51 INFO - Installing collected packages: blessings 17:45:51 INFO - Running setup.py install for blessings 17:45:51 INFO - Successfully installed blessings 17:45:51 INFO - Cleaning up... 17:45:51 INFO - Return code: 0 17:45:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:52 INFO - Reading from file tmpfile_stdout 17:45:52 INFO - Current package versions: 17:45:52 INFO - argparse == 1.2.1 17:45:52 INFO - blessings == 1.6 17:45:52 INFO - blobuploader == 1.2.4 17:45:52 INFO - docopt == 0.6.1 17:45:52 INFO - manifestparser == 1.1 17:45:52 INFO - mozInstall == 1.12 17:45:52 INFO - mozcrash == 0.17 17:45:52 INFO - mozdebug == 0.1 17:45:52 INFO - mozdevice == 0.48 17:45:52 INFO - mozfile == 1.2 17:45:52 INFO - mozhttpd == 0.7 17:45:52 INFO - mozinfo == 0.9 17:45:52 INFO - mozleak == 0.1 17:45:52 INFO - mozlog == 3.1 17:45:52 INFO - moznetwork == 0.27 17:45:52 INFO - mozprocess == 0.22 17:45:52 INFO - mozprofile == 0.28 17:45:52 INFO - mozrunner == 6.11 17:45:52 INFO - mozscreenshot == 0.1 17:45:52 INFO - mozsystemmonitor == 0.0 17:45:52 INFO - moztest == 0.7 17:45:52 INFO - mozversion == 1.4 17:45:52 INFO - psutil == 3.1.1 17:45:52 INFO - requests == 1.2.3 17:45:52 INFO - wsgiref == 0.1.2 17:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:52 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:52 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 17:45:52 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 17:45:52 INFO - Using env: {'DISPLAY': ':0', 17:45:52 INFO - 'HOME': '/home/cltbld', 17:45:52 INFO - 'LANG': 'en_US.UTF-8', 17:45:52 INFO - 'LANGUAGE': 'en_US:en', 17:45:52 INFO - 'LOGNAME': 'cltbld', 17:45:52 INFO - 'MAIL': '/var/mail/cltbld', 17:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:52 INFO - 'MOZ_NO_REMOTE': '1', 17:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:52 INFO - 'NO_EM_RESTART': '1', 17:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:52 INFO - 'PWD': '/builds/slave/test', 17:45:52 INFO - 'SHELL': '/bin/bash', 17:45:52 INFO - 'SHLVL': '1', 17:45:52 INFO - 'TERM': 'linux', 17:45:52 INFO - 'TMOUT': '86400', 17:45:52 INFO - 'USER': 'cltbld', 17:45:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:52 INFO - '_': '/tools/buildbot/bin/python'} 17:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 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)) 17:45:52 INFO - Cleaning up... 17:45:52 INFO - Return code: 0 17:45:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:52 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:52 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 17:45:52 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 17:45:52 INFO - Using env: {'DISPLAY': ':0', 17:45:52 INFO - 'HOME': '/home/cltbld', 17:45:52 INFO - 'LANG': 'en_US.UTF-8', 17:45:52 INFO - 'LANGUAGE': 'en_US:en', 17:45:52 INFO - 'LOGNAME': 'cltbld', 17:45:52 INFO - 'MAIL': '/var/mail/cltbld', 17:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:52 INFO - 'MOZ_NO_REMOTE': '1', 17:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:52 INFO - 'NO_EM_RESTART': '1', 17:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:52 INFO - 'PWD': '/builds/slave/test', 17:45:52 INFO - 'SHELL': '/bin/bash', 17:45:52 INFO - 'SHLVL': '1', 17:45:52 INFO - 'TERM': 'linux', 17:45:52 INFO - 'TMOUT': '86400', 17:45:52 INFO - 'USER': 'cltbld', 17:45:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:52 INFO - '_': '/tools/buildbot/bin/python'} 17:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:52 INFO - Downloading/unpacking jsonschema 17:45:52 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 17:45:52 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 17:45:52 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 17:45:52 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 17:45:52 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 17:45:52 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 17:45:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:45:54 INFO - Downloading/unpacking functools32 (from jsonschema) 17:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:45:54 INFO - warning: no files found matching '*.txt' 17:45:54 INFO - no previously-included directories found matching 'build' 17:45:54 INFO - no previously-included directories found matching 'dist' 17:45:54 INFO - no previously-included directories found matching '.git*' 17:45:54 INFO - Installing collected packages: jsonschema, functools32 17:45:54 INFO - Running setup.py install for functools32 17:45:54 INFO - warning: no files found matching '*.txt' 17:45:54 INFO - no previously-included directories found matching 'build' 17:45:54 INFO - no previously-included directories found matching 'dist' 17:45:54 INFO - no previously-included directories found matching '.git*' 17:45:54 INFO - Successfully installed jsonschema functools32 17:45:54 INFO - Cleaning up... 17:45:54 INFO - Return code: 0 17:45:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:45:54 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')]} 17:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:54 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')]} 17:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:54 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 0x7f7a9a39bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', '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 17:45:54 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 17:45:54 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 17:45:54 INFO - Using env: {'DISPLAY': ':0', 17:45:54 INFO - 'HOME': '/home/cltbld', 17:45:54 INFO - 'LANG': 'en_US.UTF-8', 17:45:54 INFO - 'LANGUAGE': 'en_US:en', 17:45:54 INFO - 'LOGNAME': 'cltbld', 17:45:54 INFO - 'MAIL': '/var/mail/cltbld', 17:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:54 INFO - 'MOZ_NO_REMOTE': '1', 17:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:54 INFO - 'NO_EM_RESTART': '1', 17:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:54 INFO - 'PWD': '/builds/slave/test', 17:45:54 INFO - 'SHELL': '/bin/bash', 17:45:54 INFO - 'SHLVL': '1', 17:45:54 INFO - 'TERM': 'linux', 17:45:54 INFO - 'TMOUT': '86400', 17:45:54 INFO - 'USER': 'cltbld', 17:45:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:54 INFO - '_': '/tools/buildbot/bin/python'} 17:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:55 INFO - Downloading/unpacking flake8 17:45:55 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 17:45:55 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 17:45:55 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 17:45:55 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 17:45:55 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 17:45:55 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 17:45:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:45:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:45:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:45:57 INFO - no previously-included directories found matching 'docs/_build' 17:45:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:45:57 INFO - Running setup.py install for pep8 17:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:45:57 INFO - no previously-included directories found matching 'docs/_build' 17:45:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:45:57 INFO - Cleaning up... 17:45:57 INFO - Return code: 0 17:45:57 INFO - Running post-action listener: _resource_record_post_action 17:45:57 INFO - Running post-action listener: _start_resource_monitoring 17:45:57 INFO - Starting resource monitoring. 17:45:57 INFO - ##### 17:45:57 INFO - ##### Running install step. 17:45:57 INFO - ##### 17:45:57 INFO - Running pre-action listener: _resource_record_pre_action 17:45:57 INFO - Running main action method: install 17:45:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:58 INFO - Reading from file tmpfile_stdout 17:45:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:45:58 INFO - Reading from file tmpfile_stdout 17:45:58 INFO - Output received: 17:45:58 INFO - Usage: mozinstall [options] installer 17:45:58 INFO - Options: 17:45:58 INFO - -h, --help show this help message and exit 17:45:58 INFO - -d DEST, --destination=DEST 17:45:58 INFO - Directory to install application into. [default: 17:45:58 INFO - "/builds/slave/test"] 17:45:58 INFO - --app=APP Application being installed. [default: firefox] 17:45:58 INFO - mkdir: /builds/slave/test/build/application 17:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:46:13 INFO - Reading from file tmpfile_stdout 17:46:13 INFO - Output received: 17:46:13 INFO - /builds/slave/test/build/application/firefox/firefox 17:46:13 INFO - Running post-action listener: _resource_record_post_action 17:46:13 INFO - ##### 17:46:13 INFO - ##### Running run-tests step. 17:46:13 INFO - ##### 17:46:13 INFO - Running pre-action listener: _resource_record_pre_action 17:46:13 INFO - Running main action method: run_tests 17:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:46:13 INFO - Python 2.7.3 17:46:13 INFO - Return code: 0 17:46:13 INFO - grabbing minidump binary from tooltool 17:46: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')]} 17:46:13 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 0x2859160>, '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 0x285a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:46:13 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 17:46:13 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 17:46:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:46:13 INFO - Return code: 0 17:46:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:46:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:46:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:46:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:46:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:46:14 INFO - Return code: 0 17:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 17:46:14 INFO - Using env: {'DISPLAY': ':0', 17:46:14 INFO - 'HOME': '/home/cltbld', 17:46:14 INFO - 'LANG': 'en_US.UTF-8', 17:46:14 INFO - 'LANGUAGE': 'en_US:en', 17:46:14 INFO - 'LOGNAME': 'cltbld', 17:46:14 INFO - 'MAIL': '/var/mail/cltbld', 17:46:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:46:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:14 INFO - 'MOZ_NO_REMOTE': '1', 17:46:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:14 INFO - 'NO_EM_RESTART': '1', 17:46:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:14 INFO - 'PWD': '/builds/slave/test', 17:46:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:46:14 INFO - 'SHELL': '/bin/bash', 17:46:14 INFO - 'SHLVL': '1', 17:46:14 INFO - 'TERM': 'linux', 17:46:14 INFO - 'TMOUT': '86400', 17:46:14 INFO - 'USER': 'cltbld', 17:46:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456', 17:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:14 INFO - '_': '/tools/buildbot/bin/python'} 17:46:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:46:14 INFO - mozversion application_buildid: 20160415145632 17:46:14 INFO - mozversion application_changeset: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 17:46:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:46:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:46:14 INFO - mozversion application_name: Firefox 17:46:14 INFO - mozversion application_remotingname: firefox-dev 17:46:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:46:14 INFO - mozversion application_vendor: Mozilla 17:46:14 INFO - mozversion application_version: 47.0a2 17:46:14 INFO - mozversion platform_buildid: 20160415145632 17:46:14 INFO - mozversion platform_changeset: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 17:46:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:46:14 INFO - mozversion platform_version: 47.0a2 17:46:14 INFO - using testdate: 1460767574 17:46:14 INFO - actual date: 1460767574 17:46:14 INFO - starting webserver on 'localhost:60457' 17:46:14 INFO - SUITE-START | Running 2 tests 17:46:14 INFO - TEST-START | dromaeo_css 17:46:14 INFO - operating with platform_type : linux_ 17:46:14 INFO - Initialising browser for dromaeo_css test... 17:46:14 INFO - TEST-INFO | started process 25026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRJXFnd/profile http://localhost:60457/getInfo.html) 17:46:18 INFO - PROCESS | 25026 | 17:46:18 INFO - PROCESS | 25026 | (process:25106): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:46:19 INFO - PROCESS | 25026 | __metrics Screen width/height:1600/1200 17:46:19 INFO - PROCESS | 25026 | colorDepth:24 17:46:19 INFO - PROCESS | 25026 | Browser inner width/height: 1024/697 17:46:19 INFO - PROCESS | 25026 | __metrics 17:46:20 ERROR - PROCESS | 25026 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:46:21 INFO - TEST-INFO | 25026: exit 0 17:46:21 INFO - Browser initialized. 17:46:21 INFO - Running cycle 1/1 for dromaeo_css test... 17:46:21 INFO - TEST-INFO | started process 25157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRJXFnd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:23 INFO - PROCESS | 25157 | 17:46:23 INFO - PROCESS | 25157 | (process:25225): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:46:33 INFO - PROCESS | 25157 | RSS: Main: 151388160 17:46:33 INFO - PROCESS | 25157 | 17:47:22 INFO - PROCESS | 25157 | 1460767642566 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] 17:49:30 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:60457/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60457/tests/dromaeo/cssquery-ext.html) 17:49:31 INFO - PROCESS | 25157 | RSS: Main: 155185152 17:49:31 INFO - PROCESS | 25157 | 17:52:33 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:60457/tests/dromaeo/cssquery-ext.html (next: http://localhost:60457/tests/dromaeo/cssquery-jquery.html) 17:52:33 INFO - PROCESS | 25157 | RSS: Main: 153423872 17:52:33 INFO - PROCESS | 25157 | 17:55:35 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:60457/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60457/tests/dromaeo/cssquery-mootools.html) 17:55:36 INFO - PROCESS | 25157 | RSS: Main: 152293376 17:55:36 INFO - PROCESS | 25157 | 17:58:37 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:60457/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60457/tests/dromaeo/cssquery-prototype.html) 17:58:38 INFO - PROCESS | 25157 | RSS: Main: 152059904 17:58:38 INFO - PROCESS | 25157 | 18:01:40 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:60457/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60457/tests/dromaeo/cssquery-yui.html) 18:01:41 INFO - PROCESS | 25157 | RSS: Main: 153047040 18:01:41 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:60457/tests/dromaeo/cssquery-yui.html (next: http://localhost:60457/tests/dromaeo/cssquery-dojo.html) 18:04:43 INFO - PROCESS | 25157 | RSS: Main: 154742784 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | __start_tp_report 18:04:43 INFO - PROCESS | 25157 | _x_x_mozilla_page_load 18:04:43 INFO - PROCESS | 25157 | _x_x_mozilla_page_load_details 18:04:43 INFO - PROCESS | 25157 | |i|pagename|runs| 18:04:43 INFO - PROCESS | 25157 | |0;dojo.html;3276.787008844425;3322.5680661513998;3352.8491217895194;3366.377220214259;3399.9490007649874;5431.321084864392;5446.509814116729;5465.426130256325;5467.507924286813;5477.424870388607;5462.808801691942;5483.122700367942;5486.396496385394;5505.3393592768825;5506.119020956648;4996.400431948171;5023.14606516893;5098.235264710286;5107.514786095334;5122.641415100926;4868.415790105192;4987.75061246938;5054.494550544934;5065.265536497206;5114.411842638088;5044.394672639289;5071.619628527875;5117.769700363493;5134.229865520165;5154.536091751742;5051.141305977974;5051.621128415365;5056.367954005749;5078.898422031539;5105.336306280197;4898.853034408938;4907.779149938261;4968.279599458095;4991.575716064139;5059.519345662156;5237.423883372826;5286.3127793387;5290.444503327172;5316.9202461963105;5351.063563876306;5814.563907706896;5842.298924129132;5847.590668653196;5850.0932355484965;5850.6489610623075;5750.137479378085;5923.378045305224;5952.9702351488395;5973.1040343948325;6008.519318454557;5469.234307196995;5486.177073439016;5486.984907792072;5491.533219676332;5518.117101263819;5989.490893274121;5989.970050149721;6009.06859436788;6015.879682406327;6030.216071910623;5634.915476267859;5797.536197104221;5801.82594522165;5843.065109582446;5918.674472903946;5851.444112809277;5855.151003104611;5857.238558987305;5857.70711464425;5906.232189815297;5822.534197264209;5825.475707186373;5829.854253643693;5853.03424934881;5854.736536855852;5770.365259821417;5821.767129314865;5912.793052243151;5913.201717768132;5946.791862284886;4449.354843547732;4450.109978004412;4479.283314669702;4502.482214545304;4520.141173177086;4016.2971479990883;4050.5746896576024;4057.878263652095;4068.7355321903983;4095.9590404096175;5493.807716729895;5551.528120109755;5668.51817595509;5700.8859822803315;5707.914381284284;5921.348651648315;5930.080837470199;5930.466258036798;5958.582899197015;5970.522358211333;5462.126059830408;5536.169574563848;5550.888982220333;5592.5805564582815;5600.607957443021;4963.057019166346;4998.200287953982;5063.0380227756605;5071.949280507148;5075.162598171334;6018.488428483628;6091.2081429414775;6091.8477038073515;6117.480014198754;6137.447629713347;5835.2122463466885;5922.615030023035;5942.554308426799;5956.315023772322;5962.999999999914;5925.733341999534;5991.041433370639;5991.550633702577;5995.5803093783015;6035.36628653985;5854.882902342015;5900.203472531153;5902.203202567598;5904.61619994699;5924.881502369843;5743.368229494668;5917.319508256605;5971.940280597139;5980.34216236205;5997.520198384206;5794.449527295069;5806.2451881255165;5850.7074646266665;5854.707264636666;5887.411258874078;5691.174779656843;5721.628094173865;5734.254546909042;5741.196232527366;5757.3379061406795;5522.6134170607675;5523.502884740393;5617.831465055891;5628.268325117709;5676.063449530946;5716.514096301695;5753.482186603226;5773.711314434346;5775.6823374714795;5776.826695199151;5612.7754889803955;5633.746481408429;5637.041702910433;5653.2085508028085;5680.71596420169 18:04:43 INFO - PROCESS | 25157 | |1;ext.html;540.9459054094589;574.1588572740931;582.8834233153369;588.0444081696872;614.4101662404092;37733.49066037359;38265.80867095664;38285.80857095711;38425.42361864574;38694.806525967404;42070.7896460518;42693.14613707724;42724.359134613005;42725;42898;8798.428102173355;8916.955415222916;8968.50673212973;8975.46147231165;9012.639494420215;8764.8685269721;8898.555072246394;8919.152680495376;9224.8616270756;9246.121618446237;9180.770480738001;9303.906960930406;9305.162535371848;9306.488143152124;9324.766880827965;9172.174504294611;9249.907500925006;9255;9273.165415112604;9289.163975242192;9174.174324310778;9320.72037838866;9322.06779322069;9344.439333639935;9350.158485736316;39191;39567.20865582701;39645.40531892024;39681.60318396837;39699.40450893239;3591.730620203495;3732.6267373262726;3743.9251214975548;3792.431135329695;3904.4728961590104;29079.56380654292;29136.70863291361;29207.269818254503;29260.70739292601;29470.557941630894;4144.357624568197;4244.554321796198;4256.106217694288;4330.220560299145;4342.891427714301;301019;301105;302291;302688.486557568;306661;69023.30976690269;69215.65392173007;69242.30757692359;69617.30382696108;69638.65180674064;73059;74102;74214.25785742073;74591.25408745951;74662;17129.571760705832;17161.485155445356;17220.05289709053;17338.653226935392;17401.216945237495;12893.097483176276;12909.419076141596;12920;12927.870721292855;12930.741385172243;22334.664980025314;22389.552208956055;22462.55074898493;22476.662850057262;22497.650140991595;8004.879926801103;8062.7581172564915;8336.249737523653;8444.366672499587;8474.92364370733;1076.128336047788;1084.002717499902;1123.646051493777;1129.6949823547595;1158.1314014489133;30184.24539386533;30785.8460707695;30915.381692366478;31123.221919452193;31401.05796826099;1180.722530205401;1215.538095523713;1216.914815962892;1221.4930803716536;1230.9076819238594;15835.129067901145;15922.283497242652;16147.919260403623;16176.191190440666;16353.345866165459;324056;345094;346537;349117;354930;52601.73699131556;53564.46435535595;53572;53595.732021339645;53768.73115634475;1460.0874453466583;1495.7008598280388;1504.2328412509698;1505.2097648734284;1512.37992423106;30312.54531182078;31714;31890.84054579805;31976.36047279088;32276.031719048467;51797.741011294704;54353.72823135859;56328;56450.15324770214;56502;251241;253453;254452;254467;254742;42652.78673606612;43171.56828431801;43286;43372.783136084116;43522.78238608786;45703.314450283935;45918.540814591426;46400.767996159804;46596;46800.7659961698;42499.37565556215;42893.78553107214;43208.56791432171;43606.56393436025;43760.56239437565;41901.1619767609;42341.576584234994;42720;42775.14449711051;43030.569694302656;41547.16905661931;41702;42502.362464563674;42529.36205956851;42636.57363426326;36794.632053680194;36844.912056858244;36913.63086369102;37287.81356093202;37829.621703782606;27976.44047119087;28699.28251793722;29017.854910725313;29232.26919327034;29320.56019159757 18:04:43 INFO - PROCESS | 25157 | |2;jquery.html;353.69405464273405;360.7474767662635;368.4951616285689;378.86171547385214;379.28504768511345;17235;17874;19095.52261193471;19108.90445547774;19114.808851911475;17278.740818887727;17771.55571110723;17808.821911780877;17944.64110717785;17945;5310.123829568117;5498.340199176105;5531.917021244664;5532.059549876531;5545.584081193906;4160.084781348114;5392.91910621341;5669.773209071653;5895.9705201473935;5906.852328691774;5815.767369305223;5821.417858214187;5825.44658257467;5836.970815145918;5866.70666466675;5874.530037596982;5992;6003.129546215818;6025.397460253984;6089.0866370044405;5156.484351564851;5177.249298851683;5178.119719647669;5187.844364669066;5212.244224587414;21247.68128478074;21538;21591.892040539853;21617.891910540504;21756.564868702695;2371.988140059306;2380.071772008918;3020.2449387653087;3106.891258805931;3134.6238451385752;9542.33203675743;9830.115289623967;9893.35693179941;13184.934075329562;14047.367868445945;1935.632229876319;2002.159093180853;2010.2160157538572;2027.6248893954519;2050.928217512395;60489.69755151196;61908;67620;68751.3124868755;69897.95153072759;10003.549840257207;10315.690529284133;10514.684559463076;10523.105536029523;10529;14611;14667.193304368362;14681.632959175893;14715.484958026418;14738.852611473749;7623.894535292462;7792.610369481503;7843.5293882366095;7854.567998760009;7929.088154862265;7511.699532018767;7655;7670.348020418327;7704.460687751804;7711.421643376769;4531.614812740954;4544.954550454453;4614.353990441341;4639.164950308977;4663.556962088596;1783.563027058379;1812.4959475702867;1831.7678898352156;1852.9629407411776;1935.55482239083;959.8512230604267;960.0831206198064;990.2177279948904;1025.2874252394515;1047.3087762077146;16983.66032679364;17350.47948561545;17516.12419379026;17699.02655353942;18000.819991799915;982.9950850245846;997.6458357283205;1006.094514936563;1013.3261381181431;1041.401194313273;9949.80100397988;10008.249381296286;10114.54484548197;10117.494125293706;10171.237157213238;425439;429703;436805;439900;441420;76691;77028.22971770323;77720.61139694265;78671.60664196643;79570.6021469889;1032.8915463876185;1040.3029969920171;1052.3475445223858;1054.3041592548882;1055.0820785916148;15644.92177539105;15704.953592866601;15762.211889405713;15870.9206453967;16061.27724252388;35638.64361356457;35752.284954301285;36090;36173.0956726084;36547;48821;50693.49306506888;51132;51213.74393128011;51318.23022654738;8527.445716028438;8593.226609605166;8612.612432440681;8749.343799215212;8787.253083487974;9948.154406875497;11117.94441027822;12574.371281436075;12874.871251287743;13054.608361749162;10471.42407167613;10545.367277963347;10980.560777568808;11133.332000080021;11233.157513186381;5006.324146240211;9242.676506322246;9672;11067.169962253025;11745.823812642646;11184.328940263611;11321.773564528829;11426.600068997544;11628.476718547516;11867.525298988288;8266.256036956704;8400.663973441238;8430.704925327584;8468.66125354979;8557.614907329309;9795.363301385387;10799.946000269949;10853;10857.185711071543;11061.11511079128 18:04:43 INFO - PROCESS | 25157 | |3;mootools.html;1548.860602545771;1577.9921100394497;1837.972430413544;1958.5103724068983;1989.5921336126096;7610;7749.30256276935;8545.658173673053;8747.256483198928;8758.91241087589;8072.233137851895;8292.460990035643;8437.535935523543;8554;8585.828283434328;2451.6690246816675;2479.752024797524;2482.553140434721;2496.4383013821835;2505.2108585795418;2496.450780828215;2526.9747302526926;2537.5432422164004;2542.148380292604;2546.2106746908426;2404.422938494766;2428.878556072198;2446.0338166424253;2447.571674956884;2460.963085553718;2506.724260331371;2507.8119141064403;2510.7112682041616;2527.6082207257905;2531.59494480884;2452.2275483222907;2461.3477428481465;2472.7527247275307;2473.4558397152596;2474.5174690935273;8814.250788682906;8828;8842.292616590657;8847.646094156225;8853.424527405698;5238.528532432099;5405.729713514309;5415.160650099241;5454.181872719084;5454.836354909359;3287.096048586634;3308.751843611739;3318.8340582970754;3352.379809735207;3394.6605339466105;958.8753462049958;974.6783561424713;978.2320878110648;981.3474039763548;999.8900120986685;12048.397580121047;12158.33129177886;12166.5741699041;12252.387380630933;12287.815682764765;4445.777711114431;4484.573965473275;4564.132814765184;4579.992401671627;4611.792469338888;9636.518174091267;9711.708648740409;9715.61137554504;9721.562529686182;9769.51152442375;5299.33758280215;5309.8938021239355;5312.893742125136;5321.36143662763;5325.3875804282225;4258.233517966796;4709.340692303081;4712.31671407644;4764.6664733469015;4925.236588328815;3588.766730162531;3605.7295702822394;3654.3970244909824;3674.9448758268113;3698.7041036716996;1034.1261633919326;1047.1151876664208;1048.8898665640152;1052.7736536644504;1060.7772367802847;1508.7133444645483;1525.862672359493;1527.4119464006437;1538.6538028943621;1551.1313664347776;8217.055038670509;8344.62449189788;8357.331413486907;8371.790705232417;8401.495910245405;515.1911498946617;519.7349351830594;523.4085483403729;529.1375058654369;533.9572834173257;6174.197354343906;6229.56393052482;6238.313785483593;6250.593711408744;6311.621302721851;10313.639022634172;10780.29928054674;10811.78376432467;10815.40515271652;10930.617428389969;10384.169266458664;10649;10697.358158510358;10739.516721747541;10743.194260430499;8265;8360.707375241838;8379.706710264989;8450.239478446969;8455.830883382298;7947.642356094106;7955.5226686399;8045.235702608243;8086;8112.59437028158;9278.907210928075;9311.767205819639;9427.952860235655;9464.290178236522;9497.76255593588;9431.622735090794;9659.806803864023;9854.507274636097;9874.061964113398;10008.799824003334;6355.650439225887;6375.58558693702;6515.348465153446;7243.529170603894;7379.889301660372;7746.767596972099;7801.804954876174;7801.9609901950125;7823.608819559113;7852.882206766789;7221.711131554679;7244.094488188976;7388.039554857834;7542.170361260147;7650.617469126632;7184.856302874018;7202.279772022755;7236.276372362721;7249.782506524813;7272.127344718456;7825.491343062683;7826.139124696165;7895.092064412436;7921.920780792118;7923.326517246099;7045.01369808217;7218.169910460364;7268.67290971897;7281.927180728337;7297.890531642136;7071.080759501232;7086.50394472382;7125.964370178116;7129.037579926851;7131.322524360177 18:04:43 INFO - PROCESS | 25157 | |4;prototype.html;322.9402560526303;331.88715836615546;335.055144492531;348.2599476113259;352.9752917295789;6272.059191121329;6324.9367506324925;6384.10622512848;6409.903851442232;6437.35626437356;6307.274663413708;6316.2420509538915;6328.778492752755;6329.620222786636;6356.745730170787;4657.371254880599;4782.545658162487;4785.832495862645;4800.111979283826;4872.585830204428;4777.856664300077;4789.808407663707;4791.664583479158;4792.472827988919;4796.424429068499;4688.460827004904;4735.621150307967;4742.502037286087;4744.335792988984;4747.643926705494;4795;4804.183288840905;4806.231003039515;4810.326554282403;4814.15752243356;4168.3955826405;4174.165166966619;4175.164967006611;4179.686523510719;4185.790710464495;6013.939860601426;6103.23709536308;6115.113308570232;6118.60229085108;6124.601900876429;5491.862703432406;5572.832815015556;5581.246531718207;5582.218489411485;5582.330120385539;6603.042558828991;6665;6684.699188536528;6701.966490167567;6705.832354191136;4543.295789152687;4546.795394207235;4549.294859296781;4552.4764652065105;4558.863234102949;6972.79081627552;6977.267386924351;6999.30006999296;7008.474364422637;7045.225025247219;4626.583607475343;4700.623950083985;4709.317149013374;4712.387389639393;4718.88202794926;4670.9766451167525;4718.363020992122;4726.291056341507;4731.455882573479;4733.124371991193;5459.044667183306;5518.806841760519;5521.475459831309;5523.088690366045;5526.06056970308;6708.19501659804;6716.731330746716;6727.831804204934;6760.18877734675;6776.93223067763;1656.6024154202905;1667.2664027827716;1671.0892563552893;1676.5054308978881;1677.874159438047;1041.6041904076553;1067.8238090714945;1082.880883102858;1087.445402844539;1091.1489038549944;6401.135846660642;6422.366829599841;6466.094746735461;6466.482681385478;6487.091807147003;6987.9301206987275;7001.229864714979;7011.439084873198;7016.193137789118;7020.333068358498;6258.468030217483;6466.935330646727;6497.772577959749;6553.63954982471;6579.046038324512;3802.448644946467;3839.0018595165457;3839.1745774658584;3840.9423858642144;3847.576766555677;7251.311125443074;7258.745943891939;7312.5246858954;7325.487215894943;7341.302576255247;7177.856442871113;7234.819129521698;7236.167840698282;7239.167495737952;7280.635968201569;7066.3993560546905;7263.0921134858145;7280.41756659466;7341.375983041501;7355.7057717690695;7071.36357727807;7083;7090.964545177241;7102.360787528941;7130.714771409085;6970.756023539152;6979.616121113388;6981.406580440516;6985.441164706913;6995.685194166173;7278.199398066103;7300.744473943387;7304.8539029218055;7324.63376831167;7355.043844300207;4696.131215725101;4794.568488836021;4890.731009794496;4904.288878112725;4908.779104940215;7002.614856182959;7016.403605693369;7022.929770702432;7035.507514473938;7039.436845052281;6825.317468253135;6834.179898412222;6874.072000279898;6904.206016307988;6917.584944903322;6787.830304242433;6805.6937437816405;6807.9319206807295;6823.965880170567;6832.111825462658;6444.7744328948265;6678.131842860591;6706.228783689743;6736.562123461959;6742.123523942052;6864.759733409307;6877.793666190022;6878.965605171942;6906.482013848881;6915.619640919797;6682.699278532575;6696.19645642526;6719.395254427125;6722.731090756315;6742.123523942052 18:04:43 INFO - PROCESS | 25157 | |5;yui.html;881.7751473374288;882.7131182365732;896.1844721303615;901.4726385064737;930.7905721212724;12615.684607884796;12868.099233053677;12920.160189587694;13003.284819334933;13010.739785204314;11136.3318200908;11164.330140191594;11199.104071674266;11216.439178041086;11266.267692599995;916.1708653668425;919.0946917286467;931.5528546297747;950.6910254167389;950.7147855643314;925.6575067225102;929.6699671616581;930.2232635749158;931.529577563333;931.8043210925714;966.6230170233614;967.2407160379104;969.8787651543557;972.4554249620236;973;957.6696039866235;965.2663975378692;966.4636126949575;970.6457143142773;970.6457143142773;717.436812102497;720.2365492577884;720.7837648705367;721.1958666087274;722.443718336883;12443.751124977449;12521.311327876963;12543.372831358487;12576.182548134342;12588.307643079626;12410.503579856795;12550.81173782394;12741.579169459093;12767.170133941265;12959.157654752411;10776.73058173544;10939.82252491858;10994.175436842188;11000.504977276041;11122.110231181487;3698.907527311812;3710.406334986389;3755.1550901047044;3767.6609105180664;3785.261873934584;49897;50085.49914500881;50160.49839501595;50160.74919625378;50341;9381.484018379055;9429.2928030398;9536.666216682383;9564.856527152098;9998.950005250073;15113.848861511464;15144.318505667272;15162;15163.393464261526;15167.24163791806;7017.4035207006955;7074.398676112485;7124.358807707227;7367.447441441914;7422.703091876372;4096.979515102465;4109.034376921421;4124.566920473307;4128.979355103265;4194.769287689145;3092;3111.0355789705263;3115.345777386774;3130.4365214261197;3140.105070055023;597.8146774499919;604.0908432808683;606.6147996022557;608.5952841360535;612.1002126873489;684.2712511175582;688.8656711941223;694.9478789090839;699.0737273113044;701.680735265453;7898.210178982055;8016.639251233709;8017.719379821679;8035.839283214303;8236.094029656733;490.66389523176736;636.3223167326782;644.7749276374832;672.9125213722283;722.6025685872748;3609.9278014439565;3629.4192929131214;3649.59854416014;3756.079760458705;3768.660820526111;57379;58139;58596.70701646464;58718;58874.411255887746;49168.26247606289;51737;52509.47490525122;52648;52808.47191528112;45974.5402545977;46307.30539041917;46636.300455493874;46996.29505557419;47103.29345059827;7937.6031198438695;8196.385271104571;8417.537035462863;8422.031466381444;8519.91480085216;34516.82741586276;34835;36021.81989090038;36361;36365.272694545434;45249;45294.54705452903;52435.16476923289;54496;58116;12194.207376520499;12204.633860984184;12498;12526.123171377916;12845.293508857103;12076.45655945467;12102.394880256128;12235.571754988532;12257.38713064361;12314.384280785745;11865.28808271472;11869.347185904859;11901.82147267809;11902.40487975615;11950.641480755592;11909.166358354832;11962;12060.095492838247;12078.51685932553;12129.878701212874;11310.94344528272;11373.43132843338;11413;11450.312981221154;11472.770544588895;9463.526823658653;9507.382020168667;9544.713658590254;9637.71086867395;9761;9714.902850971399;9857.852132217879;9880.40717556949;9913.801723965624;9933.950330248303 18:04:43 INFO - PROCESS | 25157 | __end_tp_report 18:04:43 INFO - PROCESS | 25157 | __start_cc_report 18:04:43 INFO - PROCESS | 25157 | _x_x_mozilla_cycle_collect,338 18:04:43 INFO - PROCESS | 25157 | __end_cc_report 18:04:43 INFO - PROCESS | 25157 | __startTimestamp1460768683533__endTimestamp 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | ------- Summary: start ------- 18:04:43 INFO - PROCESS | 25157 | Number of tests: 6 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | [#0] dojo.html Cycles:165 Average:5470.36 Median:5676.06 stddev:598.01 (10.5%) stddev-sans-first:574.55 18:04:43 INFO - PROCESS | 25157 | Values: 3276.8 3322.6 3352.8 3366.4 3399.9 5431.3 5446.5 5465.4 5467.5 5477.4 5462.8 5483.1 5486.4 5505.3 5506.1 4996.4 5023.1 5098.2 5107.5 5122.6 4868.4 4987.8 5054.5 5065.3 5114.4 5044.4 5071.6 5117.8 5134.2 5154.5 5051.1 5051.6 5056.4 5078.9 5105.3 4898.9 4907.8 4968.3 4991.6 5059.5 5237.4 5286.3 5290.4 5316.9 5351.1 5814.6 5842.3 5847.6 5850.1 5850.6 5750.1 5923.4 5953.0 5973.1 6008.5 5469.2 5486.2 5487.0 5491.5 5518.1 5989.5 5990.0 6009.1 6015.9 6030.2 5634.9 5797.5 5801.8 5843.1 5918.7 5851.4 5855.2 5857.2 5857.7 5906.2 5822.5 5825.5 5829.9 5853.0 5854.7 5770.4 5821.8 5912.8 5913.2 5946.8 4449.4 4450.1 4479.3 4502.5 4520.1 4016.3 4050.6 4057.9 4068.7 4096.0 5493.8 5551.5 5668.5 5700.9 5707.9 5921.3 5930.1 5930.5 5958.6 5970.5 5462.1 5536.2 5550.9 5592.6 5600.6 4963.1 4998.2 5063.0 5071.9 5075.2 6018.5 6091.2 6091.8 6117.5 6137.4 5835.2 5922.6 5942.6 5956.3 5963.0 5925.7 5991.0 5991.6 5995.6 6035.4 5854.9 5900.2 5902.2 5904.6 5924.9 5743.4 5917.3 5971.9 5980.3 5997.5 5794.4 5806.2 5850.7 5854.7 5887.4 5691.2 5721.6 5734.3 5741.2 5757.3 5522.6 5523.5 5617.8 5628.3 5676.1 5716.5 5753.5 5773.7 5775.7 5776.8 5612.8 5633.7 5637.0 5653.2 5680.7 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | [#1] ext.html Cycles:180 Average:49530.74 Median:22845.76 stddev:78992.66 (345.8%) stddev-sans-first:79128.61 18:04:43 INFO - PROCESS | 25157 | Values: 540.9 574.2 582.9 588.0 614.4 37733.5 38265.8 38285.8 38425.4 38694.8 42070.8 42693.1 42724.4 42725.0 42898.0 8798.4 8917.0 8968.5 8975.5 9012.6 8764.9 8898.6 8919.2 9224.9 9246.1 9180.8 9303.9 9305.2 9306.5 9324.8 9172.2 9249.9 9255.0 9273.2 9289.2 9174.2 9320.7 9322.1 9344.4 9350.2 39191.0 39567.2 39645.4 39681.6 39699.4 3591.7 3732.6 3743.9 3792.4 3904.5 29079.6 29136.7 29207.3 29260.7 29470.6 4144.4 4244.6 4256.1 4330.2 4342.9 301019.0 301105.0 302291.0 302688.5 306661.0 69023.3 69215.7 69242.3 69617.3 69638.7 73059.0 74102.0 74214.3 74591.3 74662.0 17129.6 17161.5 17220.1 17338.7 17401.2 12893.1 12909.4 12920.0 12927.9 12930.7 22334.7 22389.6 22462.6 22476.7 22497.7 8004.9 8062.8 8336.2 8444.4 8474.9 1076.1 1084.0 1123.6 1129.7 1158.1 30184.2 30785.8 30915.4 31123.2 31401.1 1180.7 1215.5 1216.9 1221.5 1230.9 15835.1 15922.3 16147.9 16176.2 16353.3 324056.0 345094.0 346537.0 349117.0 354930.0 52601.7 53564.5 53572.0 53595.7 53768.7 1460.1 1495.7 1504.2 1505.2 1512.4 30312.5 31714.0 31890.8 31976.4 32276.0 51797.7 54353.7 56328.0 56450.2 56502.0 251241.0 253453.0 254452.0 254467.0 254742.0 42652.8 43171.6 43286.0 43372.8 43522.8 45703.3 45918.5 46400.8 46596.0 46800.8 42499.4 42893.8 43208.6 43606.6 43760.6 41901.2 42341.6 42720.0 42775.1 43030.6 41547.2 41702.0 42502.4 42529.4 42636.6 36794.6 36844.9 36913.6 37287.8 37829.6 27976.4 28699.3 29017.9 29232.3 29320.6 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | [#2] jquery.html Cycles:180 Average:25887.16 Median:36131.55 stddev:71380.51 (197.6%) stddev-sans-first:71555.00 18:04:43 INFO - PROCESS | 25157 | Values: 353.7 360.7 368.5 378.9 379.3 17235.0 17874.0 19095.5 19108.9 19114.8 17278.7 17771.6 17808.8 17944.6 17945.0 5310.1 5498.3 5531.9 5532.1 5545.6 4160.1 5392.9 5669.8 5896.0 5906.9 5815.8 5821.4 5825.4 5837.0 5866.7 5874.5 5992.0 6003.1 6025.4 6089.1 5156.5 5177.2 5178.1 5187.8 5212.2 21247.7 21538.0 21591.9 21617.9 21756.6 2372.0 2380.1 3020.2 3106.9 3134.6 9542.3 9830.1 9893.4 13184.9 14047.4 1935.6 2002.2 2010.2 2027.6 2050.9 60489.7 61908.0 67620.0 68751.3 69898.0 10003.5 10315.7 10514.7 10523.1 10529.0 14611.0 14667.2 14681.6 14715.5 14738.9 7623.9 7792.6 7843.5 7854.6 7929.1 7511.7 7655.0 7670.3 7704.5 7711.4 4531.6 4545.0 4614.4 4639.2 4663.6 1783.6 1812.5 1831.8 1853.0 1935.6 959.9 960.1 990.2 1025.3 1047.3 16983.7 17350.5 17516.1 17699.0 18000.8 983.0 997.6 1006.1 1013.3 1041.4 9949.8 10008.2 10114.5 10117.5 10171.2 425439.0 429703.0 436805.0 439900.0 441420.0 76691.0 77028.2 77720.6 78671.6 79570.6 1032.9 1040.3 1052.3 1054.3 1055.1 15644.9 15705.0 15762.2 15870.9 16061.3 35638.6 35752.3 36090.0 36173.1 36547.0 48821.0 50693.5 51132.0 51213.7 51318.2 8527.4 8593.2 8612.6 8749.3 8787.3 9948.2 11117.9 12574.4 12874.9 13054.6 10471.4 10545.4 10980.6 11133.3 11233.2 5006.3 9242.7 9672.0 11067.2 11745.8 11184.3 11321.8 11426.6 11628.5 11867.5 8266.3 8400.7 8430.7 8468.7 8557.6 9795.4 10799.9 10853.0 10857.2 11061.1 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | [#3] mootools.html Cycles:180 Average:5987.47 Median:5814.52 stddev:3201.26 (55.1%) stddev-sans-first:3192.86 18:04:43 INFO - PROCESS | 25157 | Values: 1548.9 1578.0 1838.0 1958.5 1989.6 7610.0 7749.3 8545.7 8747.3 8758.9 8072.2 8292.5 8437.5 8554.0 8585.8 2451.7 2479.8 2482.6 2496.4 2505.2 2496.5 2527.0 2537.5 2542.1 2546.2 2404.4 2428.9 2446.0 2447.6 2461.0 2506.7 2507.8 2510.7 2527.6 2531.6 2452.2 2461.3 2472.8 2473.5 2474.5 8814.3 8828.0 8842.3 8847.6 8853.4 5238.5 5405.7 5415.2 5454.2 5454.8 3287.1 3308.8 3318.8 3352.4 3394.7 958.9 974.7 978.2 981.3 999.9 12048.4 12158.3 12166.6 12252.4 12287.8 4445.8 4484.6 4564.1 4580.0 4611.8 9636.5 9711.7 9715.6 9721.6 9769.5 5299.3 5309.9 5312.9 5321.4 5325.4 4258.2 4709.3 4712.3 4764.7 4925.2 3588.8 3605.7 3654.4 3674.9 3698.7 1034.1 1047.1 1048.9 1052.8 1060.8 1508.7 1525.9 1527.4 1538.7 1551.1 8217.1 8344.6 8357.3 8371.8 8401.5 515.2 519.7 523.4 529.1 534.0 6174.2 6229.6 6238.3 6250.6 6311.6 10313.6 10780.3 10811.8 10815.4 10930.6 10384.2 10649.0 10697.4 10739.5 10743.2 8265.0 8360.7 8379.7 8450.2 8455.8 7947.6 7955.5 8045.2 8086.0 8112.6 9278.9 9311.8 9428.0 9464.3 9497.8 9431.6 9659.8 9854.5 9874.1 10008.8 6355.7 6375.6 6515.3 7243.5 7379.9 7746.8 7801.8 7802.0 7823.6 7852.9 7221.7 7244.1 7388.0 7542.2 7650.6 7184.9 7202.3 7236.3 7249.8 7272.1 7825.5 7826.1 7895.1 7921.9 7923.3 7045.0 7218.2 7268.7 7281.9 7297.9 7071.1 7086.5 7126.0 7129.0 7131.3 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | [#4] prototype.html Cycles:180 Average:5648.60 Median:6416.14 stddev:1740.96 (27.1%) stddev-sans-first:1699.34 18:04:43 INFO - PROCESS | 25157 | Values: 322.9 331.9 335.1 348.3 353.0 6272.1 6324.9 6384.1 6409.9 6437.4 6307.3 6316.2 6328.8 6329.6 6356.7 4657.4 4782.5 4785.8 4800.1 4872.6 4777.9 4789.8 4791.7 4792.5 4796.4 4688.5 4735.6 4742.5 4744.3 4747.6 4795.0 4804.2 4806.2 4810.3 4814.2 4168.4 4174.2 4175.2 4179.7 4185.8 6013.9 6103.2 6115.1 6118.6 6124.6 5491.9 5572.8 5581.2 5582.2 5582.3 6603.0 6665.0 6684.7 6702.0 6705.8 4543.3 4546.8 4549.3 4552.5 4558.9 6972.8 6977.3 6999.3 7008.5 7045.2 4626.6 4700.6 4709.3 4712.4 4718.9 4671.0 4718.4 4726.3 4731.5 4733.1 5459.0 5518.8 5521.5 5523.1 5526.1 6708.2 6716.7 6727.8 6760.2 6776.9 1656.6 1667.3 1671.1 1676.5 1677.9 1041.6 1067.8 1082.9 1087.4 1091.1 6401.1 6422.4 6466.1 6466.5 6487.1 6987.9 7001.2 7011.4 7016.2 7020.3 6258.5 6466.9 6497.8 6553.6 6579.0 3802.4 3839.0 3839.2 3840.9 3847.6 7251.3 7258.7 7312.5 7325.5 7341.3 7177.9 7234.8 7236.2 7239.2 7280.6 7066.4 7263.1 7280.4 7341.4 7355.7 7071.4 7083.0 7091.0 7102.4 7130.7 6970.8 6979.6 6981.4 6985.4 6995.7 7278.2 7300.7 7304.9 7324.6 7355.0 4696.1 4794.6 4890.7 4904.3 4908.8 7002.6 7016.4 7022.9 7035.5 7039.4 6825.3 6834.2 6874.1 6904.2 6917.6 6787.8 6805.7 6807.9 6824.0 6832.1 6444.8 6678.1 6706.2 6736.6 6742.1 6864.8 6877.8 6879.0 6906.5 6915.6 6682.7 6696.2 6719.4 6722.7 6742.1 18:04:43 INFO - PROCESS | 25157 | 18:04:43 INFO - PROCESS | 25157 | [#5] yui.html Cycles:180 Average:13988.25 Median:50123.00 stddev:16580.83 (33.1%) stddev-sans-first:16598.13 18:04:43 INFO - PROCESS | 25157 | Values: 881.8 882.7 896.2 901.5 930.8 12615.7 12868.1 12920.2 13003.3 13010.7 11136.3 11164.3 11199.1 11216.4 11266.3 916.2 919.1 931.6 950.7 950.7 925.7 929.7 930.2 931.5 931.8 966.6 967.2 969.9 972.5 973.0 957.7 965.3 966.5 970.6 970.6 717.4 720.2 720.8 721.2 722.4 12443.8 12521.3 12543.4 12576.2 12588.3 12410.5 12550.8 12741.6 12767.2 12959.2 10776.7 10939.8 10994.2 11000.5 11122.1 3698.9 3710.4 3755.2 3767.7 3785.3 49897.0 50085.5 50160.5 50160.7 50341.0 9381.5 9429.3 9536.7 9564.9 9999.0 15113.8 15144.3 15162.0 15163.4 15167.2 7017.4 7074.4 7124.4 7367.4 7422.7 4097.0 4109.0 4124.6 4129.0 4194.8 3092.0 3111.0 3115.3 3130.4 3140.1 597.8 604.1 606.6 608.6 612.1 684.3 688.9 694.9 699.1 701.7 7898.2 8016.6 8017.7 8035.8 8236.1 490.7 636.3 644.8 672.9 722.6 3609.9 3629.4 3649.6 3756.1 3768.7 57379.0 58139.0 58596.7 58718.0 58874.4 49168.3 51737.0 52509.5 52648.0 52808.5 45974.5 46307.3 46636.3 46996.3 47103.3 7937.6 8196.4 8417.5 8422.0 8519.9 34516.8 34835.0 36021.8 36361.0 36365.3 45249.0 45294.5 52435.2 54496.0 58116.0 12194.2 12204.6 12498.0 12526.1 12845.3 12076.5 12102.4 12235.6 12257.4 12314.4 11865.3 11869.3 11901.8 11902.4 11950.6 11909.2 11962.0 12060.1 12078.5 12129.9 11310.9 11373.4 11413.0 11450.3 11472.8 9463.5 9507.4 9544.7 9637.7 9761.0 9714.9 9857.9 9880.4 9913.8 9934.0 18:04:43 INFO - PROCESS | 25157 | -------- Summary: end -------- 18:04:43 INFO - PROCESS | 25157 | 18:04:44 INFO - TEST-INFO | 25157: exit 0 18:04:44 INFO - TEST-OK | dromaeo_css | took 1109589ms 18:04:44 INFO - TEST-START | kraken 18:04:44 INFO - operating with platform_type : linux_ 18:04:44 INFO - Initialising browser for kraken test... 18:04:44 INFO - TEST-INFO | started process 25401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGf5UvD/profile http://localhost:60457/getInfo.html) 18:04:47 INFO - PROCESS | 25401 | 18:04:47 INFO - PROCESS | 25401 | (process:25476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:04:48 INFO - PROCESS | 25401 | __metrics Screen width/height:1600/1200 18:04:48 INFO - PROCESS | 25401 | colorDepth:24 18:04:48 INFO - PROCESS | 25401 | Browser inner width/height: 1024/697 18:04:48 INFO - PROCESS | 25401 | __metrics 18:04:49 ERROR - PROCESS | 25401 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:04:50 INFO - TEST-INFO | 25401: exit 0 18:04:50 INFO - Browser initialized. 18:04:50 INFO - Running cycle 1/1 for kraken test... 18:04:50 INFO - TEST-INFO | started process 25527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGf5UvD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:52 INFO - PROCESS | 25527 | 18:04:52 INFO - PROCESS | 25527 | (process:25593): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:05:02 INFO - PROCESS | 25527 | RSS: Main: 151302144 18:05:02 INFO - PROCESS | 25527 | 18:05:04 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60457/tests/kraken/driver.html?testName=audio-beat-detection) 18:05:05 INFO - PROCESS | 25527 | RSS: Main: 156344320 18:05:05 INFO - PROCESS | 25527 | 18:05:08 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60457/tests/kraken/driver.html?testName=audio-dft) 18:05:08 INFO - PROCESS | 25527 | RSS: Main: 155574272 18:05:08 INFO - PROCESS | 25527 | 18:05:11 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60457/tests/kraken/driver.html?testName=audio-fft) 18:05:12 INFO - PROCESS | 25527 | RSS: Main: 155783168 18:05:12 INFO - PROCESS | 25527 | 18:05:14 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60457/tests/kraken/driver.html?testName=audio-oscillator) 18:05:14 INFO - PROCESS | 25527 | RSS: Main: 155480064 18:05:14 INFO - PROCESS | 25527 | 18:05:17 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60457/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:05:17 INFO - PROCESS | 25527 | RSS: Main: 156463104 18:05:17 INFO - PROCESS | 25527 | 18:05:20 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60457/tests/kraken/driver.html?testName=imaging-darkroom) 18:05:21 INFO - PROCESS | 25527 | RSS: Main: 156532736 18:05:21 INFO - PROCESS | 25527 | 18:05:24 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60457/tests/kraken/driver.html?testName=imaging-desaturate) 18:05:25 INFO - PROCESS | 25527 | RSS: Main: 156749824 18:05:25 INFO - PROCESS | 25527 | 18:05:28 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60457/tests/kraken/driver.html?testName=json-parse-financial) 18:05:28 INFO - PROCESS | 25527 | RSS: Main: 156835840 18:05:28 INFO - PROCESS | 25527 | 18:05:30 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60457/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:05:30 INFO - PROCESS | 25527 | RSS: Main: 156745728 18:05:30 INFO - PROCESS | 25527 | 18:05:32 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:05:33 INFO - PROCESS | 25527 | RSS: Main: 157601792 18:05:33 INFO - PROCESS | 25527 | 18:05:35 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:05:35 INFO - PROCESS | 25527 | RSS: Main: 156975104 18:05:35 INFO - PROCESS | 25527 | 18:05:38 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:05:38 INFO - PROCESS | 25527 | RSS: Main: 157011968 18:05:38 INFO - PROCESS | 25527 | 18:05:41 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:05:42 INFO - PROCESS | 25527 | RSS: Main: 156856320 18:05:42 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | Cycle 1(1): loaded http://localhost:60457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60457/tests/kraken/driver.html?testName=ai-astar) 18:05:43 INFO - PROCESS | 25527 | RSS: Main: 158605312 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | __start_tp_report 18:05:43 INFO - PROCESS | 25527 | _x_x_mozilla_page_load 18:05:43 INFO - PROCESS | 25527 | _x_x_mozilla_page_load_details 18:05:43 INFO - PROCESS | 25527 | |i|pagename|runs| 18:05:43 INFO - PROCESS | 25527 | |0;ai-astar;109;103;110;109;110;120;111;111;111;110 18:05:43 INFO - PROCESS | 25527 | |1;audio-beat-detection;156;128;164;173;128;153;160;130;166;128 18:05:43 INFO - PROCESS | 25527 | |2;audio-dft;163;162;165;164;162;162;163;164;165;162 18:05:43 INFO - PROCESS | 25527 | |3;audio-fft;73;76;74;161;73;77;76;72;172;78 18:05:43 INFO - PROCESS | 25527 | |4;audio-oscillator;93;92;141;95;92;93;147;93;93;139 18:05:43 INFO - PROCESS | 25527 | |5;imaging-gaussian-blur;117;118;116;118;118;118;118;118;117;117 18:05:43 INFO - PROCESS | 25527 | |6;imaging-darkroom;148;147;147;147;147;147;147;148;148;147 18:05:43 INFO - PROCESS | 25527 | |7;imaging-desaturate;97;96;96;101;96;97;96;96;96;96 18:05:43 INFO - PROCESS | 25527 | |8;json-parse-financial;54;56;58;56;56;55;58;61;54;56 18:05:43 INFO - PROCESS | 25527 | |9;json-stringify-tinderbox;64;67;65;65;65;67;65;65;65;65 18:05:43 INFO - PROCESS | 25527 | |10;stanford-crypto-aes;79;80;81;79;79;79;79;79;79;81 18:05:43 INFO - PROCESS | 25527 | |11;stanford-crypto-ccm;117;114;127;114;117;123;118;122;122;114 18:05:43 INFO - PROCESS | 25527 | |12;stanford-crypto-pbkdf2;138;142;145;141;152;149;142;142;143;145 18:05:43 INFO - PROCESS | 25527 | |13;stanford-crypto-sha256-iterative;69;71;66;68;68;69;64;68;69;66 18:05:43 INFO - PROCESS | 25527 | __end_tp_report 18:05:43 INFO - PROCESS | 25527 | __start_cc_report 18:05:43 INFO - PROCESS | 25527 | _x_x_mozilla_cycle_collect,826 18:05:43 INFO - PROCESS | 25527 | __end_cc_report 18:05:43 INFO - PROCESS | 25527 | __startTimestamp1460768743952__endTimestamp 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | ------- Summary: start ------- 18:05:43 INFO - PROCESS | 25527 | Number of tests: 14 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:4.12 (3.7%) stddev-sans-first:4.33 18:05:43 INFO - PROCESS | 25527 | Values: 109.0 103.0 110.0 109.0 110.0 120.0 111.0 111.0 111.0 110.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:158.00 stddev:18.13 (11.5%) stddev-sans-first:19.03 18:05:43 INFO - PROCESS | 25527 | Values: 156.0 128.0 164.0 173.0 128.0 153.0 160.0 130.0 166.0 128.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.23 (0.8%) stddev-sans-first:1.30 18:05:43 INFO - PROCESS | 25527 | Values: 163.0 162.0 165.0 164.0 162.0 162.0 163.0 164.0 165.0 162.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.77 (51.7%) stddev-sans-first:40.42 18:05:43 INFO - PROCESS | 25527 | Values: 73.0 76.0 74.0 161.0 73.0 77.0 76.0 72.0 172.0 78.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.92 (25.7%) stddev-sans-first:24.77 18:05:43 INFO - PROCESS | 25527 | Values: 93.0 92.0 141.0 95.0 92.0 93.0 147.0 93.0 93.0 139.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 18:05:43 INFO - PROCESS | 25527 | Values: 117.0 118.0 116.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 18:05:43 INFO - PROCESS | 25527 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.57 (1.6%) stddev-sans-first:1.66 18:05:43 INFO - PROCESS | 25527 | Values: 97.0 96.0 96.0 101.0 96.0 97.0 96.0 96.0 96.0 96.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.12 (3.8%) stddev-sans-first:2.06 18:05:43 INFO - PROCESS | 25527 | Values: 54.0 56.0 58.0 56.0 56.0 55.0 58.0 61.0 54.0 56.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.88 18:05:43 INFO - PROCESS | 25527 | Values: 64.0 67.0 65.0 65.0 65.0 67.0 65.0 65.0 65.0 65.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 18:05:43 INFO - PROCESS | 25527 | Values: 79.0 80.0 81.0 79.0 79.0 79.0 79.0 79.0 79.0 81.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:120.00 stddev:4.49 (3.7%) stddev-sans-first:4.72 18:05:43 INFO - PROCESS | 25527 | Values: 117.0 114.0 127.0 114.0 117.0 123.0 118.0 122.0 122.0 114.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:144.00 stddev:4.07 (2.8%) stddev-sans-first:3.71 18:05:43 INFO - PROCESS | 25527 | Values: 138.0 142.0 145.0 141.0 152.0 149.0 142.0 142.0 143.0 145.0 18:05:43 INFO - PROCESS | 25527 | 18:05:43 INFO - PROCESS | 25527 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.99 (2.9%) stddev-sans-first:2.06 18:05:43 INFO - PROCESS | 25527 | Values: 69.0 71.0 66.0 68.0 68.0 69.0 64.0 68.0 69.0 66.0 18:05:43 INFO - PROCESS | 25527 | -------- Summary: end -------- 18:05:43 INFO - PROCESS | 25527 | 18:05:44 INFO - TEST-INFO | 25527: exit 0 18:05:44 INFO - TEST-OK | kraken | took 60667ms 18:05:44 INFO - SUITE-END | took 1170s 18:05:45 INFO - Completed test suite (00:19:30) 18:05:45 INFO - javascript benchmark 18:05:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3276.787008844425, 3322.5680661513998, 3352.8491217895194, 3366.377220214259, 3399.9490007649874, 5431.321084864392, 5446.509814116729, 5465.426130256325, 5467.507924286813, 5477.424870388607, 5462.808801691942, 5483.122700367942, 5486.396496385394, 5505.3393592768825, 5506.119020956648, 4996.400431948171, 5023.14606516893, 5098.235264710286, 5107.514786095334, 5122.641415100926, 4868.415790105192, 4987.75061246938, 5054.494550544934, 5065.265536497206, 5114.411842638088, 5044.394672639289, 5071.619628527875, 5117.769700363493, 5134.229865520165, 5154.536091751742, 5051.141305977974, 5051.621128415365, 5056.367954005749, 5078.898422031539, 5105.336306280197, 4898.853034408938, 4907.779149938261, 4968.279599458095, 4991.575716064139, 5059.519345662156, 5237.423883372826, 5286.3127793387, 5290.444503327172, 5316.9202461963105, 5351.063563876306, 5814.563907706896, 5842.298924129132, 5847.590668653196, 5850.0932355484965, 5850.6489610623075, 5750.137479378085, 5923.378045305224, 5952.9702351488395, 5973.1040343948325, 6008.519318454557, 5469.234307196995, 5486.177073439016, 5486.984907792072, 5491.533219676332, 5518.117101263819, 5989.490893274121, 5989.970050149721, 6009.06859436788, 6015.879682406327, 6030.216071910623, 5634.915476267859, 5797.536197104221, 5801.82594522165, 5843.065109582446, 5918.674472903946, 5851.444112809277, 5855.151003104611, 5857.238558987305, 5857.70711464425, 5906.232189815297, 5822.534197264209, 5825.475707186373, 5829.854253643693, 5853.03424934881, 5854.736536855852, 5770.365259821417, 5821.767129314865, 5912.793052243151, 5913.201717768132, 5946.791862284886, 4449.354843547732, 4450.109978004412, 4479.283314669702, 4502.482214545304, 4520.141173177086, 4016.2971479990883, 4050.5746896576024, 4057.878263652095, 4068.7355321903983, 4095.9590404096175, 5493.807716729895, 5551.528120109755, 5668.51817595509, 5700.8859822803315, 5707.914381284284, 5921.348651648315, 5930.080837470199, 5930.466258036798, 5958.582899197015, 5970.522358211333, 5462.126059830408, 5536.169574563848, 5550.888982220333, 5592.5805564582815, 5600.607957443021, 4963.057019166346, 4998.200287953982, 5063.0380227756605, 5071.949280507148, 5075.162598171334, 6018.488428483628, 6091.2081429414775, 6091.8477038073515, 6117.480014198754, 6137.447629713347, 5835.2122463466885, 5922.615030023035, 5942.554308426799, 5956.315023772322, 5962.999999999914, 5925.733341999534, 5991.041433370639, 5991.550633702577, 5995.5803093783015, 6035.36628653985, 5854.882902342015, 5900.203472531153, 5902.203202567598, 5904.61619994699, 5924.881502369843, 5743.368229494668, 5917.319508256605, 5971.940280597139, 5980.34216236205, 5997.520198384206, 5794.449527295069, 5806.2451881255165, 5850.7074646266665, 5854.707264636666, 5887.411258874078, 5691.174779656843, 5721.628094173865, 5734.254546909042, 5741.196232527366, 5757.3379061406795, 5522.6134170607675, 5523.502884740393, 5617.831465055891, 5628.268325117709, 5676.063449530946, 5716.514096301695, 5753.482186603226, 5773.711314434346, 5775.6823374714795, 5776.826695199151, 5612.7754889803955, 5633.746481408429, 5637.041702910433, 5653.2085508028085, 5680.71596420169], "unit": "score", "name": "dojo.html", "value": 5432.282596832089}, {"lowerIsBetter": false, "replicates": [540.9459054094589, 574.1588572740931, 582.8834233153369, 588.0444081696872, 614.4101662404092, 37733.49066037359, 38265.80867095664, 38285.80857095711, 38425.42361864574, 38694.806525967404, 42070.7896460518, 42693.14613707724, 42724.359134613005, 42725.0, 42898.0, 8798.428102173355, 8916.955415222916, 8968.50673212973, 8975.46147231165, 9012.639494420215, 8764.8685269721, 8898.555072246394, 8919.152680495376, 9224.8616270756, 9246.121618446237, 9180.770480738001, 9303.906960930406, 9305.162535371848, 9306.488143152124, 9324.766880827965, 9172.174504294611, 9249.907500925006, 9255.0, 9273.165415112604, 9289.163975242192, 9174.174324310778, 9320.72037838866, 9322.06779322069, 9344.439333639935, 9350.158485736316, 39191.0, 39567.20865582701, 39645.40531892024, 39681.60318396837, 39699.40450893239, 3591.730620203495, 3732.6267373262726, 3743.9251214975548, 3792.431135329695, 3904.4728961590104, 29079.56380654292, 29136.70863291361, 29207.269818254503, 29260.70739292601, 29470.557941630894, 4144.357624568197, 4244.554321796198, 4256.106217694288, 4330.220560299145, 4342.891427714301, 301019.0, 301105.0, 302291.0, 302688.486557568, 306661.0, 69023.30976690269, 69215.65392173007, 69242.30757692359, 69617.30382696108, 69638.65180674064, 73059.0, 74102.0, 74214.25785742073, 74591.25408745951, 74662.0, 17129.571760705832, 17161.485155445356, 17220.05289709053, 17338.653226935392, 17401.216945237495, 12893.097483176276, 12909.419076141596, 12920.0, 12927.870721292855, 12930.741385172243, 22334.664980025314, 22389.552208956055, 22462.55074898493, 22476.662850057262, 22497.650140991595, 8004.879926801103, 8062.7581172564915, 8336.249737523653, 8444.366672499587, 8474.92364370733, 1076.128336047788, 1084.002717499902, 1123.646051493777, 1129.6949823547595, 1158.1314014489133, 30184.24539386533, 30785.8460707695, 30915.381692366478, 31123.221919452193, 31401.05796826099, 1180.722530205401, 1215.538095523713, 1216.914815962892, 1221.4930803716536, 1230.9076819238594, 15835.129067901145, 15922.283497242652, 16147.919260403623, 16176.191190440666, 16353.345866165459, 324056.0, 345094.0, 346537.0, 349117.0, 354930.0, 52601.73699131556, 53564.46435535595, 53572.0, 53595.732021339645, 53768.73115634475, 1460.0874453466583, 1495.7008598280388, 1504.2328412509698, 1505.2097648734284, 1512.37992423106, 30312.54531182078, 31714.0, 31890.84054579805, 31976.36047279088, 32276.031719048467, 51797.741011294704, 54353.72823135859, 56328.0, 56450.15324770214, 56502.0, 251241.0, 253453.0, 254452.0, 254467.0, 254742.0, 42652.78673606612, 43171.56828431801, 43286.0, 43372.783136084116, 43522.78238608786, 45703.314450283935, 45918.540814591426, 46400.767996159804, 46596.0, 46800.7659961698, 42499.37565556215, 42893.78553107214, 43208.56791432171, 43606.56393436025, 43760.56239437565, 41901.1619767609, 42341.576584234994, 42720.0, 42775.14449711051, 43030.569694302656, 41547.16905661931, 41702.0, 42502.362464563674, 42529.36205956851, 42636.57363426326, 36794.632053680194, 36844.912056858244, 36913.63086369102, 37287.81356093202, 37829.621703782606, 27976.44047119087, 28699.28251793722, 29017.854910725313, 29232.26919327034, 29320.56019159757], "unit": "score", "name": "ext.html", "value": 20200.909852407593}, {"lowerIsBetter": false, "replicates": [353.69405464273405, 360.7474767662635, 368.4951616285689, 378.86171547385214, 379.28504768511345, 17235.0, 17874.0, 19095.52261193471, 19108.90445547774, 19114.808851911475, 17278.740818887727, 17771.55571110723, 17808.821911780877, 17944.64110717785, 17945.0, 5310.123829568117, 5498.340199176105, 5531.917021244664, 5532.059549876531, 5545.584081193906, 4160.084781348114, 5392.91910621341, 5669.773209071653, 5895.9705201473935, 5906.852328691774, 5815.767369305223, 5821.417858214187, 5825.44658257467, 5836.970815145918, 5866.70666466675, 5874.530037596982, 5992.0, 6003.129546215818, 6025.397460253984, 6089.0866370044405, 5156.484351564851, 5177.249298851683, 5178.119719647669, 5187.844364669066, 5212.244224587414, 21247.68128478074, 21538.0, 21591.892040539853, 21617.891910540504, 21756.564868702695, 2371.988140059306, 2380.071772008918, 3020.2449387653087, 3106.891258805931, 3134.6238451385752, 9542.33203675743, 9830.115289623967, 9893.35693179941, 13184.934075329562, 14047.367868445945, 1935.632229876319, 2002.159093180853, 2010.2160157538572, 2027.6248893954519, 2050.928217512395, 60489.69755151196, 61908.0, 67620.0, 68751.3124868755, 69897.95153072759, 10003.549840257207, 10315.690529284133, 10514.684559463076, 10523.105536029523, 10529.0, 14611.0, 14667.193304368362, 14681.632959175893, 14715.484958026418, 14738.852611473749, 7623.894535292462, 7792.610369481503, 7843.5293882366095, 7854.567998760009, 7929.088154862265, 7511.699532018767, 7655.0, 7670.348020418327, 7704.460687751804, 7711.421643376769, 4531.614812740954, 4544.954550454453, 4614.353990441341, 4639.164950308977, 4663.556962088596, 1783.563027058379, 1812.4959475702867, 1831.7678898352156, 1852.9629407411776, 1935.55482239083, 959.8512230604267, 960.0831206198064, 990.2177279948904, 1025.2874252394515, 1047.3087762077146, 16983.66032679364, 17350.47948561545, 17516.12419379026, 17699.02655353942, 18000.819991799915, 982.9950850245846, 997.6458357283205, 1006.094514936563, 1013.3261381181431, 1041.401194313273, 9949.80100397988, 10008.249381296286, 10114.54484548197, 10117.494125293706, 10171.237157213238, 425439.0, 429703.0, 436805.0, 439900.0, 441420.0, 76691.0, 77028.22971770323, 77720.61139694265, 78671.60664196643, 79570.6021469889, 1032.8915463876185, 1040.3029969920171, 1052.3475445223858, 1054.3041592548882, 1055.0820785916148, 15644.92177539105, 15704.953592866601, 15762.211889405713, 15870.9206453967, 16061.27724252388, 35638.64361356457, 35752.284954301285, 36090.0, 36173.0956726084, 36547.0, 48821.0, 50693.49306506888, 51132.0, 51213.74393128011, 51318.23022654738, 8527.445716028438, 8593.226609605166, 8612.612432440681, 8749.343799215212, 8787.253083487974, 9948.154406875497, 11117.94441027822, 12574.371281436075, 12874.871251287743, 13054.608361749162, 10471.42407167613, 10545.367277963347, 10980.560777568808, 11133.332000080021, 11233.157513186381, 5006.324146240211, 9242.676506322246, 9672.0, 11067.169962253025, 11745.823812642646, 11184.328940263611, 11321.773564528829, 11426.600068997544, 11628.476718547516, 11867.525298988288, 8266.256036956704, 8400.663973441238, 8430.704925327584, 8468.66125354979, 8557.614907329309, 9795.363301385387, 10799.946000269949, 10853.0, 10857.185711071543, 11061.11511079128], "unit": "score", "name": "jquery.html", "value": 8770.615584240077}, {"lowerIsBetter": false, "replicates": [1548.860602545771, 1577.9921100394497, 1837.972430413544, 1958.5103724068983, 1989.5921336126096, 7610.0, 7749.30256276935, 8545.658173673053, 8747.256483198928, 8758.91241087589, 8072.233137851895, 8292.460990035643, 8437.535935523543, 8554.0, 8585.828283434328, 2451.6690246816675, 2479.752024797524, 2482.553140434721, 2496.4383013821835, 2505.2108585795418, 2496.450780828215, 2526.9747302526926, 2537.5432422164004, 2542.148380292604, 2546.2106746908426, 2404.422938494766, 2428.878556072198, 2446.0338166424253, 2447.571674956884, 2460.963085553718, 2506.724260331371, 2507.8119141064403, 2510.7112682041616, 2527.6082207257905, 2531.59494480884, 2452.2275483222907, 2461.3477428481465, 2472.7527247275307, 2473.4558397152596, 2474.5174690935273, 8814.250788682906, 8828.0, 8842.292616590657, 8847.646094156225, 8853.424527405698, 5238.528532432099, 5405.729713514309, 5415.160650099241, 5454.181872719084, 5454.836354909359, 3287.096048586634, 3308.751843611739, 3318.8340582970754, 3352.379809735207, 3394.6605339466105, 958.8753462049958, 974.6783561424713, 978.2320878110648, 981.3474039763548, 999.8900120986685, 12048.397580121047, 12158.33129177886, 12166.5741699041, 12252.387380630933, 12287.815682764765, 4445.777711114431, 4484.573965473275, 4564.132814765184, 4579.992401671627, 4611.792469338888, 9636.518174091267, 9711.708648740409, 9715.61137554504, 9721.562529686182, 9769.51152442375, 5299.33758280215, 5309.8938021239355, 5312.893742125136, 5321.36143662763, 5325.3875804282225, 4258.233517966796, 4709.340692303081, 4712.31671407644, 4764.6664733469015, 4925.236588328815, 3588.766730162531, 3605.7295702822394, 3654.3970244909824, 3674.9448758268113, 3698.7041036716996, 1034.1261633919326, 1047.1151876664208, 1048.8898665640152, 1052.7736536644504, 1060.7772367802847, 1508.7133444645483, 1525.862672359493, 1527.4119464006437, 1538.6538028943621, 1551.1313664347776, 8217.055038670509, 8344.62449189788, 8357.331413486907, 8371.790705232417, 8401.495910245405, 515.1911498946617, 519.7349351830594, 523.4085483403729, 529.1375058654369, 533.9572834173257, 6174.197354343906, 6229.56393052482, 6238.313785483593, 6250.593711408744, 6311.621302721851, 10313.639022634172, 10780.29928054674, 10811.78376432467, 10815.40515271652, 10930.617428389969, 10384.169266458664, 10649.0, 10697.358158510358, 10739.516721747541, 10743.194260430499, 8265.0, 8360.707375241838, 8379.706710264989, 8450.239478446969, 8455.830883382298, 7947.642356094106, 7955.5226686399, 8045.235702608243, 8086.0, 8112.59437028158, 9278.907210928075, 9311.767205819639, 9427.952860235655, 9464.290178236522, 9497.76255593588, 9431.622735090794, 9659.806803864023, 9854.507274636097, 9874.061964113398, 10008.799824003334, 6355.650439225887, 6375.58558693702, 6515.348465153446, 7243.529170603894, 7379.889301660372, 7746.767596972099, 7801.804954876174, 7801.9609901950125, 7823.608819559113, 7852.882206766789, 7221.711131554679, 7244.094488188976, 7388.039554857834, 7542.170361260147, 7650.617469126632, 7184.856302874018, 7202.279772022755, 7236.276372362721, 7249.782506524813, 7272.127344718456, 7825.491343062683, 7826.139124696165, 7895.092064412436, 7921.920780792118, 7923.326517246099, 7045.01369808217, 7218.169910460364, 7268.67290971897, 7281.927180728337, 7297.890531642136, 7071.080759501232, 7086.50394472382, 7125.964370178116, 7129.037579926851, 7131.322524360177], "unit": "score", "name": "mootools.html", "value": 4792.1901985600425}, {"lowerIsBetter": false, "replicates": [322.9402560526303, 331.88715836615546, 335.055144492531, 348.2599476113259, 352.9752917295789, 6272.059191121329, 6324.9367506324925, 6384.10622512848, 6409.903851442232, 6437.35626437356, 6307.274663413708, 6316.2420509538915, 6328.778492752755, 6329.620222786636, 6356.745730170787, 4657.371254880599, 4782.545658162487, 4785.832495862645, 4800.111979283826, 4872.585830204428, 4777.856664300077, 4789.808407663707, 4791.664583479158, 4792.472827988919, 4796.424429068499, 4688.460827004904, 4735.621150307967, 4742.502037286087, 4744.335792988984, 4747.643926705494, 4795.0, 4804.183288840905, 4806.231003039515, 4810.326554282403, 4814.15752243356, 4168.3955826405, 4174.165166966619, 4175.164967006611, 4179.686523510719, 4185.790710464495, 6013.939860601426, 6103.23709536308, 6115.113308570232, 6118.60229085108, 6124.601900876429, 5491.862703432406, 5572.832815015556, 5581.246531718207, 5582.218489411485, 5582.330120385539, 6603.042558828991, 6665.0, 6684.699188536528, 6701.966490167567, 6705.832354191136, 4543.295789152687, 4546.795394207235, 4549.294859296781, 4552.4764652065105, 4558.863234102949, 6972.79081627552, 6977.267386924351, 6999.30006999296, 7008.474364422637, 7045.225025247219, 4626.583607475343, 4700.623950083985, 4709.317149013374, 4712.387389639393, 4718.88202794926, 4670.9766451167525, 4718.363020992122, 4726.291056341507, 4731.455882573479, 4733.124371991193, 5459.044667183306, 5518.806841760519, 5521.475459831309, 5523.088690366045, 5526.06056970308, 6708.19501659804, 6716.731330746716, 6727.831804204934, 6760.18877734675, 6776.93223067763, 1656.6024154202905, 1667.2664027827716, 1671.0892563552893, 1676.5054308978881, 1677.874159438047, 1041.6041904076553, 1067.8238090714945, 1082.880883102858, 1087.445402844539, 1091.1489038549944, 6401.135846660642, 6422.366829599841, 6466.094746735461, 6466.482681385478, 6487.091807147003, 6987.9301206987275, 7001.229864714979, 7011.439084873198, 7016.193137789118, 7020.333068358498, 6258.468030217483, 6466.935330646727, 6497.772577959749, 6553.63954982471, 6579.046038324512, 3802.448644946467, 3839.0018595165457, 3839.1745774658584, 3840.9423858642144, 3847.576766555677, 7251.311125443074, 7258.745943891939, 7312.5246858954, 7325.487215894943, 7341.302576255247, 7177.856442871113, 7234.819129521698, 7236.167840698282, 7239.167495737952, 7280.635968201569, 7066.3993560546905, 7263.0921134858145, 7280.41756659466, 7341.375983041501, 7355.7057717690695, 7071.36357727807, 7083.0, 7090.964545177241, 7102.360787528941, 7130.714771409085, 6970.756023539152, 6979.616121113388, 6981.406580440516, 6985.441164706913, 6995.685194166173, 7278.199398066103, 7300.744473943387, 7304.8539029218055, 7324.63376831167, 7355.043844300207, 4696.131215725101, 4794.568488836021, 4890.731009794496, 4904.288878112725, 4908.779104940215, 7002.614856182959, 7016.403605693369, 7022.929770702432, 7035.507514473938, 7039.436845052281, 6825.317468253135, 6834.179898412222, 6874.072000279898, 6904.206016307988, 6917.584944903322, 6787.830304242433, 6805.6937437816405, 6807.9319206807295, 6823.965880170567, 6832.111825462658, 6444.7744328948265, 6678.131842860591, 6706.228783689743, 6736.562123461959, 6742.123523942052, 6864.759733409307, 6877.793666190022, 6878.965605171942, 6906.482013848881, 6915.619640919797, 6682.699278532575, 6696.19645642526, 6719.395254427125, 6722.731090756315, 6742.123523942052], "unit": "score", "name": "prototype.html", "value": 5070.410899591224}, {"lowerIsBetter": false, "replicates": [881.7751473374288, 882.7131182365732, 896.1844721303615, 901.4726385064737, 930.7905721212724, 12615.684607884796, 12868.099233053677, 12920.160189587694, 13003.284819334933, 13010.739785204314, 11136.3318200908, 11164.330140191594, 11199.104071674266, 11216.439178041086, 11266.267692599995, 916.1708653668425, 919.0946917286467, 931.5528546297747, 950.6910254167389, 950.7147855643314, 925.6575067225102, 929.6699671616581, 930.2232635749158, 931.529577563333, 931.8043210925714, 966.6230170233614, 967.2407160379104, 969.8787651543557, 972.4554249620236, 973.0, 957.6696039866235, 965.2663975378692, 966.4636126949575, 970.6457143142773, 970.6457143142773, 717.436812102497, 720.2365492577884, 720.7837648705367, 721.1958666087274, 722.443718336883, 12443.751124977449, 12521.311327876963, 12543.372831358487, 12576.182548134342, 12588.307643079626, 12410.503579856795, 12550.81173782394, 12741.579169459093, 12767.170133941265, 12959.157654752411, 10776.73058173544, 10939.82252491858, 10994.175436842188, 11000.504977276041, 11122.110231181487, 3698.907527311812, 3710.406334986389, 3755.1550901047044, 3767.6609105180664, 3785.261873934584, 49897.0, 50085.49914500881, 50160.49839501595, 50160.74919625378, 50341.0, 9381.484018379055, 9429.2928030398, 9536.666216682383, 9564.856527152098, 9998.950005250073, 15113.848861511464, 15144.318505667272, 15162.0, 15163.393464261526, 15167.24163791806, 7017.4035207006955, 7074.398676112485, 7124.358807707227, 7367.447441441914, 7422.703091876372, 4096.979515102465, 4109.034376921421, 4124.566920473307, 4128.979355103265, 4194.769287689145, 3092.0, 3111.0355789705263, 3115.345777386774, 3130.4365214261197, 3140.105070055023, 597.8146774499919, 604.0908432808683, 606.6147996022557, 608.5952841360535, 612.1002126873489, 684.2712511175582, 688.8656711941223, 694.9478789090839, 699.0737273113044, 701.680735265453, 7898.210178982055, 8016.639251233709, 8017.719379821679, 8035.839283214303, 8236.094029656733, 490.66389523176736, 636.3223167326782, 644.7749276374832, 672.9125213722283, 722.6025685872748, 3609.9278014439565, 3629.4192929131214, 3649.59854416014, 3756.079760458705, 3768.660820526111, 57379.0, 58139.0, 58596.70701646464, 58718.0, 58874.411255887746, 49168.26247606289, 51737.0, 52509.47490525122, 52648.0, 52808.47191528112, 45974.5402545977, 46307.30539041917, 46636.300455493874, 46996.29505557419, 47103.29345059827, 7937.6031198438695, 8196.385271104571, 8417.537035462863, 8422.031466381444, 8519.91480085216, 34516.82741586276, 34835.0, 36021.81989090038, 36361.0, 36365.272694545434, 45249.0, 45294.54705452903, 52435.16476923289, 54496.0, 58116.0, 12194.207376520499, 12204.633860984184, 12498.0, 12526.123171377916, 12845.293508857103, 12076.45655945467, 12102.394880256128, 12235.571754988532, 12257.38713064361, 12314.384280785745, 11865.28808271472, 11869.347185904859, 11901.82147267809, 11902.40487975615, 11950.641480755592, 11909.166358354832, 11962.0, 12060.095492838247, 12078.51685932553, 12129.878701212874, 11310.94344528272, 11373.43132843338, 11413.0, 11450.312981221154, 11472.770544588895, 9463.526823658653, 9507.382020168667, 9544.713658590254, 9637.71086867395, 9761.0, 9714.902850971399, 9857.852132217879, 9880.40717556949, 9913.801723965624, 9933.950330248303], "unit": "score", "name": "yui.html", "value": 6441.101960058436}], "name": "dromaeo_css", "value": 7294.458001590325}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 103.0, 110.0, 109.0, 110.0, 120.0, 111.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 164.0, 173.0, 128.0, 153.0, 160.0, 130.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 165.0, 164.0, 162.0, 162.0, 163.0, 164.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 161.0, 73.0, 77.0, 76.0, 72.0, 172.0, 78.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 141.0, 95.0, 92.0, 93.0, 147.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 116.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 101.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 58.0, 56.0, 56.0, 55.0, 58.0, 61.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 81.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [117.0, 114.0, 127.0, 114.0, 117.0, 123.0, 118.0, 122.0, 122.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 145.0, 141.0, 152.0, 149.0, 142.0, 142.0, 143.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 66.0, 68.0, 68.0, 69.0, 64.0, 68.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1516.4}]} 18:05:45 INFO - Return code: 0 18:05:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:05:45 ERROR - # TBPL SUCCESS # 18:05:45 INFO - Running post-action listener: _resource_record_post_action 18:05:45 INFO - Running post-run listener: _resource_record_post_run 18:05:46 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 294912; Write bytes: 498540544; Read time: 1164; Write time: 487296 18:05:46 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 4096; Write bytes: 241078272; Read time: 936; Write time: 379040 18:05:46 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 290816; Write bytes: 246919168; Read time: 228; Write time: 105708 18:05:46 INFO - Running post-run listener: _upload_blobber_files 18:05:46 INFO - Blob upload gear active. 18:05:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:05:46 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 18:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:05:46 INFO - (blobuploader) - INFO - Open directory for files ... 18:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:47 INFO - (blobuploader) - INFO - Done attempting. 18:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:05:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:48 INFO - (blobuploader) - INFO - Done attempting. 18:05:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:05:48 INFO - Return code: 0 18:05:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:05:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:05:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c16f57322ce98146fde20955d21c806b469a4e92fb8f6298e939cb44302e301312308f23954951f2ef2fe9f9c2c271073863a93126a749c6104261e480cbf468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/319fac5e1a6546019707d37eeb313b4cd4bf1b2d9451ee0c1765b79839b21e84d98675863c3d4cf23aa5292a5c8691ea80cfc427286c15afb1e47096e461ceee"} 18:05:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:05:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:05:48 INFO - Contents: 18:05:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c16f57322ce98146fde20955d21c806b469a4e92fb8f6298e939cb44302e301312308f23954951f2ef2fe9f9c2c271073863a93126a749c6104261e480cbf468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/319fac5e1a6546019707d37eeb313b4cd4bf1b2d9451ee0c1765b79839b21e84d98675863c3d4cf23aa5292a5c8691ea80cfc427286c15afb1e47096e461ceee"} 18:05:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:05:48 INFO - Copying logs to upload dir... 18:05:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:05:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.264960 ========= master_lag: 34.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-15 18:06:22.663642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 18:06:22.667669) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c16f57322ce98146fde20955d21c806b469a4e92fb8f6298e939cb44302e301312308f23954951f2ef2fe9f9c2c271073863a93126a749c6104261e480cbf468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/319fac5e1a6546019707d37eeb313b4cd4bf1b2d9451ee0c1765b79839b21e84d98675863c3d4cf23aa5292a5c8691ea80cfc427286c15afb1e47096e461ceee"} build_url:https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c16f57322ce98146fde20955d21c806b469a4e92fb8f6298e939cb44302e301312308f23954951f2ef2fe9f9c2c271073863a93126a749c6104261e480cbf468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/319fac5e1a6546019707d37eeb313b4cd4bf1b2d9451ee0c1765b79839b21e84d98675863c3d4cf23aa5292a5c8691ea80cfc427286c15afb1e47096e461ceee"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 18:06:22.963720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 18:06:22.964133) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460767520.187170-576027456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004265 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 18:06:22.983734) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 18:06:22.984069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 18:06:22.985412) ========= ========= Total master_lag: 34.99 =========