builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1463546073.17 results: success (0) buildid: 20160517191151 builduid: a9f4d94576764abebe8a43ec4301b587 revision: b4e6080db0238862dfb893ea6ab564fcd4375da1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.168971) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.169405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.169735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.205116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.205411) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 21:34:33-- 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% 58.4K=0.2s 2016-05-17 21:34:33 (58.4 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.325793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.545314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.545688) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020742 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:33.595477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 21:34:33.595914) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4e6080db0238862dfb893ea6ab564fcd4375da1 --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 b4e6080db0238862dfb893ea6ab564fcd4375da1 --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=5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 21:34:33,869 truncating revision to first 12 chars 2016-05-17 21:34:33,869 Setting DEBUG logging. 2016-05-17 21:34:33,869 attempt 1/10 2016-05-17 21:34:33,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b4e6080db023?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 21:34:34,681 unpacking tar archive at: mozilla-aurora-b4e6080db023/testing/mozharness/ program finished with exit code 0 elapsedTime=1.069676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 21:34:34.681875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:34.682526) ========= script_repo_revision: b4e6080db0238862dfb893ea6ab564fcd4375da1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:34.683320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:34.683917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:34.694756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-17 21:34:34.695216) ========= /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=5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:35 INFO - MultiFileLogger online at 20160517 21:34:35 in /builds/slave/test 21:34:35 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 21:34:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:35 INFO - {'append_to_log': False, 21:34:35 INFO - 'base_work_dir': '/builds/slave/test', 21:34:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:34:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:35 INFO - 'branch': 'Mozilla-Aurora', 21:34:35 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:35 INFO - 'config_files': ('talos/linux_config.py',), 21:34:35 INFO - 'default_actions': ('clobber', 21:34:35 INFO - 'read-buildbot-config', 21:34:35 INFO - 'download-and-extract', 21:34:35 INFO - 'populate-webroot', 21:34:35 INFO - 'create-virtualenv', 21:34:35 INFO - 'install', 21:34:35 INFO - 'run-tests'), 21:34:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:35 INFO - 'download_minidump_stackwalk': True, 21:34:35 INFO - 'download_symbols': 'ondemand', 21:34:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:35 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:35 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:35 INFO - 'installer_path': 'installer.exe', 21:34:35 INFO - 'log_level': 'info', 21:34:35 INFO - 'log_name': 'talos', 21:34:35 INFO - 'log_to_console': True, 21:34:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:35 INFO - 'opt_config_files': (), 21:34:35 INFO - 'pip_index': False, 21:34:35 INFO - 'sps_profile': False, 21:34:35 INFO - 'sps_profile_interval': 0, 21:34:35 INFO - 'suite': 'dromaeojs-e10s', 21:34:35 INFO - 'system_bits': '32', 21:34:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:35 INFO - 'title': 'talos-linux64-ix-039', 21:34:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:35 INFO - 'use_talos_json': True, 21:34:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:35 INFO - 'work_dir': 'build'} 21:34:35 INFO - ##### 21:34:35 INFO - ##### Running clobber step. 21:34:35 INFO - ##### 21:34:35 INFO - Running pre-action listener: _resource_record_pre_action 21:34:35 INFO - Running main action method: clobber 21:34:35 INFO - rmtree: /builds/slave/test/build 21:34:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:35 INFO - Running post-action listener: _resource_record_post_action 21:34:35 INFO - ##### 21:34:35 INFO - ##### Running read-buildbot-config step. 21:34:35 INFO - ##### 21:34:35 INFO - Running pre-action listener: _resource_record_pre_action 21:34:35 INFO - Running main action method: read_buildbot_config 21:34:35 INFO - Using buildbot properties: 21:34:35 INFO - { 21:34:35 INFO - "project": "", 21:34:35 INFO - "product": "firefox", 21:34:35 INFO - "script_repo_revision": "production", 21:34:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 21:34:35 INFO - "repository": "", 21:34:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 21:34:35 INFO - "buildid": "20160517191151", 21:34:35 INFO - "pgo_build": "True", 21:34:35 INFO - "basedir": "/builds/slave/test", 21:34:35 INFO - "buildnumber": 319, 21:34:35 INFO - "slavename": "talos-linux64-ix-039", 21:34:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:34:35 INFO - "platform": "ubuntu64_hw", 21:34:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:34:35 INFO - "branch": "mozilla-aurora", 21:34:35 INFO - "repo_path": "releases/mozilla-aurora", 21:34:35 INFO - "revision": "b4e6080db0238862dfb893ea6ab564fcd4375da1", 21:34:35 INFO - "stage_platform": "linux64-pgo", 21:34:35 INFO - "builduid": "a9f4d94576764abebe8a43ec4301b587", 21:34:35 INFO - "slavebuilddir": "test" 21:34:35 INFO - } 21:34:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 21:34:35 INFO - Running post-action listener: _resource_record_post_action 21:34:35 INFO - ##### 21:34:35 INFO - ##### Running download-and-extract step. 21:34:35 INFO - ##### 21:34:35 INFO - Running pre-action listener: _resource_record_pre_action 21:34:35 INFO - Running main action method: download_and_extract 21:34:35 INFO - mkdir: /builds/slave/test/build/tests 21:34:35 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')]} 21:34:35 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:34:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:34:36 INFO - Downloaded 1361 bytes. 21:34:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:36 INFO - Using the following test package requirements: 21:34:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:34:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:34:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'jsshell-linux-x86_64.zip'], 21:34:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:34:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:34:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:34:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:34:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:34:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:34: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')]} 21:34:36 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:37 INFO - Downloaded 23812452 bytes. 21:34:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:38 INFO - Return code: 0 21:34:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:38 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:41 INFO - Downloaded 23812452 bytes. 21:34:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:42 INFO - Return code: 0 21:34:42 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')]} 21:34:42 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:34:44 INFO - Downloaded 10840145 bytes. 21:34:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:34:44 INFO - Return code: 0 21:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:44 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:34:47 INFO - Downloaded 62698292 bytes. 21:34:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:47 INFO - mkdir: /builds/slave/test/properties 21:34:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:34:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:34:47 INFO - Contents: 21:34:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:48 INFO - Running post-action listener: _resource_record_post_action 21:34:48 INFO - Running post-action listener: set_extra_try_arguments 21:34:48 INFO - ##### 21:34:48 INFO - ##### Running populate-webroot step. 21:34:48 INFO - ##### 21:34:48 INFO - Running pre-action listener: _resource_record_pre_action 21:34:48 INFO - Running main action method: populate_webroot 21:34:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:48 INFO - '--tppagecycles', 21:34:48 INFO - '7'], 21:34:48 INFO - 'tests': ['tsvgm']}}, 21:34:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:34:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:34:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:34:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['damp', 'tps']}, 21:34:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'tests': ['damp', 'tps']}, 21:34:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['dromaeo_dom']}, 21:34:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['a11yr', 21:34:48 INFO - 'ts_paint', 21:34:48 INFO - 'tpaint', 21:34:48 INFO - 'sessionrestore', 21:34:48 INFO - 'sessionrestore_no_auto_restore', 21:34:48 INFO - 'tabpaint']}, 21:34:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:34:48 INFO - 'ts_paint', 21:34:48 INFO - 'tpaint', 21:34:48 INFO - 'sessionrestore', 21:34:48 INFO - 'sessionrestore_no_auto_restore', 21:34:48 INFO - 'tabpaint']}, 21:34:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:34:48 INFO - 'ts_paint', 21:34:48 INFO - 'tpaint', 21:34:48 INFO - 'sessionrestore', 21:34:48 INFO - 'sessionrestore_no_auto_restore', 21:34:48 INFO - 'tabpaint']}, 21:34:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:34:48 INFO - 'ts_paint', 21:34:48 INFO - 'tpaint', 21:34:48 INFO - 'sessionrestore', 21:34:48 INFO - 'sessionrestore_no_auto_restore', 21:34:48 INFO - 'tabpaint']}, 21:34:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['a11yr', 21:34:48 INFO - 'ts_paint', 21:34:48 INFO - 'tpaint', 21:34:48 INFO - 'sessionrestore', 21:34:48 INFO - 'sessionrestore_no_auto_restore', 21:34:48 INFO - 'tabpaint']}, 21:34:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['a11yr', 21:34:48 INFO - 'ts_paint', 21:34:48 INFO - 'tpaint', 21:34:48 INFO - 'sessionrestore', 21:34:48 INFO - 'sessionrestore_no_auto_restore', 21:34:48 INFO - 'tabpaint']}, 21:34:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['tsvgx', 21:34:48 INFO - 'tsvgr_opacity', 21:34:48 INFO - 'tart', 21:34:48 INFO - 'tscrollx', 21:34:48 INFO - 'cart']}, 21:34:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:34:48 INFO - 'tsvgr_opacity', 21:34:48 INFO - 'tart', 21:34:48 INFO - 'tscrollx', 21:34:48 INFO - 'cart']}, 21:34:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'talos_options': ['--disable-e10s'], 21:34:48 INFO - 'tests': ['tp5o']}, 21:34:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'tests': ['tp5o']}, 21:34:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'talos_options': ['--disable-e10s', 21:34:48 INFO - '--xperf_path', 21:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:48 INFO - 'tests': ['tp5n']}, 21:34:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:48 INFO - 'talos_options': ['--xperf_path', 21:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:48 INFO - 'tests': ['tp5n']}}, 21:34:48 INFO - 'talos.zip': {'path': '', 21:34:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:48 INFO - Running post-action listener: _resource_record_post_action 21:34:48 INFO - ##### 21:34:48 INFO - ##### Running create-virtualenv step. 21:34:48 INFO - ##### 21:34:48 INFO - Running pre-action listener: _resource_record_pre_action 21:34:48 INFO - Running main action method: create_virtualenv 21:34:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:34:48 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 21:34:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:34:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:48 INFO - Using real prefix '/usr' 21:34:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:34:49 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:51 INFO - Installing pip.................done. 21:34:51 INFO - Return code: 0 21:34:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:34:51 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 21:34:51 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 21:34:51 INFO - Using env: {'DISPLAY': ':0', 21:34:51 INFO - 'HOME': '/home/cltbld', 21:34:51 INFO - 'LANG': 'en_US.UTF-8', 21:34:51 INFO - 'LANGUAGE': 'en_US:en', 21:34:51 INFO - 'LOGNAME': 'cltbld', 21:34:51 INFO - 'MAIL': '/var/mail/cltbld', 21:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:51 INFO - 'MOZ_NO_REMOTE': '1', 21:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:51 INFO - 'NO_EM_RESTART': '1', 21:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:51 INFO - 'PWD': '/builds/slave/test', 21:34:51 INFO - 'SHELL': '/bin/bash', 21:34:51 INFO - 'SHLVL': '1', 21:34:51 INFO - 'TERM': 'linux', 21:34:51 INFO - 'TMOUT': '86400', 21:34:51 INFO - 'USER': 'cltbld', 21:34:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:51 INFO - '_': '/tools/buildbot/bin/python'} 21:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:51 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 21:34:51 INFO - Cleaning up... 21:34:51 INFO - Return code: 0 21:34:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:34:51 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 21:34:51 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 21:34:51 INFO - Using env: {'DISPLAY': ':0', 21:34:51 INFO - 'HOME': '/home/cltbld', 21:34:51 INFO - 'LANG': 'en_US.UTF-8', 21:34:51 INFO - 'LANGUAGE': 'en_US:en', 21:34:51 INFO - 'LOGNAME': 'cltbld', 21:34:51 INFO - 'MAIL': '/var/mail/cltbld', 21:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:51 INFO - 'MOZ_NO_REMOTE': '1', 21:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:51 INFO - 'NO_EM_RESTART': '1', 21:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:51 INFO - 'PWD': '/builds/slave/test', 21:34:51 INFO - 'SHELL': '/bin/bash', 21:34:51 INFO - 'SHLVL': '1', 21:34:51 INFO - 'TERM': 'linux', 21:34:51 INFO - 'TMOUT': '86400', 21:34:51 INFO - 'USER': 'cltbld', 21:34:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:51 INFO - '_': '/tools/buildbot/bin/python'} 21:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:51 INFO - Downloading/unpacking psutil>=0.7.1 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:53 INFO - Installing collected packages: psutil 21:34:53 INFO - Running setup.py install for psutil 21:34:53 INFO - building 'psutil._psutil_linux' extension 21:34:53 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 21:34:53 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 21:34:53 INFO - building 'psutil._psutil_posix' extension 21:34:53 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 21:34:53 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 21:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:54 INFO - Successfully installed psutil 21:34:54 INFO - Cleaning up... 21:34:54 INFO - Return code: 0 21:34:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:34: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')]} 21:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34: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')]} 21:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34: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', '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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:34: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:34: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 mozsystemmonitor==0.0.0 21:34:54 INFO - Using env: {'DISPLAY': ':0', 21:34:54 INFO - 'HOME': '/home/cltbld', 21:34:54 INFO - 'LANG': 'en_US.UTF-8', 21:34:54 INFO - 'LANGUAGE': 'en_US:en', 21:34:54 INFO - 'LOGNAME': 'cltbld', 21:34:54 INFO - 'MAIL': '/var/mail/cltbld', 21:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:54 INFO - 'MOZ_NO_REMOTE': '1', 21:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:54 INFO - 'NO_EM_RESTART': '1', 21:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:54 INFO - 'PWD': '/builds/slave/test', 21:34:54 INFO - 'SHELL': '/bin/bash', 21:34:54 INFO - 'SHLVL': '1', 21:34:54 INFO - 'TERM': 'linux', 21:34:54 INFO - 'TMOUT': '86400', 21:34:54 INFO - 'USER': 'cltbld', 21:34:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:54 INFO - '_': '/tools/buildbot/bin/python'} 21:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:34:56 INFO - Installing collected packages: mozsystemmonitor 21:34:56 INFO - Running setup.py install for mozsystemmonitor 21:34:56 INFO - Successfully installed mozsystemmonitor 21:34:56 INFO - Cleaning up... 21:34:56 INFO - Return code: 0 21:34:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:34:56 INFO - Using env: {'DISPLAY': ':0', 21:34:56 INFO - 'HOME': '/home/cltbld', 21:34:56 INFO - 'LANG': 'en_US.UTF-8', 21:34:56 INFO - 'LANGUAGE': 'en_US:en', 21:34:56 INFO - 'LOGNAME': 'cltbld', 21:34:56 INFO - 'MAIL': '/var/mail/cltbld', 21:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:56 INFO - 'MOZ_NO_REMOTE': '1', 21:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:56 INFO - 'NO_EM_RESTART': '1', 21:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:56 INFO - 'PWD': '/builds/slave/test', 21:34:56 INFO - 'SHELL': '/bin/bash', 21:34:56 INFO - 'SHLVL': '1', 21:34:56 INFO - 'TERM': 'linux', 21:34:56 INFO - 'TMOUT': '86400', 21:34:56 INFO - 'USER': 'cltbld', 21:34:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:56 INFO - '_': '/tools/buildbot/bin/python'} 21:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:58 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:34:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - Downloading docopt-0.6.1.tar.gz 21:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:59 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:59 INFO - Running setup.py install for blobuploader 21:34:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:34:59 INFO - Running setup.py install for requests 21:34:59 INFO - Running setup.py install for docopt 21:34:59 INFO - Successfully installed blobuploader requests docopt 21:34:59 INFO - Cleaning up... 21:34:59 INFO - Return code: 0 21:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:59 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')]} 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:59 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')]} 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:59 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:34:59 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 21:34:59 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 21:34:59 INFO - Using env: {'DISPLAY': ':0', 21:34:59 INFO - 'HOME': '/home/cltbld', 21:34:59 INFO - 'LANG': 'en_US.UTF-8', 21:34:59 INFO - 'LANGUAGE': 'en_US:en', 21:34:59 INFO - 'LOGNAME': 'cltbld', 21:34:59 INFO - 'MAIL': '/var/mail/cltbld', 21:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:59 INFO - 'MOZ_NO_REMOTE': '1', 21:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:59 INFO - 'NO_EM_RESTART': '1', 21:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:59 INFO - 'PWD': '/builds/slave/test', 21:34:59 INFO - 'SHELL': '/bin/bash', 21:34:59 INFO - 'SHLVL': '1', 21:34:59 INFO - 'TERM': 'linux', 21:34:59 INFO - 'TMOUT': '86400', 21:34:59 INFO - 'USER': 'cltbld', 21:34:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:59 INFO - '_': '/tools/buildbot/bin/python'} 21:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:00 INFO - Running setup.py (path:/tmp/pip-UNPhx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:00 INFO - Running setup.py (path:/tmp/pip-QaTO3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:00 INFO - Running setup.py (path:/tmp/pip-Kr9P0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:00 INFO - Running setup.py (path:/tmp/pip-RyehKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:00 INFO - Running setup.py (path:/tmp/pip-lQmX5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:00 INFO - Running setup.py (path:/tmp/pip-DZ90lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:00 INFO - Running setup.py (path:/tmp/pip-tMZKK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:00 INFO - Running setup.py (path:/tmp/pip-AuHSSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:00 INFO - Running setup.py (path:/tmp/pip-wU3cHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:00 INFO - Running setup.py (path:/tmp/pip-IbraVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:00 INFO - Running setup.py (path:/tmp/pip-NYtRio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:00 INFO - Running setup.py (path:/tmp/pip-Sh05Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:00 INFO - Running setup.py (path:/tmp/pip-AovcYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:00 INFO - Running setup.py (path:/tmp/pip-wVeKLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:01 INFO - Running setup.py (path:/tmp/pip-x_877M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:01 INFO - Running setup.py (path:/tmp/pip-PxWNtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:01 INFO - Running setup.py (path:/tmp/pip-W0SZt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:01 INFO - Running setup.py install for manifestparser 21:35:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:01 INFO - Running setup.py install for mozcrash 21:35:01 INFO - Running setup.py install for mozdebug 21:35:01 INFO - Running setup.py install for mozdevice 21:35:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:35:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:01 INFO - Running setup.py install for mozfile 21:35:01 INFO - Running setup.py install for mozhttpd 21:35:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:01 INFO - Running setup.py install for mozinfo 21:35:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:01 INFO - Running setup.py install for mozInstall 21:35:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Running setup.py install for mozleak 21:35:02 INFO - Running setup.py install for mozlog 21:35:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Running setup.py install for moznetwork 21:35:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Running setup.py install for mozprocess 21:35:02 INFO - Running setup.py install for mozprofile 21:35:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Running setup.py install for mozrunner 21:35:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:02 INFO - Running setup.py install for mozscreenshot 21:35:02 INFO - Running setup.py install for moztest 21:35:02 INFO - Running setup.py install for mozversion 21:35:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:03 INFO - Cleaning up... 21:35:03 INFO - Return code: 0 21:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:03 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:35:03 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 21:35:03 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 21:35:03 INFO - Using env: {'DISPLAY': ':0', 21:35:03 INFO - 'HOME': '/home/cltbld', 21:35:03 INFO - 'LANG': 'en_US.UTF-8', 21:35:03 INFO - 'LANGUAGE': 'en_US:en', 21:35:03 INFO - 'LOGNAME': 'cltbld', 21:35:03 INFO - 'MAIL': '/var/mail/cltbld', 21:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:03 INFO - 'MOZ_NO_REMOTE': '1', 21:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:03 INFO - 'NO_EM_RESTART': '1', 21:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:03 INFO - 'PWD': '/builds/slave/test', 21:35:03 INFO - 'SHELL': '/bin/bash', 21:35:03 INFO - 'SHLVL': '1', 21:35:03 INFO - 'TERM': 'linux', 21:35:03 INFO - 'TMOUT': '86400', 21:35:03 INFO - 'USER': 'cltbld', 21:35:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:03 INFO - '_': '/tools/buildbot/bin/python'} 21:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:03 INFO - Running setup.py (path:/tmp/pip-A0Ww2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:03 INFO - Running setup.py (path:/tmp/pip-UW1pgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:03 INFO - Running setup.py (path:/tmp/pip-HiGRYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:03 INFO - Running setup.py (path:/tmp/pip-E6HLfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:03 INFO - Running setup.py (path:/tmp/pip-DC1f6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:03 INFO - Running setup.py (path:/tmp/pip-O5_x_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:03 INFO - Running setup.py (path:/tmp/pip-3IFTD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:03 INFO - Running setup.py (path:/tmp/pip-nc8T4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:03 INFO - Running setup.py (path:/tmp/pip-hEA2jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:03 INFO - Running setup.py (path:/tmp/pip-45vXWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:03 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)) 21:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:03 INFO - Running setup.py (path:/tmp/pip-pmaLgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:04 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)) 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:04 INFO - Running setup.py (path:/tmp/pip-UD_Zzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:04 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)) 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:04 INFO - Running setup.py (path:/tmp/pip-qV_mlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:04 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)) 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:04 INFO - Running setup.py (path:/tmp/pip-ppxB39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:04 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)) 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:04 INFO - Running setup.py (path:/tmp/pip-JytvbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:04 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)) 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:04 INFO - Running setup.py (path:/tmp/pip-20oRhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:04 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)) 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:04 INFO - Running setup.py (path:/tmp/pip-qC4Lu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:04 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)) 21:35:04 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)) 21:35:04 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)) 21:35:04 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)) 21:35:04 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)) 21:35:04 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)) 21:35:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:06 INFO - Downloading blessings-1.6.tar.gz 21:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:06 INFO - Installing collected packages: blessings 21:35:06 INFO - Running setup.py install for blessings 21:35:06 INFO - Successfully installed blessings 21:35:06 INFO - Cleaning up... 21:35:06 INFO - Return code: 0 21:35:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:06 INFO - Reading from file tmpfile_stdout 21:35:06 INFO - Current package versions: 21:35:06 INFO - argparse == 1.2.1 21:35:06 INFO - blessings == 1.6 21:35:06 INFO - blobuploader == 1.2.4 21:35:06 INFO - docopt == 0.6.1 21:35:06 INFO - manifestparser == 1.1 21:35:06 INFO - mozInstall == 1.12 21:35:06 INFO - mozcrash == 0.17 21:35:06 INFO - mozdebug == 0.1 21:35:06 INFO - mozdevice == 0.48 21:35:06 INFO - mozfile == 1.2 21:35:06 INFO - mozhttpd == 0.7 21:35:06 INFO - mozinfo == 0.9 21:35:06 INFO - mozleak == 0.1 21:35:06 INFO - mozlog == 3.1 21:35:06 INFO - moznetwork == 0.27 21:35:06 INFO - mozprocess == 0.22 21:35:06 INFO - mozprofile == 0.28 21:35:06 INFO - mozrunner == 6.11 21:35:06 INFO - mozscreenshot == 0.1 21:35:06 INFO - mozsystemmonitor == 0.0 21:35:06 INFO - moztest == 0.7 21:35:06 INFO - mozversion == 1.4 21:35:06 INFO - psutil == 3.1.1 21:35:06 INFO - requests == 1.2.3 21:35:06 INFO - wsgiref == 0.1.2 21:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:06 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:35:06 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 21:35:06 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 21:35:06 INFO - Using env: {'DISPLAY': ':0', 21:35:06 INFO - 'HOME': '/home/cltbld', 21:35:06 INFO - 'LANG': 'en_US.UTF-8', 21:35:06 INFO - 'LANGUAGE': 'en_US:en', 21:35:06 INFO - 'LOGNAME': 'cltbld', 21:35:06 INFO - 'MAIL': '/var/mail/cltbld', 21:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:06 INFO - 'MOZ_NO_REMOTE': '1', 21:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:06 INFO - 'NO_EM_RESTART': '1', 21:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:06 INFO - 'PWD': '/builds/slave/test', 21:35:06 INFO - 'SHELL': '/bin/bash', 21:35:06 INFO - 'SHLVL': '1', 21:35:06 INFO - 'TERM': 'linux', 21:35:06 INFO - 'TMOUT': '86400', 21:35:06 INFO - 'USER': 'cltbld', 21:35:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:06 INFO - '_': '/tools/buildbot/bin/python'} 21:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 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)) 21:35:07 INFO - Cleaning up... 21:35:07 INFO - Return code: 0 21:35:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:07 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')]} 21:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:07 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')]} 21:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:07 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:35:07 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 21:35:07 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 21:35:07 INFO - Using env: {'DISPLAY': ':0', 21:35:07 INFO - 'HOME': '/home/cltbld', 21:35:07 INFO - 'LANG': 'en_US.UTF-8', 21:35:07 INFO - 'LANGUAGE': 'en_US:en', 21:35:07 INFO - 'LOGNAME': 'cltbld', 21:35:07 INFO - 'MAIL': '/var/mail/cltbld', 21:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:07 INFO - 'MOZ_NO_REMOTE': '1', 21:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:07 INFO - 'NO_EM_RESTART': '1', 21:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:07 INFO - 'PWD': '/builds/slave/test', 21:35:07 INFO - 'SHELL': '/bin/bash', 21:35:07 INFO - 'SHLVL': '1', 21:35:07 INFO - 'TERM': 'linux', 21:35:07 INFO - 'TMOUT': '86400', 21:35:07 INFO - 'USER': 'cltbld', 21:35:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:07 INFO - '_': '/tools/buildbot/bin/python'} 21:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:07 INFO - Downloading/unpacking jsonschema 21:35:07 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 21:35:07 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 21:35:07 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 21:35:07 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 21:35:07 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 21:35:07 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 21:35:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:09 INFO - Downloading/unpacking functools32 (from jsonschema) 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:09 INFO - warning: no files found matching '*.txt' 21:35:09 INFO - no previously-included directories found matching 'build' 21:35:09 INFO - no previously-included directories found matching 'dist' 21:35:09 INFO - no previously-included directories found matching '.git*' 21:35:09 INFO - Installing collected packages: jsonschema, functools32 21:35:09 INFO - Running setup.py install for functools32 21:35:09 INFO - warning: no files found matching '*.txt' 21:35:09 INFO - no previously-included directories found matching 'build' 21:35:09 INFO - no previously-included directories found matching 'dist' 21:35:09 INFO - no previously-included directories found matching '.git*' 21:35:09 INFO - Successfully installed jsonschema functools32 21:35:09 INFO - Cleaning up... 21:35:09 INFO - Return code: 0 21:35:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:09 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 0x7f563870af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', '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 21:35:09 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 21:35:09 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 21:35:09 INFO - Using env: {'DISPLAY': ':0', 21:35:09 INFO - 'HOME': '/home/cltbld', 21:35:09 INFO - 'LANG': 'en_US.UTF-8', 21:35:09 INFO - 'LANGUAGE': 'en_US:en', 21:35:09 INFO - 'LOGNAME': 'cltbld', 21:35:09 INFO - 'MAIL': '/var/mail/cltbld', 21:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:09 INFO - 'MOZ_NO_REMOTE': '1', 21:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:09 INFO - 'NO_EM_RESTART': '1', 21:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:09 INFO - 'PWD': '/builds/slave/test', 21:35:09 INFO - 'SHELL': '/bin/bash', 21:35:09 INFO - 'SHLVL': '1', 21:35:09 INFO - 'TERM': 'linux', 21:35:09 INFO - 'TMOUT': '86400', 21:35:09 INFO - 'USER': 'cltbld', 21:35:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:09 INFO - '_': '/tools/buildbot/bin/python'} 21:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:09 INFO - Downloading/unpacking flake8 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:35:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:35:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:35:12 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 21:35:12 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 21:35:12 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 21:35:12 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 21:35:12 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 21:35:12 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 21:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:35:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:35:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:35:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:35:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:35:12 INFO - no previously-included directories found matching 'docs/_build' 21:35:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:35:12 INFO - Running setup.py install for pep8 21:35:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:35:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:35:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:35:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:35:12 INFO - no previously-included directories found matching 'docs/_build' 21:35:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:35:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:35:12 INFO - Cleaning up... 21:35:12 INFO - Return code: 0 21:35:12 INFO - Running post-action listener: _resource_record_post_action 21:35:12 INFO - Running post-action listener: _start_resource_monitoring 21:35:12 INFO - Starting resource monitoring. 21:35:12 INFO - ##### 21:35:12 INFO - ##### Running install step. 21:35:12 INFO - ##### 21:35:12 INFO - Running pre-action listener: _resource_record_pre_action 21:35:12 INFO - Running main action method: install 21:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:12 INFO - Reading from file tmpfile_stdout 21:35:12 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:13 INFO - Reading from file tmpfile_stdout 21:35:13 INFO - Output received: 21:35:13 INFO - Usage: mozinstall [options] installer 21:35:13 INFO - Options: 21:35:13 INFO - -h, --help show this help message and exit 21:35:13 INFO - -d DEST, --destination=DEST 21:35:13 INFO - Directory to install application into. [default: 21:35:13 INFO - "/builds/slave/test"] 21:35:13 INFO - --app=APP Application being installed. [default: firefox] 21:35:13 INFO - mkdir: /builds/slave/test/build/application 21:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:35:28 INFO - Reading from file tmpfile_stdout 21:35:28 INFO - Output received: 21:35:28 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:28 INFO - Running post-action listener: _resource_record_post_action 21:35:28 INFO - ##### 21:35:28 INFO - ##### Running run-tests step. 21:35:28 INFO - ##### 21:35:28 INFO - Running pre-action listener: _resource_record_pre_action 21:35:28 INFO - Running main action method: run_tests 21:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:28 INFO - Python 2.7.3 21:35:28 INFO - Return code: 0 21:35:28 INFO - grabbing minidump binary from tooltool 21:35:28 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')]} 21:35:28 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 0x16e5410>, '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 0x16e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:28 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 21:35:28 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 21:35:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:28 INFO - Return code: 0 21:35:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:35:29 INFO - Return code: 0 21:35:29 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/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 21:35:29 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/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 21:35:29 INFO - Using env: {'DISPLAY': ':0', 21:35:29 INFO - 'HOME': '/home/cltbld', 21:35:29 INFO - 'LANG': 'en_US.UTF-8', 21:35:29 INFO - 'LANGUAGE': 'en_US:en', 21:35:29 INFO - 'LOGNAME': 'cltbld', 21:35:29 INFO - 'MAIL': '/var/mail/cltbld', 21:35:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:29 INFO - 'MOZ_NO_REMOTE': '1', 21:35:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:29 INFO - 'NO_EM_RESTART': '1', 21:35:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:29 INFO - 'PWD': '/builds/slave/test', 21:35:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:29 INFO - 'SHELL': '/bin/bash', 21:35:29 INFO - 'SHLVL': '1', 21:35:29 INFO - 'TERM': 'linux', 21:35:29 INFO - 'TMOUT': '86400', 21:35:29 INFO - 'USER': 'cltbld', 21:35:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645', 21:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:29 INFO - '_': '/tools/buildbot/bin/python'} 21:35:29 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/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 21:35:29 INFO - mozversion application_buildid: 20160517191151 21:35:29 INFO - mozversion application_changeset: b4e6080db0238862dfb893ea6ab564fcd4375da1 21:35:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:35:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:29 INFO - mozversion application_name: Firefox 21:35:29 INFO - mozversion application_remotingname: firefox-dev 21:35:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:35:29 INFO - mozversion application_vendor: Mozilla 21:35:29 INFO - mozversion application_version: 48.0a2 21:35:29 INFO - mozversion platform_buildid: 20160517191151 21:35:29 INFO - mozversion platform_changeset: b4e6080db0238862dfb893ea6ab564fcd4375da1 21:35:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:35:29 INFO - mozversion platform_version: 48.0a2 21:35:29 INFO - using testdate: 1463546129 21:35:29 INFO - actual date: 1463546129 21:35:29 INFO - starting webserver on 'localhost:35531' 21:35:29 INFO - SUITE-START | Running 2 tests 21:35:29 INFO - TEST-START | dromaeo_css 21:35:29 INFO - operating with platform_type : linux_ 21:35:29 INFO - Initialising browser for dromaeo_css test... 21:35:29 INFO - TEST-INFO | started process 21359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZyLDpl/profile http://localhost:35531/getInfo.html) 21:35:33 INFO - PROCESS | 21359 | 21:35:33 INFO - PROCESS | 21359 | (process:21436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:35:34 INFO - PROCESS | 21359 | __metrics Screen width/height:1600/1200 21:35:34 INFO - PROCESS | 21359 | colorDepth:24 21:35:34 INFO - PROCESS | 21359 | Browser inner width/height: 1024/697 21:35:34 INFO - PROCESS | 21359 | __metrics 21:35:35 ERROR - PROCESS | 21359 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 21:35:36 INFO - TEST-INFO | 21359: exit 0 21:35:36 INFO - Browser initialized. 21:35:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:36 INFO - TEST-INFO | started process 21487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZyLDpl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:37 INFO - PROCESS | 21487 | 21:35:37 INFO - PROCESS | 21487 | (process:21556): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:35:47 INFO - PROCESS | 21487 | RSS: Main: 152174592 21:35:47 INFO - PROCESS | 21487 | 21:36:37 INFO - PROCESS | 21487 | 1463546197455 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] 21:38:44 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:35531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35531/tests/dromaeo/cssquery-ext.html) 21:38:45 INFO - PROCESS | 21487 | RSS: Main: 156712960 21:38:45 INFO - PROCESS | 21487 | 21:41:47 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:35531/tests/dromaeo/cssquery-ext.html (next: http://localhost:35531/tests/dromaeo/cssquery-jquery.html) 21:41:48 INFO - PROCESS | 21487 | RSS: Main: 153411584 21:41:48 INFO - PROCESS | 21487 | 21:44:49 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:35531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35531/tests/dromaeo/cssquery-mootools.html) 21:44:50 INFO - PROCESS | 21487 | RSS: Main: 153243648 21:44:50 INFO - PROCESS | 21487 | 21:47:52 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:35531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35531/tests/dromaeo/cssquery-prototype.html) 21:47:52 INFO - PROCESS | 21487 | RSS: Main: 152850432 21:47:52 INFO - PROCESS | 21487 | 21:50:55 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:35531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35531/tests/dromaeo/cssquery-yui.html) 21:50:55 INFO - PROCESS | 21487 | RSS: Main: 154406912 21:50:55 INFO - PROCESS | 21487 | 21:53:57 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:35531/tests/dromaeo/cssquery-yui.html (next: http://localhost:35531/tests/dromaeo/cssquery-dojo.html) 21:53:58 INFO - PROCESS | 21487 | RSS: Main: 156020736 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | __start_tp_report 21:53:58 INFO - PROCESS | 21487 | _x_x_mozilla_page_load 21:53:58 INFO - PROCESS | 21487 | _x_x_mozilla_page_load_details 21:53:58 INFO - PROCESS | 21487 | |i|pagename|runs| 21:53:58 INFO - PROCESS | 21487 | |0;dojo.html;3263.118957881372;3314.38683843489;3320.418926687829;3369.292448585797;3374.25766331407;5471.5896307776975;5475.917861232085;5489.313835770528;5493.258410114633;5519.9172012419795;5475.72621368932;5484.561235101192;5511.917321240175;5520.861978450531;5529.834104976847;5002.849914502562;5004.84985450437;5052.6210534209895;5065.670731402465;5070.974645126787;4923.409190897098;5031.22016087507;5136.8458946231485;5158.071547121516;5158.303629010074;4917.434495033063;5028.522290382426;5037.496250374951;5102.821401250957;5128.871778205537;5025.246213068051;5034.974825125869;5043.142665746832;5053.090443720129;5078.64449488536;4941.530554597308;4968.975155124237;4998.10034193845;5018.824341148079;5039.118154323016;5228.163493840967;5284.313039304904;5308.761105750251;5349.7592608332325;5350.839474815762;5744.511716504102;5799.536037117021;5810.389909059572;5810.5932584719085;5810.970945145289;5761.135829625548;5874.353821079678;5875.206847075633;5887.558433117533;5894;5446.754896029649;5468.179773034077;5470.234167216593;5507.091329930557;5509.035918714249;5933.9406605934255;5937.495312898365;5949.405059494016;5973.641581505123;5982.341942386334;5658.74535645897;5715.428457154251;5726.312842458931;5754.74103665336;5758.7696492140685;5671.51792097668;5727.4845263926445;5740.052891272893;5748.770049198069;5773.797917072882;5701;5707.885842283131;5708.71456427177;5724.026915424388;5728.054870946247;5613.354464236583;5724.284464441945;5763.827085187451;5807.186993820868;5856.648601083949;4416.646668266531;4447.822087116544;4460.7323560586465;4463.509014008457;4482.103579284156;4042.6159514846045;4047.817848196838;4057.9391309130388;4069.2268468991388;4095.1604920991126;5412.215228791882;5681.0910254359105;5740.913886291709;5778.855528611818;5780.53755699543;5718.51392631631;5938.851528711817;5962.135490353874;5994.130851026577;6031.884101441247;5591.384947655754;5616.466435688603;5638.548916086703;5639.492445679826;5642.6614403135945;4866.440359358719;4944.53026962438;5020;5028.044671512401;5034.798608055637;6064.818055458343;6076.635401875901;6109.908351374733;6134.754609815646;6157.353477884847;5782.2194003808945;5888.617239879565;5908.970455147783;5911.85220369477;5922.437368449991;6097.146399504161;6118.192813661829;6136.335271946791;6141.219046476651;6142.621558143092;5766.481016708516;5772.393898640582;5775.306963164448;5780.21967034445;5785.4214578541805;5664.461876121762;5835.854103647443;5861.9413805863105;5863.355030946678;5869.8239052828485;5678.914816277676;5707.1724599933605;5708.857278568069;5710.828675139753;5741.196232527366;5630.465105814941;5667.1782591524825;5668.206451096932;5686.658800471985;5692.117721753135;5476.397596264487;5590.832275031756;5593.552515798808;5625.156226565884;5676.914846277392;5678.063119585222;5690.886182276414;5719.599628026164;5720.542356611544;5741.540676745767;5580.804671836466;5591.552675785846;5596.384397716167;5602.187682786055;5627.155926610877 21:53:58 INFO - PROCESS | 21487 | |1;ext.html;607.116645281116;645.15806872032;649.1398896462189;665.2748504130496;680.4216416046359;32560.348793024124;39531.604683953155;39537.209255814865;39740.80129599355;40123.19753604926;43238.783806081;43314.35028474576;43431.78284108575;43570.56429435705;43793.24827006916;8857.424267422613;8966.955165224164;9020.594073266719;9043.095690430937;9052.909470905306;8832.11678832118;8927.06265842087;8976.955115224415;8982.730518084436;8984.19142277195;9182.770430739218;9208.401453905508;9218.17036466718;9248.352615316931;9288.674896378629;9169.72490825273;9190.126937940884;9194.816103677957;9201.217896478807;9202.585883635185;8734.606942687595;8757.255633271116;8758.430702004349;8769.166929141722;9085.13691199335;43068.353974690406;43135.35296970548;43491.565084349066;43538.782306088586;43593.128137437074;3629.401148810443;3740.831662575191;3754.1740817020213;3787.6780473659774;3859.59474255202;32997.34005319904;33376.6662333376;33440.33119337624;33694;35061.64938350635;4458.375827384169;4528.411306530163;4567.840125595588;4628.1669299526075;4672.883177920545;228129;228267;229866;300617.9999999978;300661;38955.22089558193;57295.71352143296;59804;59877;60046.099308510406;37395.06512337214;37424;37578.248435031695;37606.24787504289;37766.62233377686;17411.65176696459;17739.46781596554;17746.733798993024;17786.822131778776;17820;14964.925175374054;15082.54752357431;15146.091234525964;15147.924260378628;15172.165530895907;9072.410293330913;9205.263578913671;9220.248152850936;9265.72202833916;9277.072292770668;3573.857045718142;3631.4371272452813;3667.743257971916;3669;3687.3178461984617;1134.7219931116929;1182.6688527212223;1202.9037676985995;1209.8608660004213;1219.8475190601175;32368.514472282935;33257;33442.49836252458;33739.66260337414;33927.830360848035;1243.3410292544966;1275.8787915148046;1301.537954026326;1316.3681432912065;1333.6332508560224;17137.228824702917;17283.913580432018;17610.295588176585;17628.559286017953;17632.911835441;201787;203793;601657;609512;673023;58608.70695646494;60054;60072.69963650154;60137.39862601318;60322;1490.8658220760183;1540.3915453395846;1542.3213785934154;1567.1850637668576;1574.4568123997203;32227;32748.672513274563;33056.50415243821;33307.333853322314;33819.32361352808;51109.744451277504;51649.48350516447;52167.21749173841;52170;52317;453319;455969;457724;457756;458033;30004;30323.696763032087;30485.085447436613;30550.694493054783;30923.69076309208;48237;48535.271970919755;48610;48698.26952595785;49406.50593494019;40888.386674200505;41520.58479415288;41828.58171418247;42080.57919420889;42441.575584243765;39313.017174570865;40025.79987100046;40390.79804600958;40445.59554404418;40931.38602921018;42142;42388.36417453679;42606.360904587076;43336.566634333256;43559.34660980025;34556.65443345635;35753.82123089368;36108.09729756777;36342.27315453623;36743.448848266766;28031.299217519725;28501.287467812643;28558.286042849097;28782.136535903956;29133.562996554643 21:53:58 INFO - PROCESS | 21487 | |2;jquery.html;421.1177582963691;423.6293243412014;431.4455924137483;433.59242312226525;439.0209832074474;14400.351984160712;17904.641907161866;18667.346642867502;18763.155657995405;18766.249350025984;18091.457256282334;19525.12136953837;19590.21639134433;20225.696614550758;20279.797202027974;5495.752691128899;5562.749676264578;5753.424657534234;5759.913601295984;5824.534037277008;5653.349864765563;5714.114312281603;5720.141978703186;5739.253896993385;5747.166660834177;5318.30861987943;5634.661920284776;5665.291838520185;5673.347565030033;5675.772969081232;5532.806351777709;5554.389017208104;5566.276384070085;5568.248286481355;5579.609427340088;5388.407275199725;5418.051840927861;5472.863178420532;5479;5614.129809879475;14136.434542618283;14143.575692729235;14215;22299.331020069425;23081;2345.835791494596;2358.8820558971984;2435.780779729815;2468.358226861011;2964.0515035188746;10196.082352588302;10307.381557106597;10378.688639340831;12784.232946023269;13508.121972071882;2015.5767288869356;2037.9694304585444;2046.5702202537484;2116.5555233401005;2124.7237859078223;77417;78585.21414785837;79173.60413197955;80351.59824200842;81072;11144.665660030212;11295.943520282346;11906.88093119075;12062.51749929993;12357.505699771908;15848.60378490547;16058.277377517807;16142.596435089217;16159.43441979525;16213.756793648105;8954.731358059269;8966.282697384193;8977.685780997634;9069.31980101495;9115.407498512575;8926.910730892609;8935.597898094602;8944.910550894538;8958.596863141174;9030.86453703195;4884.902301954012;4922.089413458521;4975.4278258000795;4976.104301225741;5013.49865013503;2052.6613108836873;2053.271088763497;2055.9588808223752;2087.3424871165535;2153.9876258158642;451.4447229907233;1119.88801119889;1128.227164392394;1130.8247221680654;1140.75087778882;11412.771744565061;12068.396580171131;12080;12144.635660930186;12309;1095.9452027398597;1108.5288752280248;1113.9164562657834;1129.0910816792561;1129.5481807277156;10112.696619101438;10583.206259530565;10662.04041636241;10738.516766745515;10766.515506802212;503646;508464;512179;514680;531881;83135;86233.56883215543;87595.56202218948;89724;90893;1127.5658871334595;1139.8689150747605;1155.1047937848066;1168.760404117171;1171.5899435197612;17096;17256;17264.395746148824;17289.13554322304;17360.045197514257;38270.617293826705;38453;39798.2040359197;40307.193856122125;41468.377974331015;52543.737281314876;54788.45211547993;56982.430175699374;57371;57830.132548012654;8447.535385553607;8830.470171789713;8889.688860889837;8925;8933.330000250136;9473.768410106642;11983.76032479363;13245.536406225736;13425.932870335586;13573.914086873225;11253.437328133725;11330.320180789178;11336.263142895685;11426.2001659883;11566.595169169039;11439.942800285946;11532.25040372373;11590.36253006059;11615.76768464643;11666.941665291619;11508.36703981289;11741.236819606698;11746.236494627821;11923.224990375598;12237;8833.205011548991;8954.059823718415;8984.820303594022;9036.457812531005;9063.637454501746;8616.741497755078;11100.444977750918;11127.666170014912;11338.829917551408;12003.81994270104 21:53:58 INFO - PROCESS | 21487 | |3;mootools.html;1550.6433520290334;1567.0127819473732;1760.084755926918;1848.3807924345344;1855.2115350975832;7154.96422517888;7505.587192704399;7810.53136811791;7932.960335198323;8005.799855003628;7156;7701.422393320496;7741.845163096735;7939;8027.277545020947;2309.3764683535437;2313.687652166957;2330.568844763716;2350.3536527455003;2357.0453966143655;2231.94420139497;2277.567262220173;2280.1905323610126;2283.7145356830397;2303.7005189325364;2252.8760918149496;2272.5114100468395;2283.600369935263;2310.9884450577724;2314;2301.344116926676;2302.3093072078477;2308.665243539686;2321.593721098801;2332.4518738096535;2323.186884590397;2323.268170526279;2336.894839732216;2345.108858633708;2346.2961111666605;8228.876566851503;8260.83478330436;8328.08391076981;8338.62476188573;8349.499030058216;4909.189983652693;5004.524570165829;5013.824516141954;5014.52362025607;5035.169197082477;3294.407006738786;3295.2750394913082;3391.9152021199666;3402.4556071028514;3436.1237884339585;1131.3268605179906;1134.1267224237374;1135.9889698168636;1163.97090072748;1184.7275126720817;11510.712232194262;11538.884611153864;11572.826407603809;11575.710607234802;11604.76790464186;4204.1171354016;4305.289627211475;4314.374415709704;4362.214801335726;4377.124575084996;9583.329166958385;9595.088466595662;9611.423314601147;9625.807483850283;9627.470489123025;5030.874228144253;5058.241263810458;5080.517350851663;5088.211327244283;5091.821786237464;4219.261629214875;4525.185466615975;4605.194091034123;4626.768661566908;4652.209124448852;3814.2562200371217;3869.380899056194;3911.902202444962;3928.744631598937;4065.1463192729857;1210.6549633354452;1214.5931113077042;1214.908881833866;1224.4245204753752;1244.6328333141746;1039.2828948025838;1051.447989805343;1054.678323111443;1056.413690401819;1069.0699091790193;5619.016672082451;5660.377358490563;5688.317401911714;5710.971445142831;5794.594378393472;413.2705774308348;417.2926888923246;435.2557127312268;452.1680108600126;459.0909998203576;4032.1330913853662;4067.2678917795083;4114;4142.5857414258935;4171.478565179353;10054.69835904924;10256.333338332985;10261.640842570474;10280.948595256976;10324.43215623148;10068.647597334058;10121.24090693201;10143.898561014443;10150.44172570501;10242.641507547349;7794.610269486503;7851.842963140705;7864.252895974759;7912.881306780403;7927.048754149539;5498.422665620053;5546.140348246028;5592.916106258328;5678.7728490861555;5795.217645617788;9053.728388148365;9132.680356187502;9133.269338452776;9136.49749263797;9175.77060573491;8885.111488851064;9041.05068967749;9145.908540914772;9248.537573121452;9315.068493150631;6533.640649764308;7037.401820845285;7087.893681594884;7213.2065472799;7232.349088582053;7719.92280077192;7729.536227826348;7741.45809793309;7742.109657389472;7824.21757824213;6978.860422791414;7151.141862976476;7157.248488908798;7208.243134470805;7216.061911951413;6990.231074581894;7068.045813815274;7084.716611335489;7125.35871771543;7146.821329466805;6233.065040244;6361.713722882574;6373.330800265905;6390.7443702251385;6412.61524308543;4968.726720030433;4993.126202914548;4996.15065438869;5003.324551185543;5018.297438358706;4789.616830653609;4796.448408432935;4810.39870016248;4855.975720121518;4922.655414120977 21:53:58 INFO - PROCESS | 21487 | |4;prototype.html;322.56775920266836;335.29755162933657;339.39587534189144;340.92329225924186;341.29863131265256;6422.775202867901;6553.8033858984245;6587.143671322728;6598.10925525054;6619.139511863451;6450.225972883249;6467.126937863399;6470.773522926698;6485.286618471964;6494.935050649492;4674.859754207379;4734.502877197879;4837.0325934813;4843.055604157191;4887.120318342697;4830.661853670244;4863.954249836284;4871.391076115486;4889.291052797343;4897.2898929655175;4830.97584512077;4831.106245344605;4831.130396528623;4834;4834.734089625087;4813.903721925577;4832.782524786376;4836.685615434985;4844.273358996179;4848.248521479177;4222.788860556991;4223.113146239293;4226.957730422687;4230.238557059728;4233.708718840783;5940.435658612425;6142.570020098595;6161.168242287279;6172.105044768528;6178.505719542471;5489.149181876815;5502.0921547944545;5534.806281780158;5542.11326187812;5542.75057622408;6758.324167583251;6785.185777706657;6804.795856124324;6806.047153398528;6816.48876334272;4523.163214805271;4531.229690952546;4531.637469002472;4544.795484203219;4549;7039.436845052383;7090.71637134514;7119.644017799141;7129.3583577478275;7139.571625702474;4460.130274596488;4579.931301030487;4604.102200070954;4620.514845941195;4641.419822522184;4662.044280922402;4680.555347242007;4687.71873687573;4706.647001474903;4709.434867815884;5522.723863806874;5534.7786088556;5540.501354878;5550.417206193372;5554.222408862763;6797.66011699423;6812.250652428229;6858.485613579001;6860.3139686032;6871.14110736158;1615.3700056977789;1616.8787340949475;1618.668173024527;1628.8452597003266;1631.111044480761;1030.4744580264119;1044.5038606661926;1054;1056.9735756606146;1072.522727386321;6651.966740166268;6655.500837437212;6680.632565208863;6681.064650948871;6694.799156025327;6827.6244806536115;7078.433725301964;7092.148942126978;7103.573785572882;7108.71565137399;6542.411182993554;6700.966495167493;6756.729730810811;6764.222114456802;6767.187937447439;3831.214601006787;3856.4986551748093;3857.9421308680394;3875.7210120660116;3882.1265215326325;7408.370288525428;7517.17311095779;7546.735864244725;7547.132079810892;7558.508696934681;7029.89455158173;7209;7279;7293.452991025588;7302.123745150509;7513.060867391576;7517.308605563814;7520.473566850377;7523.3229009389415;7546.169921308651;7162.391196748126;7174.784756457315;7175;7177.677004534913;7183.676734547063;7073.681684324115;7077.044598979278;7093.716251349888;7125.5368401053765;7134.750283740252;7242.348188663045;7426.517276377018;7523.8495230093995;7559.659815308214;7559.848803024019;4617.215073437591;4637.25803871379;4659.976700116477;4665.533446655308;4672.018876036071;7083.397911177608;7105.111861017373;7131.037309963089;7134.500584959211;7148.392386647193;6920.377166055079;6923.2038315594355;6931.029655848084;6931.133608298963;6931.896021559782;6636.83407914806;6825.044493770777;6904;6907.758228461979;6926.134233220848;6750.763723269662;6770.93229067703;6790.830229244309;6791.524593278423;6823.55646882951;6929.861402772017;6932.410745086724;6960.37356637905;6961.7215311389;6989.0564773754895;6714.328567143247;6760.526763126534;6782.355676210752;6790.524663273523;6790.830229244309 21:53:58 INFO - PROCESS | 21487 | |5;yui.html;752.8720117580011;766.8657984852656;799.0611032037355;840.8984230657838;882.5146169606714;14606.488772892952;14734.410623575044;14762.040467369614;14868.182249976233;14936.551903442887;12954.48182072716;12978.805317920214;13077.149985250975;13103.54137605184;13119.409626566827;877.398981697536;890.3278025091047;907.3467103685336;910.640297082652;916.8441364967971;905.0451773379083;910.1080940678139;913.488446469979;914.0174312613933;916.5005072235648;921.0881227584676;928.0487500312166;928.2944961828991;928.3501548915785;928.3640706116332;923.7505873414208;925.5141050948239;925.5649844573006;926.0230456868002;926.0831776541243;672.0758956434902;674.1674032569821;674.2381109346456;676.5061505101254;679.7077256779583;15644.608884777857;15647.687046259125;15669.764953525706;15692.979956302917;15733.68532629341;14206;14302.213378264192;14499.275036248146;14543.418263269457;14620.853791462056;11969.94015029928;12153.574624888086;12199.695007624792;12221.511139554406;12416.130870839044;3969.3053715599945;4005.239004589148;4016.8995775105564;4028.174224284044;4051.4125451809323;61440.692796536176;61839.38160618426;62016;62222.44443888894;63010;11036.282641628268;11051.944740276247;11176.217664763388;11233.66299011031;11439.656810295704;20442;20543;20586.176552937715;20623.071961761456;20623.381298561068;8674.956625216833;8821;8881.319361895565;8888.244499217639;8987.370884038055;4899.436564795023;4907.435644900811;4934.235193545006;4956.157453232959;5045.672031318026;3647.8176091195332;3725;3732.664060234592;3736.1033351995325;3754.9061273467837;598.2671227746064;607.3653032580963;613.487737738984;614.4807637546267;617.6818938246806;764.4725139653622;793.4723408933111;800.7837883771349;822.5887056471764;833.295864994079;9386.15524602789;9477.857832132524;9627.277954153467;9670.626564424401;9756.560954757053;648.844277373427;650.4731167754135;730.2952650692108;731.2175971710219;751.2600088912417;4290.785460726951;4361.781910904442;4434.201843668106;4439.64482841372;4474.105178964221;68079.65960170167;68739.31260687429;68923.65538172377;68956.31043689599;69073;61458;61693.691531542056;62043;62386;62518.374816252166;54675;55046;55140.44859551433;55289.1706624401;55984.440155598735;8482;8717.215450609221;8741.606627701642;9006.099390060941;9012.684556040507;36855.44716829303;38080.23839523138;38469.6153038466;38577.80711096426;39501.80249098851;48125.75937120432;50287.74856125842;52188;52278.215826761865;53321.46678533165;10917;10998.835017474905;11055.668329950115;11271.49278282463;11464.082873370277;11963.521459141537;12399.442025108712;12414.503419863104;12512.37438128108;12541;12438.564650237198;12554.686132846751;12615.053870959531;12840.03699722506;13102.541411050568;11821.940890295493;12070.456829442872;12128;12309.93845030769;12424.06819488524;12559.99520038413;12672.746545068863;12714.427850746553;12803.231806091664;13174.143680660727;10213.540390682288;10276.845847312146;10424.426656533964;10512.369257844553;10519.842202367123;10254.487275636038;10529.736756581147;10616.1507079435;10682.57269709203;10699.411532365795 21:53:58 INFO - PROCESS | 21487 | __end_tp_report 21:53:58 INFO - PROCESS | 21487 | __start_cc_report 21:53:58 INFO - PROCESS | 21487 | _x_x_mozilla_cycle_collect,317 21:53:58 INFO - PROCESS | 21487 | __end_cc_report 21:53:58 INFO - PROCESS | 21487 | __startTimestamp1463547238073__endTimestamp 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | ------- Summary: start ------- 21:53:58 INFO - PROCESS | 21487 | Number of tests: 6 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | [#0] dojo.html Cycles:165 Average:5441.40 Median:5658.75 stddev:587.21 (10.4%) stddev-sans-first:563.60 21:53:58 INFO - PROCESS | 21487 | Values: 3263.1 3314.4 3320.4 3369.3 3374.3 5471.6 5475.9 5489.3 5493.3 5519.9 5475.7 5484.6 5511.9 5520.9 5529.8 5002.8 5004.8 5052.6 5065.7 5071.0 4923.4 5031.2 5136.8 5158.1 5158.3 4917.4 5028.5 5037.5 5102.8 5128.9 5025.2 5035.0 5043.1 5053.1 5078.6 4941.5 4969.0 4998.1 5018.8 5039.1 5228.2 5284.3 5308.8 5349.8 5350.8 5744.5 5799.5 5810.4 5810.6 5811.0 5761.1 5874.4 5875.2 5887.6 5894.0 5446.8 5468.2 5470.2 5507.1 5509.0 5933.9 5937.5 5949.4 5973.6 5982.3 5658.7 5715.4 5726.3 5754.7 5758.8 5671.5 5727.5 5740.1 5748.8 5773.8 5701.0 5707.9 5708.7 5724.0 5728.1 5613.4 5724.3 5763.8 5807.2 5856.6 4416.6 4447.8 4460.7 4463.5 4482.1 4042.6 4047.8 4057.9 4069.2 4095.2 5412.2 5681.1 5740.9 5778.9 5780.5 5718.5 5938.9 5962.1 5994.1 6031.9 5591.4 5616.5 5638.5 5639.5 5642.7 4866.4 4944.5 5020.0 5028.0 5034.8 6064.8 6076.6 6109.9 6134.8 6157.4 5782.2 5888.6 5909.0 5911.9 5922.4 6097.1 6118.2 6136.3 6141.2 6142.6 5766.5 5772.4 5775.3 5780.2 5785.4 5664.5 5835.9 5861.9 5863.4 5869.8 5678.9 5707.2 5708.9 5710.8 5741.2 5630.5 5667.2 5668.2 5686.7 5692.1 5476.4 5590.8 5593.6 5625.2 5676.9 5678.1 5690.9 5719.6 5720.5 5741.5 5580.8 5591.6 5596.4 5602.2 5627.2 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | [#1] ext.html Cycles:180 Average:55317.96 Median:40418.20 stddev:112234.49 (277.7%) stddev-sans-first:112474.16 21:53:58 INFO - PROCESS | 21487 | Values: 607.1 645.2 649.1 665.3 680.4 32560.3 39531.6 39537.2 39740.8 40123.2 43238.8 43314.4 43431.8 43570.6 43793.2 8857.4 8967.0 9020.6 9043.1 9052.9 8832.1 8927.1 8977.0 8982.7 8984.2 9182.8 9208.4 9218.2 9248.4 9288.7 9169.7 9190.1 9194.8 9201.2 9202.6 8734.6 8757.3 8758.4 8769.2 9085.1 43068.4 43135.4 43491.6 43538.8 43593.1 3629.4 3740.8 3754.2 3787.7 3859.6 32997.3 33376.7 33440.3 33694.0 35061.6 4458.4 4528.4 4567.8 4628.2 4672.9 228129.0 228267.0 229866.0 300618.0 300661.0 38955.2 57295.7 59804.0 59877.0 60046.1 37395.1 37424.0 37578.2 37606.2 37766.6 17411.7 17739.5 17746.7 17786.8 17820.0 14964.9 15082.5 15146.1 15147.9 15172.2 9072.4 9205.3 9220.2 9265.7 9277.1 3573.9 3631.4 3667.7 3669.0 3687.3 1134.7 1182.7 1202.9 1209.9 1219.8 32368.5 33257.0 33442.5 33739.7 33927.8 1243.3 1275.9 1301.5 1316.4 1333.6 17137.2 17283.9 17610.3 17628.6 17632.9 201787.0 203793.0 601657.0 609512.0 673023.0 58608.7 60054.0 60072.7 60137.4 60322.0 1490.9 1540.4 1542.3 1567.2 1574.5 32227.0 32748.7 33056.5 33307.3 33819.3 51109.7 51649.5 52167.2 52170.0 52317.0 453319.0 455969.0 457724.0 457756.0 458033.0 30004.0 30323.7 30485.1 30550.7 30923.7 48237.0 48535.3 48610.0 48698.3 49406.5 40888.4 41520.6 41828.6 42080.6 42441.6 39313.0 40025.8 40390.8 40445.6 40931.4 42142.0 42388.4 42606.4 43336.6 43559.3 34556.7 35753.8 36108.1 36342.3 36743.4 28031.3 28501.3 28558.3 28782.1 29133.6 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | [#2] jquery.html Cycles:180 Average:29098.25 Median:22690.17 stddev:84554.43 (372.6%) stddev-sans-first:84764.21 21:53:58 INFO - PROCESS | 21487 | Values: 421.1 423.6 431.4 433.6 439.0 14400.4 17904.6 18667.3 18763.2 18766.2 18091.5 19525.1 19590.2 20225.7 20279.8 5495.8 5562.7 5753.4 5759.9 5824.5 5653.3 5714.1 5720.1 5739.3 5747.2 5318.3 5634.7 5665.3 5673.3 5675.8 5532.8 5554.4 5566.3 5568.2 5579.6 5388.4 5418.1 5472.9 5479.0 5614.1 14136.4 14143.6 14215.0 22299.3 23081.0 2345.8 2358.9 2435.8 2468.4 2964.1 10196.1 10307.4 10378.7 12784.2 13508.1 2015.6 2038.0 2046.6 2116.6 2124.7 77417.0 78585.2 79173.6 80351.6 81072.0 11144.7 11295.9 11906.9 12062.5 12357.5 15848.6 16058.3 16142.6 16159.4 16213.8 8954.7 8966.3 8977.7 9069.3 9115.4 8926.9 8935.6 8944.9 8958.6 9030.9 4884.9 4922.1 4975.4 4976.1 5013.5 2052.7 2053.3 2056.0 2087.3 2154.0 451.4 1119.9 1128.2 1130.8 1140.8 11412.8 12068.4 12080.0 12144.6 12309.0 1095.9 1108.5 1113.9 1129.1 1129.5 10112.7 10583.2 10662.0 10738.5 10766.5 503646.0 508464.0 512179.0 514680.0 531881.0 83135.0 86233.6 87595.6 89724.0 90893.0 1127.6 1139.9 1155.1 1168.8 1171.6 17096.0 17256.0 17264.4 17289.1 17360.0 38270.6 38453.0 39798.2 40307.2 41468.4 52543.7 54788.5 56982.4 57371.0 57830.1 8447.5 8830.5 8889.7 8925.0 8933.3 9473.8 11983.8 13245.5 13425.9 13573.9 11253.4 11330.3 11336.3 11426.2 11566.6 11439.9 11532.3 11590.4 11615.8 11666.9 11508.4 11741.2 11746.2 11923.2 12237.0 8833.2 8954.1 8984.8 9036.5 9063.6 8616.7 11100.4 11127.7 11338.8 12003.8 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | [#3] mootools.html Cycles:180 Average:5424.49 Median:4793.03 stddev:2994.40 (62.5%) stddev-sans-first:2988.65 21:53:58 INFO - PROCESS | 21487 | Values: 1550.6 1567.0 1760.1 1848.4 1855.2 7155.0 7505.6 7810.5 7933.0 8005.8 7156.0 7701.4 7741.8 7939.0 8027.3 2309.4 2313.7 2330.6 2350.4 2357.0 2231.9 2277.6 2280.2 2283.7 2303.7 2252.9 2272.5 2283.6 2311.0 2314.0 2301.3 2302.3 2308.7 2321.6 2332.5 2323.2 2323.3 2336.9 2345.1 2346.3 8228.9 8260.8 8328.1 8338.6 8349.5 4909.2 5004.5 5013.8 5014.5 5035.2 3294.4 3295.3 3391.9 3402.5 3436.1 1131.3 1134.1 1136.0 1164.0 1184.7 11510.7 11538.9 11572.8 11575.7 11604.8 4204.1 4305.3 4314.4 4362.2 4377.1 9583.3 9595.1 9611.4 9625.8 9627.5 5030.9 5058.2 5080.5 5088.2 5091.8 4219.3 4525.2 4605.2 4626.8 4652.2 3814.3 3869.4 3911.9 3928.7 4065.1 1210.7 1214.6 1214.9 1224.4 1244.6 1039.3 1051.4 1054.7 1056.4 1069.1 5619.0 5660.4 5688.3 5711.0 5794.6 413.3 417.3 435.3 452.2 459.1 4032.1 4067.3 4114.0 4142.6 4171.5 10054.7 10256.3 10261.6 10280.9 10324.4 10068.6 10121.2 10143.9 10150.4 10242.6 7794.6 7851.8 7864.3 7912.9 7927.0 5498.4 5546.1 5592.9 5678.8 5795.2 9053.7 9132.7 9133.3 9136.5 9175.8 8885.1 9041.1 9145.9 9248.5 9315.1 6533.6 7037.4 7087.9 7213.2 7232.3 7719.9 7729.5 7741.5 7742.1 7824.2 6978.9 7151.1 7157.2 7208.2 7216.1 6990.2 7068.0 7084.7 7125.4 7146.8 6233.1 6361.7 6373.3 6390.7 6412.6 4968.7 4993.1 4996.2 5003.3 5018.3 4789.6 4796.4 4810.4 4856.0 4922.7 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | [#4] prototype.html Cycles:180 Average:5712.64 Median:6627.99 stddev:1792.88 (27.1%) stddev-sans-first:1751.67 21:53:58 INFO - PROCESS | 21487 | Values: 322.6 335.3 339.4 340.9 341.3 6422.8 6553.8 6587.1 6598.1 6619.1 6450.2 6467.1 6470.8 6485.3 6494.9 4674.9 4734.5 4837.0 4843.1 4887.1 4830.7 4864.0 4871.4 4889.3 4897.3 4831.0 4831.1 4831.1 4834.0 4834.7 4813.9 4832.8 4836.7 4844.3 4848.2 4222.8 4223.1 4227.0 4230.2 4233.7 5940.4 6142.6 6161.2 6172.1 6178.5 5489.1 5502.1 5534.8 5542.1 5542.8 6758.3 6785.2 6804.8 6806.0 6816.5 4523.2 4531.2 4531.6 4544.8 4549.0 7039.4 7090.7 7119.6 7129.4 7139.6 4460.1 4579.9 4604.1 4620.5 4641.4 4662.0 4680.6 4687.7 4706.6 4709.4 5522.7 5534.8 5540.5 5550.4 5554.2 6797.7 6812.3 6858.5 6860.3 6871.1 1615.4 1616.9 1618.7 1628.8 1631.1 1030.5 1044.5 1054.0 1057.0 1072.5 6652.0 6655.5 6680.6 6681.1 6694.8 6827.6 7078.4 7092.1 7103.6 7108.7 6542.4 6701.0 6756.7 6764.2 6767.2 3831.2 3856.5 3857.9 3875.7 3882.1 7408.4 7517.2 7546.7 7547.1 7558.5 7029.9 7209.0 7279.0 7293.5 7302.1 7513.1 7517.3 7520.5 7523.3 7546.2 7162.4 7174.8 7175.0 7177.7 7183.7 7073.7 7077.0 7093.7 7125.5 7134.8 7242.3 7426.5 7523.8 7559.7 7559.8 4617.2 4637.3 4660.0 4665.5 4672.0 7083.4 7105.1 7131.0 7134.5 7148.4 6920.4 6923.2 6931.0 6931.1 6931.9 6636.8 6825.0 6904.0 6907.8 6926.1 6750.8 6770.9 6790.8 6791.5 6823.6 6929.9 6932.4 6960.4 6961.7 6989.1 6714.3 6760.5 6782.4 6790.5 6790.8 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - PROCESS | 21487 | [#5] yui.html Cycles:180 Average:15922.21 Median:26512.60 stddev:19265.52 (72.7%) stddev-sans-first:19285.89 21:53:58 INFO - PROCESS | 21487 | Values: 752.9 766.9 799.1 840.9 882.5 14606.5 14734.4 14762.0 14868.2 14936.6 12954.5 12978.8 13077.1 13103.5 13119.4 877.4 890.3 907.3 910.6 916.8 905.0 910.1 913.5 914.0 916.5 921.1 928.0 928.3 928.4 928.4 923.8 925.5 925.6 926.0 926.1 672.1 674.2 674.2 676.5 679.7 15644.6 15647.7 15669.8 15693.0 15733.7 14206.0 14302.2 14499.3 14543.4 14620.9 11969.9 12153.6 12199.7 12221.5 12416.1 3969.3 4005.2 4016.9 4028.2 4051.4 61440.7 61839.4 62016.0 62222.4 63010.0 11036.3 11051.9 11176.2 11233.7 11439.7 20442.0 20543.0 20586.2 20623.1 20623.4 8675.0 8821.0 8881.3 8888.2 8987.4 4899.4 4907.4 4934.2 4956.2 5045.7 3647.8 3725.0 3732.7 3736.1 3754.9 598.3 607.4 613.5 614.5 617.7 764.5 793.5 800.8 822.6 833.3 9386.2 9477.9 9627.3 9670.6 9756.6 648.8 650.5 730.3 731.2 751.3 4290.8 4361.8 4434.2 4439.6 4474.1 68079.7 68739.3 68923.7 68956.3 69073.0 61458.0 61693.7 62043.0 62386.0 62518.4 54675.0 55046.0 55140.4 55289.2 55984.4 8482.0 8717.2 8741.6 9006.1 9012.7 36855.4 38080.2 38469.6 38577.8 39501.8 48125.8 50287.7 52188.0 52278.2 53321.5 10917.0 10998.8 11055.7 11271.5 11464.1 11963.5 12399.4 12414.5 12512.4 12541.0 12438.6 12554.7 12615.1 12840.0 13102.5 11821.9 12070.5 12128.0 12309.9 12424.1 12560.0 12672.7 12714.4 12803.2 13174.1 10213.5 10276.8 10424.4 10512.4 10519.8 10254.5 10529.7 10616.2 10682.6 10699.4 21:53:58 INFO - PROCESS | 21487 | -------- Summary: end -------- 21:53:58 INFO - PROCESS | 21487 | 21:53:58 INFO - TEST-INFO | 21487: exit 0 21:53:58 INFO - TEST-OK | dromaeo_css | took 1108898ms 21:53:58 INFO - TEST-START | kraken 21:53:58 INFO - operating with platform_type : linux_ 21:53:58 INFO - Initialising browser for kraken test... 21:53:58 INFO - TEST-INFO | started process 21728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRO4N50/profile http://localhost:35531/getInfo.html) 21:54:02 INFO - PROCESS | 21728 | 21:54:02 INFO - PROCESS | 21728 | (process:21810): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:54:03 INFO - PROCESS | 21728 | __metrics Screen width/height:1600/1200 21:54:03 INFO - PROCESS | 21728 | colorDepth:24 21:54:03 INFO - PROCESS | 21728 | Browser inner width/height: 1024/697 21:54:03 INFO - PROCESS | 21728 | __metrics 21:54:04 ERROR - PROCESS | 21728 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 21:54:04 INFO - TEST-INFO | 21728: exit 0 21:54:04 INFO - Browser initialized. 21:54:04 INFO - Running cycle 1/1 for kraken test... 21:54:04 INFO - TEST-INFO | started process 21861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRO4N50/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:06 INFO - PROCESS | 21861 | 21:54:06 INFO - PROCESS | 21861 | (process:21928): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:54:16 INFO - PROCESS | 21861 | RSS: Main: 151842816 21:54:16 INFO - PROCESS | 21861 | 21:54:19 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35531/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:20 INFO - PROCESS | 21861 | RSS: Main: 156831744 21:54:20 INFO - PROCESS | 21861 | 21:54:22 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35531/tests/kraken/driver.html?testName=audio-dft) 21:54:23 INFO - PROCESS | 21861 | RSS: Main: 156676096 21:54:23 INFO - PROCESS | 21861 | 21:54:26 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35531/tests/kraken/driver.html?testName=audio-fft) 21:54:26 INFO - PROCESS | 21861 | RSS: Main: 157122560 21:54:26 INFO - PROCESS | 21861 | 21:54:28 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35531/tests/kraken/driver.html?testName=audio-oscillator) 21:54:29 INFO - PROCESS | 21861 | RSS: Main: 156983296 21:54:29 INFO - PROCESS | 21861 | 21:54:31 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:32 INFO - PROCESS | 21861 | RSS: Main: 156921856 21:54:32 INFO - PROCESS | 21861 | 21:54:35 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35531/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:35 INFO - PROCESS | 21861 | RSS: Main: 157315072 21:54:35 INFO - PROCESS | 21861 | 21:54:39 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35531/tests/kraken/driver.html?testName=imaging-desaturate) 21:54:39 INFO - PROCESS | 21861 | RSS: Main: 157401088 21:54:39 INFO - PROCESS | 21861 | 21:54:42 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35531/tests/kraken/driver.html?testName=json-parse-financial) 21:54:43 INFO - PROCESS | 21861 | RSS: Main: 157462528 21:54:43 INFO - PROCESS | 21861 | 21:54:44 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:54:45 INFO - PROCESS | 21861 | RSS: Main: 157442048 21:54:45 INFO - PROCESS | 21861 | 21:54:47 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:54:47 INFO - PROCESS | 21861 | RSS: Main: 156659712 21:54:47 INFO - PROCESS | 21861 | 21:54:49 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:50 INFO - PROCESS | 21861 | RSS: Main: 157253632 21:54:50 INFO - PROCESS | 21861 | 21:54:52 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:53 INFO - PROCESS | 21861 | RSS: Main: 157405184 21:54:53 INFO - PROCESS | 21861 | 21:54:56 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:56 INFO - PROCESS | 21861 | RSS: Main: 157396992 21:54:56 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | Cycle 1(1): loaded http://localhost:35531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35531/tests/kraken/driver.html?testName=ai-astar) 21:54:58 INFO - PROCESS | 21861 | RSS: Main: 159416320 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | __start_tp_report 21:54:58 INFO - PROCESS | 21861 | _x_x_mozilla_page_load 21:54:58 INFO - PROCESS | 21861 | _x_x_mozilla_page_load_details 21:54:58 INFO - PROCESS | 21861 | |i|pagename|runs| 21:54:58 INFO - PROCESS | 21861 | |0;ai-astar;108;110;105;110;113;110;100;111;110;111 21:54:58 INFO - PROCESS | 21861 | |1;audio-beat-detection;159;128;154;190;131;154;159;134;197;141 21:54:58 INFO - PROCESS | 21861 | |2;audio-dft;162;164;163;165;163;164;162;162;162;162 21:54:58 INFO - PROCESS | 21861 | |3;audio-fft;75;77;76;167;76;76;76;77;173;78 21:54:58 INFO - PROCESS | 21861 | |4;audio-oscillator;91;92;152;92;92;91;139;91;91;146 21:54:58 INFO - PROCESS | 21861 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;118;118 21:54:58 INFO - PROCESS | 21861 | |6;imaging-darkroom;146;148;147;147;147;147;147;148;146;146 21:54:58 INFO - PROCESS | 21861 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;95;95 21:54:58 INFO - PROCESS | 21861 | |8;json-parse-financial;58;56;54;56;55;55;58;73;54;54 21:54:58 INFO - PROCESS | 21861 | |9;json-stringify-tinderbox;58;58;57;58;59;58;58;58;58;59 21:54:58 INFO - PROCESS | 21861 | |10;stanford-crypto-aes;73;72;74;74;74;81;75;74;78;75 21:54:58 INFO - PROCESS | 21861 | |11;stanford-crypto-ccm;117;122;120;124;113;115;127;115;135;130 21:54:58 INFO - PROCESS | 21861 | |12;stanford-crypto-pbkdf2;160;158;159;161;160;161;161;157;159;160 21:54:58 INFO - PROCESS | 21861 | |13;stanford-crypto-sha256-iterative;65;66;69;70;67;73;68;66;66;65 21:54:58 INFO - PROCESS | 21861 | __end_tp_report 21:54:58 INFO - PROCESS | 21861 | __start_cc_report 21:54:58 INFO - PROCESS | 21861 | _x_x_mozilla_cycle_collect,868 21:54:58 INFO - PROCESS | 21861 | __end_cc_report 21:54:58 INFO - PROCESS | 21861 | __startTimestamp1463547298741__endTimestamp 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | ------- Summary: start ------- 21:54:58 INFO - PROCESS | 21861 | Number of tests: 14 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.95 21:54:58 INFO - PROCESS | 21861 | Values: 108.0 110.0 105.0 110.0 113.0 110.0 100.0 111.0 110.0 111.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:156.50 stddev:23.49 (15.0%) stddev-sans-first:24.86 21:54:58 INFO - PROCESS | 21861 | Values: 159.0 128.0 154.0 190.0 131.0 154.0 159.0 134.0 197.0 141.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 21:54:58 INFO - PROCESS | 21861 | Values: 162.0 164.0 163.0 165.0 163.0 164.0 162.0 162.0 162.0 162.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:39.51 (52.0%) stddev-sans-first:41.23 21:54:58 INFO - PROCESS | 21861 | Values: 75.0 77.0 76.0 167.0 76.0 76.0 76.0 77.0 173.0 78.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:91.00 stddev:26.38 (29.0%) stddev-sans-first:27.28 21:54:58 INFO - PROCESS | 21861 | Values: 91.0 92.0 152.0 92.0 92.0 91.0 139.0 91.0 91.0 146.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:54:58 INFO - PROCESS | 21861 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 21:54:58 INFO - PROCESS | 21861 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 146.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:54:58 INFO - PROCESS | 21861 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.00 stddev:5.72 (10.2%) stddev-sans-first:6.06 21:54:58 INFO - PROCESS | 21861 | Values: 58.0 56.0 54.0 56.0 55.0 55.0 58.0 73.0 54.0 54.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 21:54:58 INFO - PROCESS | 21861 | Values: 58.0 58.0 57.0 58.0 59.0 58.0 58.0 58.0 58.0 59.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:2.62 (3.5%) stddev-sans-first:2.68 21:54:58 INFO - PROCESS | 21861 | Values: 73.0 72.0 74.0 74.0 74.0 81.0 75.0 74.0 78.0 75.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.00 stddev:7.22 (5.9%) stddev-sans-first:7.45 21:54:58 INFO - PROCESS | 21861 | Values: 117.0 122.0 120.0 124.0 113.0 115.0 127.0 115.0 135.0 130.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 21:54:58 INFO - PROCESS | 21861 | Values: 160.0 158.0 159.0 161.0 160.0 161.0 161.0 157.0 159.0 160.0 21:54:58 INFO - PROCESS | 21861 | 21:54:58 INFO - PROCESS | 21861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:2.55 (3.8%) stddev-sans-first:2.54 21:54:58 INFO - PROCESS | 21861 | Values: 65.0 66.0 69.0 70.0 67.0 73.0 68.0 66.0 66.0 65.0 21:54:58 INFO - PROCESS | 21861 | -------- Summary: end -------- 21:54:58 INFO - PROCESS | 21861 | 21:54:59 INFO - TEST-INFO | 21861: exit 0 21:54:59 INFO - TEST-OK | kraken | took 60933ms 21:54:59 INFO - SUITE-END | took 1169s 21:54:59 INFO - Completed test suite (00:19:30) 21:54:59 INFO - javascript benchmark 21:54:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.118957881372, 3314.38683843489, 3320.418926687829, 3369.292448585797, 3374.25766331407, 5471.5896307776975, 5475.917861232085, 5489.313835770528, 5493.258410114633, 5519.9172012419795, 5475.72621368932, 5484.561235101192, 5511.917321240175, 5520.861978450531, 5529.834104976847, 5002.849914502562, 5004.84985450437, 5052.6210534209895, 5065.670731402465, 5070.974645126787, 4923.409190897098, 5031.22016087507, 5136.8458946231485, 5158.071547121516, 5158.303629010074, 4917.434495033063, 5028.522290382426, 5037.496250374951, 5102.821401250957, 5128.871778205537, 5025.246213068051, 5034.974825125869, 5043.142665746832, 5053.090443720129, 5078.64449488536, 4941.530554597308, 4968.975155124237, 4998.10034193845, 5018.824341148079, 5039.118154323016, 5228.163493840967, 5284.313039304904, 5308.761105750251, 5349.7592608332325, 5350.839474815762, 5744.511716504102, 5799.536037117021, 5810.389909059572, 5810.5932584719085, 5810.970945145289, 5761.135829625548, 5874.353821079678, 5875.206847075633, 5887.558433117533, 5894.0, 5446.754896029649, 5468.179773034077, 5470.234167216593, 5507.091329930557, 5509.035918714249, 5933.9406605934255, 5937.495312898365, 5949.405059494016, 5973.641581505123, 5982.341942386334, 5658.74535645897, 5715.428457154251, 5726.312842458931, 5754.74103665336, 5758.7696492140685, 5671.51792097668, 5727.4845263926445, 5740.052891272893, 5748.770049198069, 5773.797917072882, 5701.0, 5707.885842283131, 5708.71456427177, 5724.026915424388, 5728.054870946247, 5613.354464236583, 5724.284464441945, 5763.827085187451, 5807.186993820868, 5856.648601083949, 4416.646668266531, 4447.822087116544, 4460.7323560586465, 4463.509014008457, 4482.103579284156, 4042.6159514846045, 4047.817848196838, 4057.9391309130388, 4069.2268468991388, 4095.1604920991126, 5412.215228791882, 5681.0910254359105, 5740.913886291709, 5778.855528611818, 5780.53755699543, 5718.51392631631, 5938.851528711817, 5962.135490353874, 5994.130851026577, 6031.884101441247, 5591.384947655754, 5616.466435688603, 5638.548916086703, 5639.492445679826, 5642.6614403135945, 4866.440359358719, 4944.53026962438, 5020.0, 5028.044671512401, 5034.798608055637, 6064.818055458343, 6076.635401875901, 6109.908351374733, 6134.754609815646, 6157.353477884847, 5782.2194003808945, 5888.617239879565, 5908.970455147783, 5911.85220369477, 5922.437368449991, 6097.146399504161, 6118.192813661829, 6136.335271946791, 6141.219046476651, 6142.621558143092, 5766.481016708516, 5772.393898640582, 5775.306963164448, 5780.21967034445, 5785.4214578541805, 5664.461876121762, 5835.854103647443, 5861.9413805863105, 5863.355030946678, 5869.8239052828485, 5678.914816277676, 5707.1724599933605, 5708.857278568069, 5710.828675139753, 5741.196232527366, 5630.465105814941, 5667.1782591524825, 5668.206451096932, 5686.658800471985, 5692.117721753135, 5476.397596264487, 5590.832275031756, 5593.552515798808, 5625.156226565884, 5676.914846277392, 5678.063119585222, 5690.886182276414, 5719.599628026164, 5720.542356611544, 5741.540676745767, 5580.804671836466, 5591.552675785846, 5596.384397716167, 5602.187682786055, 5627.155926610877], "value": 5404.479380187693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.116645281116, 645.15806872032, 649.1398896462189, 665.2748504130496, 680.4216416046359, 32560.348793024124, 39531.604683953155, 39537.209255814865, 39740.80129599355, 40123.19753604926, 43238.783806081, 43314.35028474576, 43431.78284108575, 43570.56429435705, 43793.24827006916, 8857.424267422613, 8966.955165224164, 9020.594073266719, 9043.095690430937, 9052.909470905306, 8832.11678832118, 8927.06265842087, 8976.955115224415, 8982.730518084436, 8984.19142277195, 9182.770430739218, 9208.401453905508, 9218.17036466718, 9248.352615316931, 9288.674896378629, 9169.72490825273, 9190.126937940884, 9194.816103677957, 9201.217896478807, 9202.585883635185, 8734.606942687595, 8757.255633271116, 8758.430702004349, 8769.166929141722, 9085.13691199335, 43068.353974690406, 43135.35296970548, 43491.565084349066, 43538.782306088586, 43593.128137437074, 3629.401148810443, 3740.831662575191, 3754.1740817020213, 3787.6780473659774, 3859.59474255202, 32997.34005319904, 33376.6662333376, 33440.33119337624, 33694.0, 35061.64938350635, 4458.375827384169, 4528.411306530163, 4567.840125595588, 4628.1669299526075, 4672.883177920545, 228129.0, 228267.0, 229866.0, 300617.9999999978, 300661.0, 38955.22089558193, 57295.71352143296, 59804.0, 59877.0, 60046.099308510406, 37395.06512337214, 37424.0, 37578.248435031695, 37606.24787504289, 37766.62233377686, 17411.65176696459, 17739.46781596554, 17746.733798993024, 17786.822131778776, 17820.0, 14964.925175374054, 15082.54752357431, 15146.091234525964, 15147.924260378628, 15172.165530895907, 9072.410293330913, 9205.263578913671, 9220.248152850936, 9265.72202833916, 9277.072292770668, 3573.857045718142, 3631.4371272452813, 3667.743257971916, 3669.0, 3687.3178461984617, 1134.7219931116929, 1182.6688527212223, 1202.9037676985995, 1209.8608660004213, 1219.8475190601175, 32368.514472282935, 33257.0, 33442.49836252458, 33739.66260337414, 33927.830360848035, 1243.3410292544966, 1275.8787915148046, 1301.537954026326, 1316.3681432912065, 1333.6332508560224, 17137.228824702917, 17283.913580432018, 17610.295588176585, 17628.559286017953, 17632.911835441, 201787.0, 203793.0, 601657.0, 609512.0, 673023.0, 58608.70695646494, 60054.0, 60072.69963650154, 60137.39862601318, 60322.0, 1490.8658220760183, 1540.3915453395846, 1542.3213785934154, 1567.1850637668576, 1574.4568123997203, 32227.0, 32748.672513274563, 33056.50415243821, 33307.333853322314, 33819.32361352808, 51109.744451277504, 51649.48350516447, 52167.21749173841, 52170.0, 52317.0, 453319.0, 455969.0, 457724.0, 457756.0, 458033.0, 30004.0, 30323.696763032087, 30485.085447436613, 30550.694493054783, 30923.69076309208, 48237.0, 48535.271970919755, 48610.0, 48698.26952595785, 49406.50593494019, 40888.386674200505, 41520.58479415288, 41828.58171418247, 42080.57919420889, 42441.575584243765, 39313.017174570865, 40025.79987100046, 40390.79804600958, 40445.59554404418, 40931.38602921018, 42142.0, 42388.36417453679, 42606.360904587076, 43336.566634333256, 43559.34660980025, 34556.65443345635, 35753.82123089368, 36108.09729756777, 36342.27315453623, 36743.448848266766, 28031.299217519725, 28501.287467812643, 28558.286042849097, 28782.136535903956, 29133.562996554643], "value": 19456.344264709343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.1177582963691, 423.6293243412014, 431.4455924137483, 433.59242312226525, 439.0209832074474, 14400.351984160712, 17904.641907161866, 18667.346642867502, 18763.155657995405, 18766.249350025984, 18091.457256282334, 19525.12136953837, 19590.21639134433, 20225.696614550758, 20279.797202027974, 5495.752691128899, 5562.749676264578, 5753.424657534234, 5759.913601295984, 5824.534037277008, 5653.349864765563, 5714.114312281603, 5720.141978703186, 5739.253896993385, 5747.166660834177, 5318.30861987943, 5634.661920284776, 5665.291838520185, 5673.347565030033, 5675.772969081232, 5532.806351777709, 5554.389017208104, 5566.276384070085, 5568.248286481355, 5579.609427340088, 5388.407275199725, 5418.051840927861, 5472.863178420532, 5479.0, 5614.129809879475, 14136.434542618283, 14143.575692729235, 14215.0, 22299.331020069425, 23081.0, 2345.835791494596, 2358.8820558971984, 2435.780779729815, 2468.358226861011, 2964.0515035188746, 10196.082352588302, 10307.381557106597, 10378.688639340831, 12784.232946023269, 13508.121972071882, 2015.5767288869356, 2037.9694304585444, 2046.5702202537484, 2116.5555233401005, 2124.7237859078223, 77417.0, 78585.21414785837, 79173.60413197955, 80351.59824200842, 81072.0, 11144.665660030212, 11295.943520282346, 11906.88093119075, 12062.51749929993, 12357.505699771908, 15848.60378490547, 16058.277377517807, 16142.596435089217, 16159.43441979525, 16213.756793648105, 8954.731358059269, 8966.282697384193, 8977.685780997634, 9069.31980101495, 9115.407498512575, 8926.910730892609, 8935.597898094602, 8944.910550894538, 8958.596863141174, 9030.86453703195, 4884.902301954012, 4922.089413458521, 4975.4278258000795, 4976.104301225741, 5013.49865013503, 2052.6613108836873, 2053.271088763497, 2055.9588808223752, 2087.3424871165535, 2153.9876258158642, 451.4447229907233, 1119.88801119889, 1128.227164392394, 1130.8247221680654, 1140.75087778882, 11412.771744565061, 12068.396580171131, 12080.0, 12144.635660930186, 12309.0, 1095.9452027398597, 1108.5288752280248, 1113.9164562657834, 1129.0910816792561, 1129.5481807277156, 10112.696619101438, 10583.206259530565, 10662.04041636241, 10738.516766745515, 10766.515506802212, 503646.0, 508464.0, 512179.0, 514680.0, 531881.0, 83135.0, 86233.56883215543, 87595.56202218948, 89724.0, 90893.0, 1127.5658871334595, 1139.8689150747605, 1155.1047937848066, 1168.760404117171, 1171.5899435197612, 17096.0, 17256.0, 17264.395746148824, 17289.13554322304, 17360.045197514257, 38270.617293826705, 38453.0, 39798.2040359197, 40307.193856122125, 41468.377974331015, 52543.737281314876, 54788.45211547993, 56982.430175699374, 57371.0, 57830.132548012654, 8447.535385553607, 8830.470171789713, 8889.688860889837, 8925.0, 8933.330000250136, 9473.768410106642, 11983.76032479363, 13245.536406225736, 13425.932870335586, 13573.914086873225, 11253.437328133725, 11330.320180789178, 11336.263142895685, 11426.2001659883, 11566.595169169039, 11439.942800285946, 11532.25040372373, 11590.36253006059, 11615.76768464643, 11666.941665291619, 11508.36703981289, 11741.236819606698, 11746.236494627821, 11923.224990375598, 12237.0, 8833.205011548991, 8954.059823718415, 8984.820303594022, 9036.457812531005, 9063.637454501746, 8616.741497755078, 11100.444977750918, 11127.666170014912, 11338.829917551408, 12003.81994270104], "value": 9199.216364977878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.6433520290334, 1567.0127819473732, 1760.084755926918, 1848.3807924345344, 1855.2115350975832, 7154.96422517888, 7505.587192704399, 7810.53136811791, 7932.960335198323, 8005.799855003628, 7156.0, 7701.422393320496, 7741.845163096735, 7939.0, 8027.277545020947, 2309.3764683535437, 2313.687652166957, 2330.568844763716, 2350.3536527455003, 2357.0453966143655, 2231.94420139497, 2277.567262220173, 2280.1905323610126, 2283.7145356830397, 2303.7005189325364, 2252.8760918149496, 2272.5114100468395, 2283.600369935263, 2310.9884450577724, 2314.0, 2301.344116926676, 2302.3093072078477, 2308.665243539686, 2321.593721098801, 2332.4518738096535, 2323.186884590397, 2323.268170526279, 2336.894839732216, 2345.108858633708, 2346.2961111666605, 8228.876566851503, 8260.83478330436, 8328.08391076981, 8338.62476188573, 8349.499030058216, 4909.189983652693, 5004.524570165829, 5013.824516141954, 5014.52362025607, 5035.169197082477, 3294.407006738786, 3295.2750394913082, 3391.9152021199666, 3402.4556071028514, 3436.1237884339585, 1131.3268605179906, 1134.1267224237374, 1135.9889698168636, 1163.97090072748, 1184.7275126720817, 11510.712232194262, 11538.884611153864, 11572.826407603809, 11575.710607234802, 11604.76790464186, 4204.1171354016, 4305.289627211475, 4314.374415709704, 4362.214801335726, 4377.124575084996, 9583.329166958385, 9595.088466595662, 9611.423314601147, 9625.807483850283, 9627.470489123025, 5030.874228144253, 5058.241263810458, 5080.517350851663, 5088.211327244283, 5091.821786237464, 4219.261629214875, 4525.185466615975, 4605.194091034123, 4626.768661566908, 4652.209124448852, 3814.2562200371217, 3869.380899056194, 3911.902202444962, 3928.744631598937, 4065.1463192729857, 1210.6549633354452, 1214.5931113077042, 1214.908881833866, 1224.4245204753752, 1244.6328333141746, 1039.2828948025838, 1051.447989805343, 1054.678323111443, 1056.413690401819, 1069.0699091790193, 5619.016672082451, 5660.377358490563, 5688.317401911714, 5710.971445142831, 5794.594378393472, 413.2705774308348, 417.2926888923246, 435.2557127312268, 452.1680108600126, 459.0909998203576, 4032.1330913853662, 4067.2678917795083, 4114.0, 4142.5857414258935, 4171.478565179353, 10054.69835904924, 10256.333338332985, 10261.640842570474, 10280.948595256976, 10324.43215623148, 10068.647597334058, 10121.24090693201, 10143.898561014443, 10150.44172570501, 10242.641507547349, 7794.610269486503, 7851.842963140705, 7864.252895974759, 7912.881306780403, 7927.048754149539, 5498.422665620053, 5546.140348246028, 5592.916106258328, 5678.7728490861555, 5795.217645617788, 9053.728388148365, 9132.680356187502, 9133.269338452776, 9136.49749263797, 9175.77060573491, 8885.111488851064, 9041.05068967749, 9145.908540914772, 9248.537573121452, 9315.068493150631, 6533.640649764308, 7037.401820845285, 7087.893681594884, 7213.2065472799, 7232.349088582053, 7719.92280077192, 7729.536227826348, 7741.45809793309, 7742.109657389472, 7824.21757824213, 6978.860422791414, 7151.141862976476, 7157.248488908798, 7208.243134470805, 7216.061911951413, 6990.231074581894, 7068.045813815274, 7084.716611335489, 7125.35871771543, 7146.821329466805, 6233.065040244, 6361.713722882574, 6373.330800265905, 6390.7443702251385, 6412.61524308543, 4968.726720030433, 4993.126202914548, 4996.15065438869, 5003.324551185543, 5018.297438358706, 4789.616830653609, 4796.448408432935, 4810.39870016248, 4855.975720121518, 4922.655414120977], "value": 4351.589913266623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.56775920266836, 335.29755162933657, 339.39587534189144, 340.92329225924186, 341.29863131265256, 6422.775202867901, 6553.8033858984245, 6587.143671322728, 6598.10925525054, 6619.139511863451, 6450.225972883249, 6467.126937863399, 6470.773522926698, 6485.286618471964, 6494.935050649492, 4674.859754207379, 4734.502877197879, 4837.0325934813, 4843.055604157191, 4887.120318342697, 4830.661853670244, 4863.954249836284, 4871.391076115486, 4889.291052797343, 4897.2898929655175, 4830.97584512077, 4831.106245344605, 4831.130396528623, 4834.0, 4834.734089625087, 4813.903721925577, 4832.782524786376, 4836.685615434985, 4844.273358996179, 4848.248521479177, 4222.788860556991, 4223.113146239293, 4226.957730422687, 4230.238557059728, 4233.708718840783, 5940.435658612425, 6142.570020098595, 6161.168242287279, 6172.105044768528, 6178.505719542471, 5489.149181876815, 5502.0921547944545, 5534.806281780158, 5542.11326187812, 5542.75057622408, 6758.324167583251, 6785.185777706657, 6804.795856124324, 6806.047153398528, 6816.48876334272, 4523.163214805271, 4531.229690952546, 4531.637469002472, 4544.795484203219, 4549.0, 7039.436845052383, 7090.71637134514, 7119.644017799141, 7129.3583577478275, 7139.571625702474, 4460.130274596488, 4579.931301030487, 4604.102200070954, 4620.514845941195, 4641.419822522184, 4662.044280922402, 4680.555347242007, 4687.71873687573, 4706.647001474903, 4709.434867815884, 5522.723863806874, 5534.7786088556, 5540.501354878, 5550.417206193372, 5554.222408862763, 6797.66011699423, 6812.250652428229, 6858.485613579001, 6860.3139686032, 6871.14110736158, 1615.3700056977789, 1616.8787340949475, 1618.668173024527, 1628.8452597003266, 1631.111044480761, 1030.4744580264119, 1044.5038606661926, 1054.0, 1056.9735756606146, 1072.522727386321, 6651.966740166268, 6655.500837437212, 6680.632565208863, 6681.064650948871, 6694.799156025327, 6827.6244806536115, 7078.433725301964, 7092.148942126978, 7103.573785572882, 7108.71565137399, 6542.411182993554, 6700.966495167493, 6756.729730810811, 6764.222114456802, 6767.187937447439, 3831.214601006787, 3856.4986551748093, 3857.9421308680394, 3875.7210120660116, 3882.1265215326325, 7408.370288525428, 7517.17311095779, 7546.735864244725, 7547.132079810892, 7558.508696934681, 7029.89455158173, 7209.0, 7279.0, 7293.452991025588, 7302.123745150509, 7513.060867391576, 7517.308605563814, 7520.473566850377, 7523.3229009389415, 7546.169921308651, 7162.391196748126, 7174.784756457315, 7175.0, 7177.677004534913, 7183.676734547063, 7073.681684324115, 7077.044598979278, 7093.716251349888, 7125.5368401053765, 7134.750283740252, 7242.348188663045, 7426.517276377018, 7523.8495230093995, 7559.659815308214, 7559.848803024019, 4617.215073437591, 4637.25803871379, 4659.976700116477, 4665.533446655308, 4672.018876036071, 7083.397911177608, 7105.111861017373, 7131.037309963089, 7134.500584959211, 7148.392386647193, 6920.377166055079, 6923.2038315594355, 6931.029655848084, 6931.133608298963, 6931.896021559782, 6636.83407914806, 6825.044493770777, 6904.0, 6907.758228461979, 6926.134233220848, 6750.763723269662, 6770.93229067703, 6790.830229244309, 6791.524593278423, 6823.55646882951, 6929.861402772017, 6932.410745086724, 6960.37356637905, 6961.7215311389, 6989.0564773754895, 6714.328567143247, 6760.526763126534, 6782.355676210752, 6790.524663273523, 6790.830229244309], "value": 5111.046338685436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.8720117580011, 766.8657984852656, 799.0611032037355, 840.8984230657838, 882.5146169606714, 14606.488772892952, 14734.410623575044, 14762.040467369614, 14868.182249976233, 14936.551903442887, 12954.48182072716, 12978.805317920214, 13077.149985250975, 13103.54137605184, 13119.409626566827, 877.398981697536, 890.3278025091047, 907.3467103685336, 910.640297082652, 916.8441364967971, 905.0451773379083, 910.1080940678139, 913.488446469979, 914.0174312613933, 916.5005072235648, 921.0881227584676, 928.0487500312166, 928.2944961828991, 928.3501548915785, 928.3640706116332, 923.7505873414208, 925.5141050948239, 925.5649844573006, 926.0230456868002, 926.0831776541243, 672.0758956434902, 674.1674032569821, 674.2381109346456, 676.5061505101254, 679.7077256779583, 15644.608884777857, 15647.687046259125, 15669.764953525706, 15692.979956302917, 15733.68532629341, 14206.0, 14302.213378264192, 14499.275036248146, 14543.418263269457, 14620.853791462056, 11969.94015029928, 12153.574624888086, 12199.695007624792, 12221.511139554406, 12416.130870839044, 3969.3053715599945, 4005.239004589148, 4016.8995775105564, 4028.174224284044, 4051.4125451809323, 61440.692796536176, 61839.38160618426, 62016.0, 62222.44443888894, 63010.0, 11036.282641628268, 11051.944740276247, 11176.217664763388, 11233.66299011031, 11439.656810295704, 20442.0, 20543.0, 20586.176552937715, 20623.071961761456, 20623.381298561068, 8674.956625216833, 8821.0, 8881.319361895565, 8888.244499217639, 8987.370884038055, 4899.436564795023, 4907.435644900811, 4934.235193545006, 4956.157453232959, 5045.672031318026, 3647.8176091195332, 3725.0, 3732.664060234592, 3736.1033351995325, 3754.9061273467837, 598.2671227746064, 607.3653032580963, 613.487737738984, 614.4807637546267, 617.6818938246806, 764.4725139653622, 793.4723408933111, 800.7837883771349, 822.5887056471764, 833.295864994079, 9386.15524602789, 9477.857832132524, 9627.277954153467, 9670.626564424401, 9756.560954757053, 648.844277373427, 650.4731167754135, 730.2952650692108, 731.2175971710219, 751.2600088912417, 4290.785460726951, 4361.781910904442, 4434.201843668106, 4439.64482841372, 4474.105178964221, 68079.65960170167, 68739.31260687429, 68923.65538172377, 68956.31043689599, 69073.0, 61458.0, 61693.691531542056, 62043.0, 62386.0, 62518.374816252166, 54675.0, 55046.0, 55140.44859551433, 55289.1706624401, 55984.440155598735, 8482.0, 8717.215450609221, 8741.606627701642, 9006.099390060941, 9012.684556040507, 36855.44716829303, 38080.23839523138, 38469.6153038466, 38577.80711096426, 39501.80249098851, 48125.75937120432, 50287.74856125842, 52188.0, 52278.215826761865, 53321.46678533165, 10917.0, 10998.835017474905, 11055.668329950115, 11271.49278282463, 11464.082873370277, 11963.521459141537, 12399.442025108712, 12414.503419863104, 12512.37438128108, 12541.0, 12438.564650237198, 12554.686132846751, 12615.053870959531, 12840.03699722506, 13102.541411050568, 11821.940890295493, 12070.456829442872, 12128.0, 12309.93845030769, 12424.06819488524, 12559.99520038413, 12672.746545068863, 12714.427850746553, 12803.231806091664, 13174.143680660727, 10213.540390682288, 10276.845847312146, 10424.426656533964, 10512.369257844553, 10519.842202367123, 10254.487275636038, 10529.736756581147, 10616.1507079435, 10682.57269709203, 10699.411532365795], "value": 7048.068987581316, "unit": "score"}], "name": "dromaeo_css", "value": 7302.510963256806, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 105.0, 110.0, 113.0, 110.0, 100.0, 111.0, 110.0, 111.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 154.0, 190.0, 131.0, 154.0, 159.0, 134.0, 197.0, 141.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 165.0, 163.0, 164.0, 162.0, 162.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 167.0, 76.0, 76.0, 76.0, 77.0, 173.0, 78.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 152.0, 92.0, 92.0, 91.0, 139.0, 91.0, 91.0, 146.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 54.0, 56.0, 55.0, 55.0, 58.0, 73.0, 54.0, 54.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 74.0, 74.0, 81.0, 75.0, 74.0, 78.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 120.0, 124.0, 113.0, 115.0, 127.0, 115.0, 135.0, 130.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 161.0, 160.0, 161.0, 161.0, 157.0, 159.0, 160.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 69.0, 70.0, 67.0, 73.0, 68.0, 66.0, 66.0, 65.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1528.0999999999997, "alertThreshold": 2.0}]} 21:55:00 INFO - Return code: 0 21:55:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:55:00 ERROR - # TBPL SUCCESS # 21:55:00 INFO - Running post-action listener: _resource_record_post_action 21:55:00 INFO - Running post-run listener: _resource_record_post_run 21:55:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504578048; Read time: 20; Write time: 560488 21:55:01 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 215273472; Read time: 0; Write time: 340724 21:55:01 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248737792; Read time: 20; Write time: 208068 21:55:01 INFO - Running post-run listener: _upload_blobber_files 21:55:01 INFO - Blob upload gear active. 21:55:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:01 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 21:55:01 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'] 21:55:01 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 21:55:01 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:55:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:02 INFO - (blobuploader) - INFO - Done attempting. 21:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:03 INFO - (blobuploader) - INFO - Done attempting. 21:55:03 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:03 INFO - Return code: 0 21:55:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/726380aacd54b139ffbddbae048b570b0af2b049ea70fb161deb58d968bbb0208af1c2d23ae429e379c1dd36f8d424fd47258d00fc85dc9c399cf9ede09e846c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d30b4a7cf0cddbaf8153021859031d0dc10c1b63319ffa1cdd73b078a7504daddfe3e83359b9d3fba6fb1e6dab7bd26b087c72084f6839fbe3ae3dfb0c835c"} 21:55:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:03 INFO - Contents: 21:55:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/726380aacd54b139ffbddbae048b570b0af2b049ea70fb161deb58d968bbb0208af1c2d23ae429e379c1dd36f8d424fd47258d00fc85dc9c399cf9ede09e846c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d30b4a7cf0cddbaf8153021859031d0dc10c1b63319ffa1cdd73b078a7504daddfe3e83359b9d3fba6fb1e6dab7bd26b087c72084f6839fbe3ae3dfb0c835c"} 21:55:03 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:03 INFO - Copying logs to upload dir... 21:55:03 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.234125 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-17 21:55:02.943507) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 21:55:02.946968) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645 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/726380aacd54b139ffbddbae048b570b0af2b049ea70fb161deb58d968bbb0208af1c2d23ae429e379c1dd36f8d424fd47258d00fc85dc9c399cf9ede09e846c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d30b4a7cf0cddbaf8153021859031d0dc10c1b63319ffa1cdd73b078a7504daddfe3e83359b9d3fba6fb1e6dab7bd26b087c72084f6839fbe3ae3dfb0c835c"} build_url:https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.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/726380aacd54b139ffbddbae048b570b0af2b049ea70fb161deb58d968bbb0208af1c2d23ae429e379c1dd36f8d424fd47258d00fc85dc9c399cf9ede09e846c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d30b4a7cf0cddbaf8153021859031d0dc10c1b63319ffa1cdd73b078a7504daddfe3e83359b9d3fba6fb1e6dab7bd26b087c72084f6839fbe3ae3dfb0c835c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 21:55:02.972276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:55:02.972669) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463545445.310706-528998645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004366 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:55:03.057789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 21:55:03.058402) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 21:55:03.058987) ========= ========= Total master_lag: 0.17 =========