builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1462473426.58 results: success (0) buildid: 20160505085246 builduid: 441f70eebd0542f4b1254629e64ab8dc revision: 45197bd1bd11fccc5da8efc98629a64b664a387d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.584854) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.585343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.585632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.633635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.634023) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 11:37:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-05 11:37:06 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.775650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.775972) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015352 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:06.845498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 11:37:06.845846) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 45197bd1bd11fccc5da8efc98629a64b664a387d --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 45197bd1bd11fccc5da8efc98629a64b664a387d --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=934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 11:37:07,029 truncating revision to first 12 chars 2016-05-05 11:37:07,029 Setting DEBUG logging. 2016-05-05 11:37:07,029 attempt 1/10 2016-05-05 11:37:07,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/45197bd1bd11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 11:37:08,381 unpacking tar archive at: mozilla-aurora-45197bd1bd11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.668946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 11:37:08.531872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:08.532194) ========= script_repo_revision: 45197bd1bd11fccc5da8efc98629a64b664a387d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:08.532586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:08.532851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 11:37:08.547389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-05 11:37:08.547670) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:37:08 INFO - MultiFileLogger online at 20160505 11:37:08 in /builds/slave/test 11:37:08 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 11:37:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:08 INFO - {'append_to_log': False, 11:37:08 INFO - 'base_work_dir': '/builds/slave/test', 11:37:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:37:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:08 INFO - 'branch': 'Mozilla-Aurora', 11:37:08 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:08 INFO - 'config_files': ('talos/linux_config.py',), 11:37:08 INFO - 'default_actions': ('clobber', 11:37:08 INFO - 'read-buildbot-config', 11:37:08 INFO - 'download-and-extract', 11:37:08 INFO - 'populate-webroot', 11:37:08 INFO - 'create-virtualenv', 11:37:08 INFO - 'install', 11:37:08 INFO - 'run-tests'), 11:37:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:08 INFO - 'download_minidump_stackwalk': True, 11:37:08 INFO - 'download_symbols': 'ondemand', 11:37:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:08 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:08 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:08 INFO - 'installer_path': 'installer.exe', 11:37:08 INFO - 'log_level': 'info', 11:37:08 INFO - 'log_name': 'talos', 11:37:08 INFO - 'log_to_console': True, 11:37:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:37:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:37:08 INFO - 'opt_config_files': (), 11:37:08 INFO - 'pip_index': False, 11:37:08 INFO - 'sps_profile': False, 11:37:08 INFO - 'sps_profile_interval': 0, 11:37:08 INFO - 'suite': 'dromaeojs-e10s', 11:37:08 INFO - 'system_bits': '32', 11:37:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:08 INFO - 'title': 'talos-linux64-ix-057', 11:37:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:08 INFO - 'use_talos_json': True, 11:37:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:08 INFO - 'work_dir': 'build'} 11:37:08 INFO - ##### 11:37:08 INFO - ##### Running clobber step. 11:37:08 INFO - ##### 11:37:08 INFO - Running pre-action listener: _resource_record_pre_action 11:37:08 INFO - Running main action method: clobber 11:37:08 INFO - rmtree: /builds/slave/test/build 11:37:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:09 INFO - Running post-action listener: _resource_record_post_action 11:37:09 INFO - ##### 11:37:09 INFO - ##### Running read-buildbot-config step. 11:37:09 INFO - ##### 11:37:09 INFO - Running pre-action listener: _resource_record_pre_action 11:37:09 INFO - Running main action method: read_buildbot_config 11:37:09 INFO - Using buildbot properties: 11:37:09 INFO - { 11:37:09 INFO - "project": "", 11:37:09 INFO - "product": "firefox", 11:37:09 INFO - "script_repo_revision": "production", 11:37:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:37:09 INFO - "repository": "", 11:37:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:37:09 INFO - "buildid": "20160505085246", 11:37:09 INFO - "pgo_build": "True", 11:37:09 INFO - "basedir": "/builds/slave/test", 11:37:09 INFO - "buildnumber": 290, 11:37:09 INFO - "slavename": "talos-linux64-ix-057", 11:37:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:37:09 INFO - "platform": "ubuntu64_hw", 11:37:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:37:09 INFO - "branch": "mozilla-aurora", 11:37:09 INFO - "repo_path": "releases/mozilla-aurora", 11:37:09 INFO - "revision": "45197bd1bd11fccc5da8efc98629a64b664a387d", 11:37:09 INFO - "stage_platform": "linux64-pgo", 11:37:09 INFO - "builduid": "441f70eebd0542f4b1254629e64ab8dc", 11:37:09 INFO - "slavebuilddir": "test" 11:37:09 INFO - } 11:37:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 11:37:09 INFO - Running post-action listener: _resource_record_post_action 11:37:09 INFO - ##### 11:37:09 INFO - ##### Running download-and-extract step. 11:37:09 INFO - ##### 11:37:09 INFO - Running pre-action listener: _resource_record_pre_action 11:37:09 INFO - Running main action method: download_and_extract 11:37:09 INFO - mkdir: /builds/slave/test/build/tests 11:37: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')]} 11:37:09 INFO - https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:09 INFO - Downloaded 1361 bytes. 11:37:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:37:09 INFO - Using the following test package requirements: 11:37:09 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:37:09 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:37:09 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:37:09 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'jsshell-linux-x86_64.zip'], 11:37:09 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:37:09 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:37:09 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:37:09 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:37:09 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:37:09 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:37:09 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:37:09 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:37: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')]} 11:37:09 INFO - https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:11 INFO - Downloaded 23824818 bytes. 11:37:11 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'] 11:37:11 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 11:37:12 INFO - Return code: 0 11:37:12 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 11:37:12 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')]} 11:37:12 INFO - https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:37:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:37:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:13 INFO - Downloaded 23824818 bytes. 11:37:13 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'] 11:37:13 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 11:37:15 INFO - Return code: 0 11:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:15 INFO - https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:16 INFO - Downloaded 10840145 bytes. 11:37:16 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'] 11:37:16 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 11:37:16 INFO - Return code: 0 11:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:16 INFO - https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:37:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:37:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:37:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jsng451oSa-fFoPrhY3TZg/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 11:37:17 INFO - Downloaded 62697303 bytes. 11:37:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:37:17 INFO - mkdir: /builds/slave/test/properties 11:37:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:17 INFO - Contents: 11:37:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:37:18 INFO - Running post-action listener: _resource_record_post_action 11:37:18 INFO - Running post-action listener: set_extra_try_arguments 11:37:18 INFO - ##### 11:37:18 INFO - ##### Running populate-webroot step. 11:37:18 INFO - ##### 11:37:18 INFO - Running pre-action listener: _resource_record_pre_action 11:37:18 INFO - Running main action method: populate_webroot 11:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:18 INFO - '--tppagecycles', 11:37:18 INFO - '7'], 11:37:18 INFO - 'tests': ['tsvgm']}}, 11:37:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['damp', 'tps']}, 11:37:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'tests': ['damp', 'tps']}, 11:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['dromaeo_dom']}, 11:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tsvgx', 11:37:18 INFO - 'tsvgr_opacity', 11:37:18 INFO - 'tart', 11:37:18 INFO - 'tscrollx', 11:37:18 INFO - 'cart']}, 11:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:18 INFO - 'tsvgr_opacity', 11:37:18 INFO - 'tart', 11:37:18 INFO - 'tscrollx', 11:37:18 INFO - 'cart']}, 11:37:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tp5o']}, 11:37:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'tests': ['tp5o']}, 11:37:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s', 11:37:18 INFO - '--xperf_path', 11:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:18 INFO - 'tests': ['tp5n']}, 11:37:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--xperf_path', 11:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:18 INFO - 'tests': ['tp5n']}}, 11:37:18 INFO - 'talos.zip': {'path': '', 11:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:18 INFO - Running post-action listener: _resource_record_post_action 11:37:18 INFO - ##### 11:37:18 INFO - ##### Running create-virtualenv step. 11:37:18 INFO - ##### 11:37:18 INFO - Running pre-action listener: _resource_record_pre_action 11:37:18 INFO - Running main action method: create_virtualenv 11:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:18 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 11:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:18 INFO - Using real prefix '/usr' 11:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:20 INFO - Installing pip.................done. 11:37:20 INFO - Return code: 0 11:37:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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')]} 11:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:21 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 11:37:21 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 11:37:21 INFO - Using env: {'DISPLAY': ':0', 11:37:21 INFO - 'HOME': '/home/cltbld', 11:37:21 INFO - 'LANG': 'en_US.UTF-8', 11:37:21 INFO - 'LANGUAGE': 'en_US:en', 11:37:21 INFO - 'LOGNAME': 'cltbld', 11:37:21 INFO - 'MAIL': '/var/mail/cltbld', 11:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:21 INFO - 'MOZ_NO_REMOTE': '1', 11:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:21 INFO - 'NO_EM_RESTART': '1', 11:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:21 INFO - 'PWD': '/builds/slave/test', 11:37:21 INFO - 'SHELL': '/bin/bash', 11:37:21 INFO - 'SHLVL': '1', 11:37:21 INFO - 'TERM': 'linux', 11:37:21 INFO - 'TMOUT': '86400', 11:37:21 INFO - 'USER': 'cltbld', 11:37:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:21 INFO - '_': '/tools/buildbot/bin/python'} 11:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:21 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 11:37:21 INFO - Cleaning up... 11:37:21 INFO - Return code: 0 11:37:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:37:21 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')]} 11:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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')]} 11:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:21 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 11:37:21 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 11:37:21 INFO - Using env: {'DISPLAY': ':0', 11:37:21 INFO - 'HOME': '/home/cltbld', 11:37:21 INFO - 'LANG': 'en_US.UTF-8', 11:37:21 INFO - 'LANGUAGE': 'en_US:en', 11:37:21 INFO - 'LOGNAME': 'cltbld', 11:37:21 INFO - 'MAIL': '/var/mail/cltbld', 11:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:21 INFO - 'MOZ_NO_REMOTE': '1', 11:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:21 INFO - 'NO_EM_RESTART': '1', 11:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:21 INFO - 'PWD': '/builds/slave/test', 11:37:21 INFO - 'SHELL': '/bin/bash', 11:37:21 INFO - 'SHLVL': '1', 11:37:21 INFO - 'TERM': 'linux', 11:37:21 INFO - 'TMOUT': '86400', 11:37:21 INFO - 'USER': 'cltbld', 11:37:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:21 INFO - '_': '/tools/buildbot/bin/python'} 11:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:21 INFO - Downloading/unpacking psutil>=0.7.1 11:37:21 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 11:37:21 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 11:37:21 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 11:37:21 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 11:37:21 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 11:37:21 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 11:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:23 INFO - Installing collected packages: psutil 11:37:23 INFO - Running setup.py install for psutil 11:37:23 INFO - building 'psutil._psutil_linux' extension 11:37:23 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 11:37:23 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 11:37:23 INFO - building 'psutil._psutil_posix' extension 11:37:23 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 11:37:23 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 11:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:23 INFO - Successfully installed psutil 11:37:23 INFO - Cleaning up... 11:37:23 INFO - Return code: 0 11:37:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:23 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:23 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 11:37:23 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 11:37:23 INFO - Using env: {'DISPLAY': ':0', 11:37:23 INFO - 'HOME': '/home/cltbld', 11:37:23 INFO - 'LANG': 'en_US.UTF-8', 11:37:23 INFO - 'LANGUAGE': 'en_US:en', 11:37:23 INFO - 'LOGNAME': 'cltbld', 11:37:23 INFO - 'MAIL': '/var/mail/cltbld', 11:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:23 INFO - 'MOZ_NO_REMOTE': '1', 11:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:23 INFO - 'NO_EM_RESTART': '1', 11:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:23 INFO - 'PWD': '/builds/slave/test', 11:37:23 INFO - 'SHELL': '/bin/bash', 11:37:23 INFO - 'SHLVL': '1', 11:37:23 INFO - 'TERM': 'linux', 11:37:23 INFO - 'TMOUT': '86400', 11:37:23 INFO - 'USER': 'cltbld', 11:37:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:23 INFO - '_': '/tools/buildbot/bin/python'} 11:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:37:26 INFO - Installing collected packages: mozsystemmonitor 11:37:26 INFO - Running setup.py install for mozsystemmonitor 11:37:26 INFO - Successfully installed mozsystemmonitor 11:37:26 INFO - Cleaning up... 11:37:26 INFO - Return code: 0 11:37:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:26 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 11:37:26 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 11:37:26 INFO - Using env: {'DISPLAY': ':0', 11:37:26 INFO - 'HOME': '/home/cltbld', 11:37:26 INFO - 'LANG': 'en_US.UTF-8', 11:37:26 INFO - 'LANGUAGE': 'en_US:en', 11:37:26 INFO - 'LOGNAME': 'cltbld', 11:37:26 INFO - 'MAIL': '/var/mail/cltbld', 11:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:26 INFO - 'MOZ_NO_REMOTE': '1', 11:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:26 INFO - 'NO_EM_RESTART': '1', 11:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:26 INFO - 'PWD': '/builds/slave/test', 11:37:26 INFO - 'SHELL': '/bin/bash', 11:37:26 INFO - 'SHLVL': '1', 11:37:26 INFO - 'TERM': 'linux', 11:37:26 INFO - 'TMOUT': '86400', 11:37:26 INFO - 'USER': 'cltbld', 11:37:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:26 INFO - '_': '/tools/buildbot/bin/python'} 11:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:26 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:26 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 11:37:26 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 11:37:26 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 11:37:26 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 11:37:26 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 11:37:26 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 11:37:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:29 INFO - Downloading docopt-0.6.1.tar.gz 11:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:29 INFO - Running setup.py install for blobuploader 11:37:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:29 INFO - Running setup.py install for requests 11:37:29 INFO - Running setup.py install for docopt 11:37:29 INFO - Successfully installed blobuploader requests docopt 11:37:29 INFO - Cleaning up... 11:37:29 INFO - Return code: 0 11:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:29 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:29 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 11:37:29 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 11:37:29 INFO - Using env: {'DISPLAY': ':0', 11:37:29 INFO - 'HOME': '/home/cltbld', 11:37:29 INFO - 'LANG': 'en_US.UTF-8', 11:37:29 INFO - 'LANGUAGE': 'en_US:en', 11:37:29 INFO - 'LOGNAME': 'cltbld', 11:37:29 INFO - 'MAIL': '/var/mail/cltbld', 11:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:29 INFO - 'MOZ_NO_REMOTE': '1', 11:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:29 INFO - 'NO_EM_RESTART': '1', 11:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:29 INFO - 'PWD': '/builds/slave/test', 11:37:29 INFO - 'SHELL': '/bin/bash', 11:37:29 INFO - 'SHLVL': '1', 11:37:29 INFO - 'TERM': 'linux', 11:37:29 INFO - 'TMOUT': '86400', 11:37:29 INFO - 'USER': 'cltbld', 11:37:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:29 INFO - '_': '/tools/buildbot/bin/python'} 11:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:29 INFO - Running setup.py (path:/tmp/pip-XFSO6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:30 INFO - Running setup.py (path:/tmp/pip-w84e3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:30 INFO - Running setup.py (path:/tmp/pip-TqSMtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:30 INFO - Running setup.py (path:/tmp/pip-GQJZGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:30 INFO - Running setup.py (path:/tmp/pip-oRA5jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:30 INFO - Running setup.py (path:/tmp/pip-efTLm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:30 INFO - Running setup.py (path:/tmp/pip-KQ4NK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:30 INFO - Running setup.py (path:/tmp/pip-7y6Tg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:30 INFO - Running setup.py (path:/tmp/pip-WjHqgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:30 INFO - Running setup.py (path:/tmp/pip-HtqUWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:30 INFO - Running setup.py (path:/tmp/pip-10dCGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:30 INFO - Running setup.py (path:/tmp/pip-BTBPwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:30 INFO - Running setup.py (path:/tmp/pip-1VBZ5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:30 INFO - Running setup.py (path:/tmp/pip-_DKoIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:30 INFO - Running setup.py (path:/tmp/pip-P567Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:31 INFO - Running setup.py (path:/tmp/pip-Fi72dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:31 INFO - Running setup.py (path:/tmp/pip-y5rnVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:31 INFO - Running setup.py install for manifestparser 11:37:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Running setup.py install for mozcrash 11:37:31 INFO - Running setup.py install for mozdebug 11:37:31 INFO - Running setup.py install for mozdevice 11:37:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Running setup.py install for mozfile 11:37:31 INFO - Running setup.py install for mozhttpd 11:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Running setup.py install for mozinfo 11:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Running setup.py install for mozInstall 11:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Running setup.py install for mozleak 11:37:32 INFO - Running setup.py install for mozlog 11:37:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for moznetwork 11:37:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozprocess 11:37:32 INFO - Running setup.py install for mozprofile 11:37:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozrunner 11:37:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozscreenshot 11:37:32 INFO - Running setup.py install for moztest 11:37:32 INFO - Running setup.py install for mozversion 11:37:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:32 INFO - Cleaning up... 11:37:32 INFO - Return code: 0 11:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:32 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:32 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 11:37:32 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 11:37:32 INFO - Using env: {'DISPLAY': ':0', 11:37:32 INFO - 'HOME': '/home/cltbld', 11:37:32 INFO - 'LANG': 'en_US.UTF-8', 11:37:32 INFO - 'LANGUAGE': 'en_US:en', 11:37:32 INFO - 'LOGNAME': 'cltbld', 11:37:32 INFO - 'MAIL': '/var/mail/cltbld', 11:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:32 INFO - 'MOZ_NO_REMOTE': '1', 11:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:32 INFO - 'NO_EM_RESTART': '1', 11:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:32 INFO - 'PWD': '/builds/slave/test', 11:37:32 INFO - 'SHELL': '/bin/bash', 11:37:32 INFO - 'SHLVL': '1', 11:37:32 INFO - 'TERM': 'linux', 11:37:32 INFO - 'TMOUT': '86400', 11:37:32 INFO - 'USER': 'cltbld', 11:37:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:32 INFO - '_': '/tools/buildbot/bin/python'} 11:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:33 INFO - Running setup.py (path:/tmp/pip-koc10A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:33 INFO - Running setup.py (path:/tmp/pip-kU_UtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:33 INFO - Running setup.py (path:/tmp/pip-kwDlEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:33 INFO - Running setup.py (path:/tmp/pip-JGidXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:33 INFO - Running setup.py (path:/tmp/pip-69afn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:33 INFO - Running setup.py (path:/tmp/pip-kfUQJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:33 INFO - Running setup.py (path:/tmp/pip-ZYuz6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:33 INFO - Running setup.py (path:/tmp/pip-GJ0dRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:33 INFO - Running setup.py (path:/tmp/pip-i3k2zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:33 INFO - Running setup.py (path:/tmp/pip-AIYHu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:33 INFO - Running setup.py (path:/tmp/pip-EZmtFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:33 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:34 INFO - Running setup.py (path:/tmp/pip-JjmdVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:34 INFO - Running setup.py (path:/tmp/pip-qPbJaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:34 INFO - Running setup.py (path:/tmp/pip-Oa8gCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:34 INFO - Running setup.py (path:/tmp/pip-mUxJtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:34 INFO - Running setup.py (path:/tmp/pip-OBpFEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:34 INFO - Running setup.py (path:/tmp/pip-xv7l8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:34 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 11:37:34 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 11:37:34 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 11:37:34 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 11:37:34 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 11:37:34 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 11:37:36 INFO - Downloading blessings-1.6.tar.gz 11:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:36 INFO - Installing collected packages: blessings 11:37:36 INFO - Running setup.py install for blessings 11:37:36 INFO - Successfully installed blessings 11:37:36 INFO - Cleaning up... 11:37:36 INFO - Return code: 0 11:37:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:36 INFO - Reading from file tmpfile_stdout 11:37:36 INFO - Current package versions: 11:37:36 INFO - argparse == 1.2.1 11:37:36 INFO - blessings == 1.6 11:37:36 INFO - blobuploader == 1.2.4 11:37:36 INFO - docopt == 0.6.1 11:37:36 INFO - manifestparser == 1.1 11:37:36 INFO - mozInstall == 1.12 11:37:36 INFO - mozcrash == 0.17 11:37:36 INFO - mozdebug == 0.1 11:37:36 INFO - mozdevice == 0.48 11:37:36 INFO - mozfile == 1.2 11:37:36 INFO - mozhttpd == 0.7 11:37:36 INFO - mozinfo == 0.9 11:37:36 INFO - mozleak == 0.1 11:37:36 INFO - mozlog == 3.1 11:37:36 INFO - moznetwork == 0.27 11:37:36 INFO - mozprocess == 0.22 11:37:36 INFO - mozprofile == 0.28 11:37:36 INFO - mozrunner == 6.11 11:37:36 INFO - mozscreenshot == 0.1 11:37:36 INFO - mozsystemmonitor == 0.0 11:37:36 INFO - moztest == 0.7 11:37:36 INFO - mozversion == 1.4 11:37:36 INFO - psutil == 3.1.1 11:37:36 INFO - requests == 1.2.3 11:37:36 INFO - wsgiref == 0.1.2 11:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:36 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 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:36 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 11:37:36 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 11:37:36 INFO - Using env: {'DISPLAY': ':0', 11:37:36 INFO - 'HOME': '/home/cltbld', 11:37:36 INFO - 'LANG': 'en_US.UTF-8', 11:37:36 INFO - 'LANGUAGE': 'en_US:en', 11:37:36 INFO - 'LOGNAME': 'cltbld', 11:37:36 INFO - 'MAIL': '/var/mail/cltbld', 11:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:36 INFO - 'MOZ_NO_REMOTE': '1', 11:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:36 INFO - 'NO_EM_RESTART': '1', 11:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:36 INFO - 'PWD': '/builds/slave/test', 11:37:36 INFO - 'SHELL': '/bin/bash', 11:37:36 INFO - 'SHLVL': '1', 11:37:36 INFO - 'TERM': 'linux', 11:37:36 INFO - 'TMOUT': '86400', 11:37:36 INFO - 'USER': 'cltbld', 11:37:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:36 INFO - '_': '/tools/buildbot/bin/python'} 11:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 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)) 11:37:36 INFO - Cleaning up... 11:37:37 INFO - Return code: 0 11:37:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:37:37 INFO - Using env: {'DISPLAY': ':0', 11:37:37 INFO - 'HOME': '/home/cltbld', 11:37:37 INFO - 'LANG': 'en_US.UTF-8', 11:37:37 INFO - 'LANGUAGE': 'en_US:en', 11:37:37 INFO - 'LOGNAME': 'cltbld', 11:37:37 INFO - 'MAIL': '/var/mail/cltbld', 11:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:37 INFO - 'MOZ_NO_REMOTE': '1', 11:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:37 INFO - 'NO_EM_RESTART': '1', 11:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:37 INFO - 'PWD': '/builds/slave/test', 11:37:37 INFO - 'SHELL': '/bin/bash', 11:37:37 INFO - 'SHLVL': '1', 11:37:37 INFO - 'TERM': 'linux', 11:37:37 INFO - 'TMOUT': '86400', 11:37:37 INFO - 'USER': 'cltbld', 11:37:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:37 INFO - '_': '/tools/buildbot/bin/python'} 11:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:37 INFO - Downloading/unpacking jsonschema 11:37:37 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 11:37:37 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 11:37:37 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 11:37:37 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 11:37:37 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 11:37:37 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 11:37:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:39 INFO - Downloading/unpacking functools32 (from jsonschema) 11:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:39 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:39 INFO - warning: no files found matching '*.txt' 11:37:39 INFO - no previously-included directories found matching 'build' 11:37:39 INFO - no previously-included directories found matching 'dist' 11:37:39 INFO - no previously-included directories found matching '.git*' 11:37:39 INFO - Installing collected packages: jsonschema, functools32 11:37:39 INFO - Running setup.py install for functools32 11:37:39 INFO - warning: no files found matching '*.txt' 11:37:39 INFO - no previously-included directories found matching 'build' 11:37:39 INFO - no previously-included directories found matching 'dist' 11:37:39 INFO - no previously-included directories found matching '.git*' 11:37:39 INFO - Successfully installed jsonschema functools32 11:37:39 INFO - Cleaning up... 11:37:39 INFO - Return code: 0 11:37:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4e6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', '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 11:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:37:39 INFO - Using env: {'DISPLAY': ':0', 11:37:39 INFO - 'HOME': '/home/cltbld', 11:37:39 INFO - 'LANG': 'en_US.UTF-8', 11:37:39 INFO - 'LANGUAGE': 'en_US:en', 11:37:39 INFO - 'LOGNAME': 'cltbld', 11:37:39 INFO - 'MAIL': '/var/mail/cltbld', 11:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:39 INFO - 'MOZ_NO_REMOTE': '1', 11:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:39 INFO - 'NO_EM_RESTART': '1', 11:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:39 INFO - 'PWD': '/builds/slave/test', 11:37:39 INFO - 'SHELL': '/bin/bash', 11:37:39 INFO - 'SHLVL': '1', 11:37:39 INFO - 'TERM': 'linux', 11:37:39 INFO - 'TMOUT': '86400', 11:37:39 INFO - 'USER': 'cltbld', 11:37:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:39 INFO - '_': '/tools/buildbot/bin/python'} 11:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:39 INFO - Downloading/unpacking flake8 11:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:37:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:37:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:37:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:37:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:37:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:37:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:37:42 INFO - no previously-included directories found matching 'docs/_build' 11:37:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:37:42 INFO - Running setup.py install for pep8 11:37:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:37:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:37:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:37:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:37:42 INFO - no previously-included directories found matching 'docs/_build' 11:37:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:37:42 INFO - Cleaning up... 11:37:42 INFO - Return code: 0 11:37:42 INFO - Running post-action listener: _resource_record_post_action 11:37:42 INFO - Running post-action listener: _start_resource_monitoring 11:37:42 INFO - Starting resource monitoring. 11:37:42 INFO - ##### 11:37:42 INFO - ##### Running install step. 11:37:42 INFO - ##### 11:37:42 INFO - Running pre-action listener: _resource_record_pre_action 11:37:42 INFO - Running main action method: install 11:37:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:42 INFO - Reading from file tmpfile_stdout 11:37:42 INFO - Detecting whether we're running mozinstall >=1.0... 11:37:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:37:42 INFO - Reading from file tmpfile_stdout 11:37:42 INFO - Output received: 11:37:42 INFO - Usage: mozinstall [options] installer 11:37:42 INFO - Options: 11:37:42 INFO - -h, --help show this help message and exit 11:37:42 INFO - -d DEST, --destination=DEST 11:37:42 INFO - Directory to install application into. [default: 11:37:42 INFO - "/builds/slave/test"] 11:37:42 INFO - --app=APP Application being installed. [default: firefox] 11:37:42 INFO - mkdir: /builds/slave/test/build/application 11:37:42 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'] 11:37:42 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 11:37:58 INFO - Reading from file tmpfile_stdout 11:37:58 INFO - Output received: 11:37:58 INFO - /builds/slave/test/build/application/firefox/firefox 11:37:58 INFO - Running post-action listener: _resource_record_post_action 11:37:58 INFO - ##### 11:37:58 INFO - ##### Running run-tests step. 11:37:58 INFO - ##### 11:37:58 INFO - Running pre-action listener: _resource_record_pre_action 11:37:58 INFO - Running main action method: run_tests 11:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:37:58 INFO - Python 2.7.3 11:37:58 INFO - Return code: 0 11:37:58 INFO - grabbing minidump binary from tooltool 11:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:58 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 0x2998410>, '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 0x2999310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29997a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:37:58 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 11:37:58 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 11:37:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:58 INFO - Return code: 0 11:37:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:37:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:37:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:37:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:37:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:37:59 INFO - Return code: 0 11:37:59 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/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 11:37:59 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/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 11:37:59 INFO - Using env: {'DISPLAY': ':0', 11:37:59 INFO - 'HOME': '/home/cltbld', 11:37:59 INFO - 'LANG': 'en_US.UTF-8', 11:37:59 INFO - 'LANGUAGE': 'en_US:en', 11:37:59 INFO - 'LOGNAME': 'cltbld', 11:37:59 INFO - 'MAIL': '/var/mail/cltbld', 11:37:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:37:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:59 INFO - 'MOZ_NO_REMOTE': '1', 11:37:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:59 INFO - 'NO_EM_RESTART': '1', 11:37:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:59 INFO - 'PWD': '/builds/slave/test', 11:37:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:37:59 INFO - 'SHELL': '/bin/bash', 11:37:59 INFO - 'SHLVL': '1', 11:37:59 INFO - 'TERM': 'linux', 11:37:59 INFO - 'TMOUT': '86400', 11:37:59 INFO - 'USER': 'cltbld', 11:37:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381', 11:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:59 INFO - '_': '/tools/buildbot/bin/python'} 11:37:59 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/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 11:37:59 INFO - mozversion application_buildid: 20160505085246 11:37:59 INFO - mozversion application_changeset: 45197bd1bd11fccc5da8efc98629a64b664a387d 11:37:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:37:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:59 INFO - mozversion application_name: Firefox 11:37:59 INFO - mozversion application_remotingname: firefox-dev 11:37:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:37:59 INFO - mozversion application_vendor: Mozilla 11:37:59 INFO - mozversion application_version: 48.0a2 11:37:59 INFO - mozversion platform_buildid: 20160505085246 11:37:59 INFO - mozversion platform_changeset: 45197bd1bd11fccc5da8efc98629a64b664a387d 11:37:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:37:59 INFO - mozversion platform_version: 48.0a2 11:37:59 INFO - using testdate: 1462473479 11:37:59 INFO - actual date: 1462473479 11:37:59 INFO - starting webserver on 'localhost:39297' 11:37:59 INFO - SUITE-START | Running 2 tests 11:37:59 INFO - TEST-START | dromaeo_css 11:37:59 INFO - operating with platform_type : linux_ 11:37:59 INFO - Initialising browser for dromaeo_css test... 11:37:59 INFO - TEST-INFO | started process 2694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXd1fgr/profile http://localhost:39297/getInfo.html) 11:38:03 INFO - PROCESS | 2694 | 11:38:03 INFO - PROCESS | 2694 | (process:2849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:04 INFO - PROCESS | 2694 | __metrics Screen width/height:1600/1200 11:38:04 INFO - PROCESS | 2694 | colorDepth:24 11:38:04 INFO - PROCESS | 2694 | Browser inner width/height: 1024/697 11:38:04 INFO - PROCESS | 2694 | __metrics 11:38:05 ERROR - PROCESS | 2694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:38:06 INFO - TEST-INFO | 2694: exit 0 11:38:06 INFO - Browser initialized. 11:38:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:06 INFO - TEST-INFO | started process 2925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXd1fgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:07 INFO - PROCESS | 2925 | 11:38:07 INFO - PROCESS | 2925 | (process:2997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:17 INFO - PROCESS | 2925 | RSS: Main: 152461312 11:38:17 INFO - PROCESS | 2925 | 11:39:07 INFO - PROCESS | 2925 | 1462473547517 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] 11:41:15 INFO - PROCESS | 2925 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39297/tests/dromaeo/cssquery-ext.html) 11:41:16 INFO - PROCESS | 2925 | RSS: Main: 155934720 11:41:16 INFO - PROCESS | 2925 | 11:44:18 INFO - PROCESS | 2925 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-ext.html (next: http://localhost:39297/tests/dromaeo/cssquery-jquery.html) 11:44:18 INFO - PROCESS | 2925 | RSS: Main: 154263552 11:44:18 INFO - PROCESS | 2925 | 11:47:20 INFO - PROCESS | 2925 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39297/tests/dromaeo/cssquery-mootools.html) 11:47:21 INFO - PROCESS | 2925 | RSS: Main: 153821184 11:47:21 INFO - PROCESS | 2925 | 11:50:22 INFO - PROCESS | 2925 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39297/tests/dromaeo/cssquery-prototype.html) 11:50:23 INFO - PROCESS | 2925 | RSS: Main: 153063424 11:50:23 INFO - PROCESS | 2925 | 11:53:25 INFO - PROCESS | 2925 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39297/tests/dromaeo/cssquery-yui.html) 11:53:26 INFO - PROCESS | 2925 | RSS: Main: 154746880 11:53:26 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-yui.html (next: http://localhost:39297/tests/dromaeo/cssquery-dojo.html) 11:56:28 INFO - PROCESS | 2925 | RSS: Main: 155377664 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | __start_tp_report 11:56:28 INFO - PROCESS | 2925 | _x_x_mozilla_page_load 11:56:28 INFO - PROCESS | 2925 | _x_x_mozilla_page_load_details 11:56:28 INFO - PROCESS | 2925 | |i|pagename|runs| 11:56:28 INFO - PROCESS | 2925 | |0;dojo.html;3431.0907609483484;3471.2536804587007;3480.3735327641016;3510;3541.62812904645;5676.631018983773;5706.65760054397;5760.423957604243;5767.394423585526;5768.942310576893;5800.680962547058;5855.268091488564;5856.150858125569;5883.941160588403;5902.645841249528;5279.868003299919;5326.201069839536;5361.624686271943;5365.356157261134;5372.865678358053;5182.792688292464;5211.322528071364;5320.76056577455;5395.082835917903;5402.37872644645;5231.738413079331;5258.184981327881;5278.181881808326;5288.497592728704;5353.3843607985;5257.5531079858065;5280.234366016906;5293;5297.417284098746;5298.258243845865;5119.692818430906;5121.359830021247;5124.231365295235;5215.061288967984;5259.342582177228;5579.69311687857;5581.944180558183;5598.972005139989;5636.71816409182;5672.602917795756;6117.755289788403;6166.599171053867;6172.537059720539;6174.938250617482;6176.505879529672;6054.878902421927;6197.938020619781;6203.472704820096;6218.751249949996;6285.528585356071;5800.071988481823;5809.070548712186;5812.738426770806;5813.534917206655;5820.854478638025;6338.366163383625;6353.078803573456;6355.142055822497;6359.395857393541;6368.331325210786;5990.580659353891;6039.456448919531;6079.544034197364;6127.769884593299;6153.938460615426;6143.631382117087;6143.877122457615;6151.5386346024225;6157.568970172045;6159.414855588801;6086.939170516033;6108.877822443526;6124.418180272867;6125.356837532084;6128.754849805958;5976.820695379146;6165.938340616626;6243.594166379171;6300.779472718433;6308.779192728232;4656.837010704609;4685.508021657745;4686.484486706459;4689.20283551797;4718.834840780556;4084.571120032354;4142.813573389205;4192.413062171298;4201.390798334224;4216.388623649554;5776.104703770922;5803.970980145156;5811.738471768781;5891.852703682443;5952.196453478811;6182.412670796267;6189.226346706661;6200.410960958701;6205.751769929243;6211;5900.76396944126;5902.852428689232;5907;5921.585489015813;5924.081767325985;5021.246812978083;5119.334486516729;5133.153029750124;5150.356205474316;5218.217267409919;6296.181496405529;6310;6372.299047104815;6377.585456945284;6396.040593910858;6103.572749907464;6198.194234749544;6231.813045608639;6238.282597501346;6240.4071613196675;6363.395477429637;6394.968025159845;6395.456386207225;6407.743690252338;6421.678916054085;6021.819345419644;6056.031035034373;6077.893582007715;6132.850133029843;6148.538859585638;6240.219972503437;6243.594166379171;6254.312025677263;6262.373762623702;6272.466840318624;6002.279726432856;6056.666883321283;6072.453479186895;6081.878362432815;6086.087086936818;6062;6065.909011364744;6070.6357618543025;6078.270607527125;6078.635281883101;5846.970765146147;5896.292444906467;5950.523958083257;5978.312494063064;5989.8203053908455;6088.269407671108;6119.868162944292;6133.1510485532735;6178.783742569169;6184.6598437086395;5859.062549991981;5918.496927761188;5919.082542205965;5921.289445266596;5953.464188223081 11:56:28 INFO - PROCESS | 2925 | |1;ext.html;658.5752189837555;672.5998031171455;677.6374639567832;686.8214264291286;782.0146615264772;33086.50370244448;33919;33977.49033764489;34074.8296258519;34081.488777668324;32662.510062349025;33210.169745756306;33438.49842252362;33439.66560334396;33507.664923350756;8619.138086191393;8865.423747456427;8901.554922253894;8905.554722263892;8927.687530936419;8649.65401383944;8710.956445217766;8769.736907892742;8818.955905220464;8826.205641492264;8495.490270583785;8597.398182127254;8598.441101328393;8610.569471526398;8611.655533778641;8715.564221788916;8778.824423511494;8788.34087443441;8801.779955501099;8809.38334316598;8626.65493380264;8659.783505412352;8709.956450217709;8765.956170219171;8766.60550275239;30184.8490757547;38885.80557097225;39214.80392598047;39687.20625587501;39716.40425393621;3270.9345813083605;3619.981900090509;3698.130939229279;3771.9811400943095;3947.50656167979;29065;29210.561841572395;29449.11652650424;30323.545146822817;30506.389872202653;4457.66567507435;4471.955280447187;4490.371348011281;4520;4579.931301030487;280746;281044;283282;284893.5755321231;286724;60467;61496;61554.38445615487;61595;61616.38383616106;58505;59001;59248;59525;59867.700661497285;17251.74122388165;17676.381326653507;17683.20425580852;17704.55738606545;17745.378911738026;14788.852111478962;14909.403623854925;14954.775678364833;14990.175540345386;15018.69962600742;19934.202631894852;19941.700874486894;20018.499537511678;20205.696914546294;20982.2656207032;6451.129097571861;6535.967320163369;6550.934490655032;6580;6605.768798092044;1059.057438879398;1110.3726394587034;1113.1651261553834;1134.2683968840051;1140.7433327501246;32950.340993180005;32988.38605529442;33365.499517507254;33739.66260337414;33960.471778770014;1088.2762962629763;1092.5192915117482;1128.1087940527057;1155.4511606986614;1163.1973937982764;17517.824821751874;17711.73432398515;17724.20241089154;17728.55678608045;17730.734038989427;283064.33871322457;318054;323472;325963;564181;55806.16290755642;57458.42541574614;57508.424915751144;57637.71181144068;57827.4217257822;1452.3537026023319;1469.169918995764;1478.9556313310618;1512.3799242310379;1515.8408367121515;31262.53106203454;31289.530657040617;31769.364612707155;31897.68102318947;32384.514232287005;54139.72930135324;55240.44759552353;55346.44653553574;55363;55431;426257;429913;431171;431885;433907;27946.860265699353;28045.859770701016;28118.297042573282;28198.15405537837;28287;49531.50468495413;50931;51279.23081153711;51547;52299.47700522946;42259;42810.78594607007;43404;43686.344704828814;44514.55485445104;41313.58686413097;42153;42298.78850605727;43720.56279437292;44445.55554444544;43129;44024;44170.77914610406;44929.32606010847;45087.774561126986;37137.814310928276;37577.4363384544;37607.059823504635;38420.42369364518;38622.4206636895;29750;29826.85086574553;29992.700072999865;30012.249693756956;30068.398632027674 11:56:28 INFO - PROCESS | 2925 | |2;jquery.html;415.8877103182141;415.98960025999355;420.26453706014473;420.90319226577884;421.2964349536274;12334.691632709188;12814.743705125891;18263.634727305445;19112.61774764504;19137.42587722367;20069.297574584893;20422.183112675513;20982.37052888412;21017.159313627435;22166.335009949686;6559.442447391977;6561;6737.006096860697;6789.7284108635595;6810.387065164135;6666.500012499057;6669.4997875159315;6730.259671436138;6766;6770.559913605624;6460.289368169498;6590.967045164767;6647.368499992493;6688.063671086052;6688.431483323923;6377.585456945284;6598;6625.93374066258;6667.766628167991;6678.430568816324;6489.4483968862705;6503.122078519386;6510.08858759774;6512.5766825156215;6520.152380190592;25219.369515762068;25472.745272547407;26955.865220673968;27057.1882843515;27119.457610847672;2568.80733944953;2635.525605391029;2732.8770205340807;3004.8948286809855;3023.6371635403893;15806;16739.916300418543;17120.31518739249;17187.312507499686;17394.82605173945;2189.770074142208;2191.7808219178114;2196.176433837311;2305.101010605865;2339.754325795801;86756.13243867544;87761.56119219426;88292;88791;89026;17492.47522574325;17502.737458938125;17866.91066544685;17932.372366967094;18026.63946721058;15376.615584610474;32493.18767030843;32781.836090819874;32886.83556582202;32917.17707057295;8382.245597896097;8529.530875801891;8543.273821725223;8622.655093796178;8735.121948780916;8228.794280143044;8389.07720150783;8390.496570205807;8455.196756308142;8491.872621910676;4865.513448655106;4875.1712208923855;4911.435184953704;4924.285978533093;4990.950090499048;2021.1915233906261;2044.4582185720797;2047.5802460495563;2095.3190213180474;2132.2430537159394;1022.3099407899638;1032.6024480575034;1038.2576457832686;1056.8361903904906;1165.8659254185707;17793.377231797083;18694.71957920632;18828.24687012504;18934.337298194772;19908.203671853254;1057.381431862369;1057.9471026448646;1068.3643232276784;1108.5621179634;1146.8222425524057;10439.634612788668;10986.450677466095;10997.560097596006;11017;11178.329300242012;484479;486687;495677;557364;570624;95069.0493095074;101119;101179;101203.49398252962;103230;1065.5950738719237;1068.8503609494676;1076.4348716923678;1084.614961688605;1094.2668412163869;17034.403795867085;17170;17339.154297118625;17622.383216587357;17679.73480397821;41277;41334.79332603438;41410.79294603508;41543.169136617704;42162.57837421587;60272.39727602668;60820.695896522004;60828.6958565222;61243.693781530805;62667.373326266155;8980.640774369213;9008.41445306053;9123.77190570241;9187.943386510637;9199.126083022102;10428.478576071318;12952.676183095122;13078.934605326913;13617.387217575035;13896.861031389557;8720.12798720123;10832.18758593093;11322.490487927898;12069.094817888868;12315;11078.944605276922;11426.428678565871;11886.28682279066;12129.939350303544;12179.939100304442;6731.966340168267;11271.49278282463;12217.144799863925;12360.75278494443;12553.49786008586;8939.240164586083;9062.501562413867;9128.589213485542;9266.675666351646;9320;9591.952040240034;12358.320292384005;12495.500179992698;12539.373031348214;12623.179493332904 11:56:28 INFO - PROCESS | 2925 | |3;mootools.html;1427.6288165077076;1459.1026518691;1508.9170095644736;1518.9772153417698;1535.963224823244;7845.646945887434;8616.61225244864;8689.435186712875;9063.139001794827;9063.410878292907;8745.650173993048;8752.29981601472;8780.209781119698;8828.117188281169;8847.73456796297;2419.830611857171;2433.0875921529428;2434.8782560871973;2435.1842132885504;2439.9390015249583;2361.1499860050367;2393.2580899920995;2458.201084647497;2468.4075821802726;2475.616279476675;2445.6576079348906;2452.2765784093735;2461.064795377754;2464;2476.962845557318;2296.942576435594;2298.6552017197387;2307.100230909938;2315.5759208087075;2339.9883000584887;2333.568289866363;2375.2043065573052;2390.8206884483734;2404.7354790972977;2415.806735461159;8655.17775811297;8657.350698697559;8736.082711315348;8742.956285218534;8748.475091494467;5383.757730902119;5456.181572764078;5518.972405137949;5549.5005449509335;5563.36021357545;3566.2154326048226;3604.044928094057;3626.782393056425;3726.832292546842;3742.55089389275;1196.6170825335896;1198.2510930668332;1226.288752523543;1230.4217018001525;1254.2098477958828;12572.4342404592;12606.054545909003;12695.873041269562;12729.681757956032;12746.235225886569;4880.658353915192;4901.191303434894;5005.89988200234;5051.570616497565;5175.45657705943;10566.947165264124;10605.098566621924;10640.148788096934;10726.088282496075;10752.784944301227;5404.081306177959;5462.962037212917;5534.972325138348;5547.944520554743;5550.5282051026115;4485.641148708096;4843.491433399442;4861.052094841472;4992.051510213048;5002.674826136289;4117.691173162025;4169.145325208325;4222.641075508616;4236.533981262059;4244.724092934011;1362.2916083636453;1386.1752257406827;1388.8194534710626;1396.322783450026;1398.4126666799766;918.8392031394479;1034.1726618705006;1043.1498328861953;1048.397171626318;1050.3487837540774;6112.083187521907;6306.180196574416;6328.873422531524;6411.487081033506;6411.839704007437;1030.8917563655857;1078.0405439159;1080.6001779341693;1081.1620993729764;1095.5453486802887;4145.751254924714;4210.052738133957;4291.69958102936;4321.848735294312;4332.913341733148;10640.68077957647;11030.779384412266;11276.774464510663;11284.210105292716;11327.433628318551;11363.602273920538;11421.714457138638;11441.885581144248;11494.942525287488;11511.539538418538;7930.167332430127;7986.121526632066;8326.45878017927;8404.327653787683;8428.072911979678;6310.905336420049;6352.587081839665;6490.326105853935;6514.6416947068365;6550.737970481127;10255.38467691911;10325.432101234204;10573.62992295266;10682.145428365868;10745.892541074489;10491.632792852213;10654.520546575268;10872.130229581773;10873.075788557744;10900.34597924127;7200.315969982843;7735;7865.056193256617;7990.680372785024;8249.133840946854;8161.79595510117;8202.26179643835;8215.630296636546;8260.173982601691;8285.54429506383;7651.502652327804;7912.723054693058;7922.207779222032;7982.401319901147;8102.311303539265;7602.961985190039;7703.807404814925;7705.922940770521;7732.652030658522;7794;7337.119545654556;7405.5926924019695;7418.072740907387;7464.813379665552;7466.514676546007;5168.560672342743;5279.208118782213;5329.040772660958;5329.227262046904;5427.810026649048;5205.4520944631195;5281.445448228034;5288.153895376721;5405.702686352289;5407.675539467645 11:56:28 INFO - PROCESS | 2925 | |4;prototype.html;342.7429427929053;346.28664950202585;350.7649874584027;351.9208178159916;355.9038162459624;5599.972000140004;5694.971525142379;5785.537157027438;5785.710714464276;5824.7670093196275;5725.856853578663;5727.742251598677;5738.713064346776;5763.279590051244;5775.768969241225;4501.819927202916;4506.729596224221;4514.864554063367;4517.841875534357;4538.659600529957;4436.534163912791;4513.79687914043;4520.779389564816;4532.3881276027805;4551.817927282905;4459.843905463309;4461.531539188387;4477.306017567266;4489.910201795962;4517.367568540407;4467.798949047301;4493.707908985905;4515.322701594754;4515.819367225324;4520.480144783326;3944.6055394460614;4000.6199411055904;4005.379166229239;4017.196560687845;4039.555648878621;5531.889362212773;5547.528460080898;5582.8325150245555;5589.692566908819;5615.606907516475;5183.663061900965;5188.870278243036;5204.0857120012915;5207.270982062514;5218.921716174261;5877.353491115974;6001.9196544621955;6040.96979515104;6060.666663333515;6088.847778805521;4359.517763960269;4363.6072753452345;4394.934075988863;4402.669799765031;4407.977960110179;6245.65718370548;6281.194885912235;6296.905546416808;6325.114483972247;6330.936690633081;4103.584263429112;4350.695451318441;4351.3255445405375;4355.303151495746;4357.302831547001;4318.3738357938555;4359.17175736609;4361.1495758327455;4386.758728269976;4434.578715022068;5045.520675535819;5057.443681195065;5077.847664570068;5088.9745551272745;5115.897682046339;5917.55618328627;5966.582339236212;6050.606710563799;6089.451949324493;6129.478994285447;1600.0799540264395;1612.6855263223558;1619.060944652099;1619.101398723696;1625.4879712890402;1058.8517607534952;1060.5651682810164;1073.2540884085486;1078.6170909327234;1089.0906093411932;6231.750729970841;6245.156903818017;6251;6259.374062593704;6341.112244285804;6629.502787290876;6656.567323123982;6673.63190545937;6681.76613818514;6687.598744075371;5694.857628559236;5964.940350596438;5972.432618901197;6005.879882402328;6047.485963693048;3578.2127931854952;3594.946075808865;3597.5503062117236;3628.292482965849;3628.7480819117363;6196.566240363131;6543.574667646683;6588.439982601437;6595.472362211011;7018.789436316919;6426.2931077581425;6426.807195784134;6463;6477.4170324671;6509.44669703071;6324.932407782222;6520.152380190545;6552.312007239267;6579.47364210862;6604.768833090819;6289.685515724104;6341.143945567289;6350.68246587678;6361.4274715274;6380.3619638035825;5987;6165.198524191826;6267.780627678009;6289.867823791761;6307.873842523216;6562.179727534059;6568.638724869987;6569.310222426577;6570.77002304917;6593.307702691341;4372.125574885099;4441.955580444154;4451.732896026248;4463.486699029653;4466.843660471868;5989.880202396015;6040.738001479152;6151.907721384094;6317.241930968313;6407.839804004937;6072.848178795389;6096.603720758137;6137.189529088841;6149.7847575334645;6151.169592105009;6059.545534084873;6092.862175979286;6112.934898292586;6116.633002019893;6145.480353055226;5717.742701578522;6058.515318774399;6063.333033366238;6081.604695694766;6086.239220097488;6163.568550201443;6204.875902482016;6226.097215903578;6227.750889964532;6262.2172228471445;5903.586748927534;5914.526837853047;6010.278766548042;6038.305594856648;6053.334133245251 11:56:28 INFO - PROCESS | 2925 | |5;yui.html;801.7835184500185;856.3448961544416;876.9170074957426;883.748131782442;899.2356496977566;14589.124652520843;14653.926730366333;14757.409703611856;14855.257237138154;14898.702025959474;11709;13892.652683682913;13895.861041389582;13900.791488127687;13947;860.2000139869918;889.0176355127588;892.5760263874672;900.7072701372048;902.4585248850702;896.6413434626169;904.8099899021181;904.9095090490931;906.8050369170627;908.1690253418147;943.3962264150949;945.9479728614923;947.4315410753527;947.7062110745657;951.1487218939045;937.1284705224139;943.259541260111;943.8867335919699;945.7257395355407;948.2366694810675;685.5749435350065;686.0600976661955;688.2463702246083;689.9448044156455;692.3872372949925;14285.142891426443;14577.635559111;14613.415463381452;14627.926860365737;14686;11884.346360950145;12824.23054616726;12846.421911014028;12895.935520322431;14312.713745725026;11190.38452885091;11247.212695111346;11327.150463715254;11378.658640240807;11399.202055856093;4497.9325310120375;4578.198815207359;4586.7477288749105;4666.953330466686;4690.530946905316;49870;50152;50489.74755126201;50607.74696126533;50641.49358506442;10039.247056470795;10326.741831454274;10537.262391632512;10574.471276436301;10595;19142.71285930712;19261.22955081781;19272;19279.22883084661;19329;8224.671013159406;8262.504249745034;8348.081711011784;8461.23848853606;8498.192671696179;4474.530174331649;4542.704724192917;4577.427821522309;4589.449266088024;4835.323054772335;3154.4322022035794;3230.111719277171;3243.8378081095852;3244.5295432162206;3247.269364392993;645.9935400646027;649.2566011916424;657.7730682914387;659.3801826283278;680.8127764864603;729.6315360742897;730.4631096144329;759.1725019728523;773.3658400111967;796.3390385979623;8968.506732129665;9495.57269922855;9561.808763824823;9600.423974561549;9742.220622350194;619.5074915442234;635.8315046512678;721.9061522002106;751.5565816168487;759.5101159751929;4364.367166760802;4372.934405983913;4442.822287108479;4463.620592249695;4558.407407037064;69276.6536167316;70066;72048;72085.27914720785;72286.277137229;59434;60722;60910;61557.692211538655;63225.05162422567;54408;55205.1719224212;55227.171592426144;55467.72266138724;55980;8588.785280368042;8692.739217823475;9127.908720912706;9367.859482107637;9520.428774273565;35317;35994.4600830993;36112.277754444236;36137;36174.63825361713;50116;50156.498435015186;50408.49591504185;50887.98224035424;51309.48690513196;12636.36952094516;12676.556320528738;12707.87292127067;12777.872221277668;12852.55016074433;14214.644633884236;14299;14312;14515.346809393392;14535.927320363331;12714.68213294638;12831.871681283068;12849.935750321563;12869.871301286867;13068.607941761762;13322.40049197769;13378.13042152257;13387.330633468482;13562.118462299919;13590.86409135896;12891.935540322238;12892.677683057998;13158.473661053451;13378;13771.242581658105;10737.946310268711;10791.946040269748;10948.56205751793;11008.174386921173;11028.613998510014;10816.837747433638;10939.398333091756;11045;11129.332240065622;11186.608468703556 11:56:28 INFO - PROCESS | 2925 | __end_tp_report 11:56:28 INFO - PROCESS | 2925 | __start_cc_report 11:56:28 INFO - PROCESS | 2925 | _x_x_mozilla_cycle_collect,324 11:56:28 INFO - PROCESS | 2925 | __end_cc_report 11:56:28 INFO - PROCESS | 2925 | __startTimestamp1462474588854__endTimestamp 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | ------- Summary: start ------- 11:56:28 INFO - PROCESS | 2925 | Number of tests: 6 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | [#0] dojo.html Cycles:165 Average:5742.08 Median:5953.46 stddev:646.73 (10.9%) stddev-sans-first:622.78 11:56:28 INFO - PROCESS | 2925 | Values: 3431.1 3471.3 3480.4 3510.0 3541.6 5676.6 5706.7 5760.4 5767.4 5768.9 5800.7 5855.3 5856.2 5883.9 5902.6 5279.9 5326.2 5361.6 5365.4 5372.9 5182.8 5211.3 5320.8 5395.1 5402.4 5231.7 5258.2 5278.2 5288.5 5353.4 5257.6 5280.2 5293.0 5297.4 5298.3 5119.7 5121.4 5124.2 5215.1 5259.3 5579.7 5581.9 5599.0 5636.7 5672.6 6117.8 6166.6 6172.5 6174.9 6176.5 6054.9 6197.9 6203.5 6218.8 6285.5 5800.1 5809.1 5812.7 5813.5 5820.9 6338.4 6353.1 6355.1 6359.4 6368.3 5990.6 6039.5 6079.5 6127.8 6153.9 6143.6 6143.9 6151.5 6157.6 6159.4 6086.9 6108.9 6124.4 6125.4 6128.8 5976.8 6165.9 6243.6 6300.8 6308.8 4656.8 4685.5 4686.5 4689.2 4718.8 4084.6 4142.8 4192.4 4201.4 4216.4 5776.1 5804.0 5811.7 5891.9 5952.2 6182.4 6189.2 6200.4 6205.8 6211.0 5900.8 5902.9 5907.0 5921.6 5924.1 5021.2 5119.3 5133.2 5150.4 5218.2 6296.2 6310.0 6372.3 6377.6 6396.0 6103.6 6198.2 6231.8 6238.3 6240.4 6363.4 6395.0 6395.5 6407.7 6421.7 6021.8 6056.0 6077.9 6132.9 6148.5 6240.2 6243.6 6254.3 6262.4 6272.5 6002.3 6056.7 6072.5 6081.9 6086.1 6062.0 6065.9 6070.6 6078.3 6078.6 5847.0 5896.3 5950.5 5978.3 5989.8 6088.3 6119.9 6133.2 6178.8 6184.7 5859.1 5918.5 5919.1 5921.3 5953.5 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | [#1] ext.html Cycles:180 Average:53332.12 Median:21581.16 stddev:97284.08 (450.8%) stddev-sans-first:97476.60 11:56:28 INFO - PROCESS | 2925 | Values: 658.6 672.6 677.6 686.8 782.0 33086.5 33919.0 33977.5 34074.8 34081.5 32662.5 33210.2 33438.5 33439.7 33507.7 8619.1 8865.4 8901.6 8905.6 8927.7 8649.7 8711.0 8769.7 8819.0 8826.2 8495.5 8597.4 8598.4 8610.6 8611.7 8715.6 8778.8 8788.3 8801.8 8809.4 8626.7 8659.8 8710.0 8766.0 8766.6 30184.8 38885.8 39214.8 39687.2 39716.4 3270.9 3620.0 3698.1 3772.0 3947.5 29065.0 29210.6 29449.1 30323.5 30506.4 4457.7 4472.0 4490.4 4520.0 4579.9 280746.0 281044.0 283282.0 284893.6 286724.0 60467.0 61496.0 61554.4 61595.0 61616.4 58505.0 59001.0 59248.0 59525.0 59867.7 17251.7 17676.4 17683.2 17704.6 17745.4 14788.9 14909.4 14954.8 14990.2 15018.7 19934.2 19941.7 20018.5 20205.7 20982.3 6451.1 6536.0 6550.9 6580.0 6605.8 1059.1 1110.4 1113.2 1134.3 1140.7 32950.3 32988.4 33365.5 33739.7 33960.5 1088.3 1092.5 1128.1 1155.5 1163.2 17517.8 17711.7 17724.2 17728.6 17730.7 283064.3 318054.0 323472.0 325963.0 564181.0 55806.2 57458.4 57508.4 57637.7 57827.4 1452.4 1469.2 1479.0 1512.4 1515.8 31262.5 31289.5 31769.4 31897.7 32384.5 54139.7 55240.4 55346.4 55363.0 55431.0 426257.0 429913.0 431171.0 431885.0 433907.0 27946.9 28045.9 28118.3 28198.2 28287.0 49531.5 50931.0 51279.2 51547.0 52299.5 42259.0 42810.8 43404.0 43686.3 44514.6 41313.6 42153.0 42298.8 43720.6 44445.6 43129.0 44024.0 44170.8 44929.3 45087.8 37137.8 37577.4 37607.1 38420.4 38622.4 29750.0 29826.9 29992.7 30012.2 30068.4 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | [#2] jquery.html Cycles:180 Average:31315.17 Median:14795.70 stddev:85822.61 (580.1%) stddev-sans-first:86032.01 11:56:28 INFO - PROCESS | 2925 | Values: 415.9 416.0 420.3 420.9 421.3 12334.7 12814.7 18263.6 19112.6 19137.4 20069.3 20422.2 20982.4 21017.2 22166.3 6559.4 6561.0 6737.0 6789.7 6810.4 6666.5 6669.5 6730.3 6766.0 6770.6 6460.3 6591.0 6647.4 6688.1 6688.4 6377.6 6598.0 6625.9 6667.8 6678.4 6489.4 6503.1 6510.1 6512.6 6520.2 25219.4 25472.7 26955.9 27057.2 27119.5 2568.8 2635.5 2732.9 3004.9 3023.6 15806.0 16739.9 17120.3 17187.3 17394.8 2189.8 2191.8 2196.2 2305.1 2339.8 86756.1 87761.6 88292.0 88791.0 89026.0 17492.5 17502.7 17866.9 17932.4 18026.6 15376.6 32493.2 32781.8 32886.8 32917.2 8382.2 8529.5 8543.3 8622.7 8735.1 8228.8 8389.1 8390.5 8455.2 8491.9 4865.5 4875.2 4911.4 4924.3 4991.0 2021.2 2044.5 2047.6 2095.3 2132.2 1022.3 1032.6 1038.3 1056.8 1165.9 17793.4 18694.7 18828.2 18934.3 19908.2 1057.4 1057.9 1068.4 1108.6 1146.8 10439.6 10986.5 10997.6 11017.0 11178.3 484479.0 486687.0 495677.0 557364.0 570624.0 95069.0 101119.0 101179.0 101203.5 103230.0 1065.6 1068.9 1076.4 1084.6 1094.3 17034.4 17170.0 17339.2 17622.4 17679.7 41277.0 41334.8 41410.8 41543.2 42162.6 60272.4 60820.7 60828.7 61243.7 62667.4 8980.6 9008.4 9123.8 9187.9 9199.1 10428.5 12952.7 13078.9 13617.4 13896.9 8720.1 10832.2 11322.5 12069.1 12315.0 11078.9 11426.4 11886.3 12129.9 12179.9 6732.0 11271.5 12217.1 12360.8 12553.5 8939.2 9062.5 9128.6 9266.7 9320.0 9592.0 12358.3 12495.5 12539.4 12623.2 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | [#3] mootools.html Cycles:180 Average:5976.20 Median:4268.21 stddev:3357.82 (78.7%) stddev-sans-first:3349.84 11:56:28 INFO - PROCESS | 2925 | Values: 1427.6 1459.1 1508.9 1519.0 1536.0 7845.6 8616.6 8689.4 9063.1 9063.4 8745.7 8752.3 8780.2 8828.1 8847.7 2419.8 2433.1 2434.9 2435.2 2439.9 2361.1 2393.3 2458.2 2468.4 2475.6 2445.7 2452.3 2461.1 2464.0 2477.0 2296.9 2298.7 2307.1 2315.6 2340.0 2333.6 2375.2 2390.8 2404.7 2415.8 8655.2 8657.4 8736.1 8743.0 8748.5 5383.8 5456.2 5519.0 5549.5 5563.4 3566.2 3604.0 3626.8 3726.8 3742.6 1196.6 1198.3 1226.3 1230.4 1254.2 12572.4 12606.1 12695.9 12729.7 12746.2 4880.7 4901.2 5005.9 5051.6 5175.5 10566.9 10605.1 10640.1 10726.1 10752.8 5404.1 5463.0 5535.0 5547.9 5550.5 4485.6 4843.5 4861.1 4992.1 5002.7 4117.7 4169.1 4222.6 4236.5 4244.7 1362.3 1386.2 1388.8 1396.3 1398.4 918.8 1034.2 1043.1 1048.4 1050.3 6112.1 6306.2 6328.9 6411.5 6411.8 1030.9 1078.0 1080.6 1081.2 1095.5 4145.8 4210.1 4291.7 4321.8 4332.9 10640.7 11030.8 11276.8 11284.2 11327.4 11363.6 11421.7 11441.9 11494.9 11511.5 7930.2 7986.1 8326.5 8404.3 8428.1 6310.9 6352.6 6490.3 6514.6 6550.7 10255.4 10325.4 10573.6 10682.1 10745.9 10491.6 10654.5 10872.1 10873.1 10900.3 7200.3 7735.0 7865.1 7990.7 8249.1 8161.8 8202.3 8215.6 8260.2 8285.5 7651.5 7912.7 7922.2 7982.4 8102.3 7603.0 7703.8 7705.9 7732.7 7794.0 7337.1 7405.6 7418.1 7464.8 7466.5 5168.6 5279.2 5329.0 5329.2 5427.8 5205.5 5281.4 5288.2 5405.7 5407.7 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | [#4] prototype.html Cycles:180 Average:5166.61 Median:5805.24 stddev:1529.36 (26.3%) stddev-sans-first:1490.18 11:56:28 INFO - PROCESS | 2925 | Values: 342.7 346.3 350.8 351.9 355.9 5600.0 5695.0 5785.5 5785.7 5824.8 5725.9 5727.7 5738.7 5763.3 5775.8 4501.8 4506.7 4514.9 4517.8 4538.7 4436.5 4513.8 4520.8 4532.4 4551.8 4459.8 4461.5 4477.3 4489.9 4517.4 4467.8 4493.7 4515.3 4515.8 4520.5 3944.6 4000.6 4005.4 4017.2 4039.6 5531.9 5547.5 5582.8 5589.7 5615.6 5183.7 5188.9 5204.1 5207.3 5218.9 5877.4 6001.9 6041.0 6060.7 6088.8 4359.5 4363.6 4394.9 4402.7 4408.0 6245.7 6281.2 6296.9 6325.1 6330.9 4103.6 4350.7 4351.3 4355.3 4357.3 4318.4 4359.2 4361.1 4386.8 4434.6 5045.5 5057.4 5077.8 5089.0 5115.9 5917.6 5966.6 6050.6 6089.5 6129.5 1600.1 1612.7 1619.1 1619.1 1625.5 1058.9 1060.6 1073.3 1078.6 1089.1 6231.8 6245.2 6251.0 6259.4 6341.1 6629.5 6656.6 6673.6 6681.8 6687.6 5694.9 5964.9 5972.4 6005.9 6047.5 3578.2 3594.9 3597.6 3628.3 3628.7 6196.6 6543.6 6588.4 6595.5 7018.8 6426.3 6426.8 6463.0 6477.4 6509.4 6324.9 6520.2 6552.3 6579.5 6604.8 6289.7 6341.1 6350.7 6361.4 6380.4 5987.0 6165.2 6267.8 6289.9 6307.9 6562.2 6568.6 6569.3 6570.8 6593.3 4372.1 4442.0 4451.7 4463.5 4466.8 5989.9 6040.7 6151.9 6317.2 6407.8 6072.8 6096.6 6137.2 6149.8 6151.2 6059.5 6092.9 6112.9 6116.6 6145.5 5717.7 6058.5 6063.3 6081.6 6086.2 6163.6 6204.9 6226.1 6227.8 6262.2 5903.6 5914.5 6010.3 6038.3 6053.3 11:56:28 INFO - PROCESS | 2925 | 11:56:28 INFO - PROCESS | 2925 | [#5] yui.html Cycles:180 Average:15579.05 Median:4588.10 stddev:18571.82 (404.8%) stddev-sans-first:18590.76 11:56:28 INFO - PROCESS | 2925 | Values: 801.8 856.3 876.9 883.7 899.2 14589.1 14653.9 14757.4 14855.3 14898.7 11709.0 13892.7 13895.9 13900.8 13947.0 860.2 889.0 892.6 900.7 902.5 896.6 904.8 904.9 906.8 908.2 943.4 945.9 947.4 947.7 951.1 937.1 943.3 943.9 945.7 948.2 685.6 686.1 688.2 689.9 692.4 14285.1 14577.6 14613.4 14627.9 14686.0 11884.3 12824.2 12846.4 12895.9 14312.7 11190.4 11247.2 11327.2 11378.7 11399.2 4497.9 4578.2 4586.7 4667.0 4690.5 49870.0 50152.0 50489.7 50607.7 50641.5 10039.2 10326.7 10537.3 10574.5 10595.0 19142.7 19261.2 19272.0 19279.2 19329.0 8224.7 8262.5 8348.1 8461.2 8498.2 4474.5 4542.7 4577.4 4589.4 4835.3 3154.4 3230.1 3243.8 3244.5 3247.3 646.0 649.3 657.8 659.4 680.8 729.6 730.5 759.2 773.4 796.3 8968.5 9495.6 9561.8 9600.4 9742.2 619.5 635.8 721.9 751.6 759.5 4364.4 4372.9 4442.8 4463.6 4558.4 69276.7 70066.0 72048.0 72085.3 72286.3 59434.0 60722.0 60910.0 61557.7 63225.1 54408.0 55205.2 55227.2 55467.7 55980.0 8588.8 8692.7 9127.9 9367.9 9520.4 35317.0 35994.5 36112.3 36137.0 36174.6 50116.0 50156.5 50408.5 50888.0 51309.5 12636.4 12676.6 12707.9 12777.9 12852.6 14214.6 14299.0 14312.0 14515.3 14535.9 12714.7 12831.9 12849.9 12869.9 13068.6 13322.4 13378.1 13387.3 13562.1 13590.9 12891.9 12892.7 13158.5 13378.0 13771.2 10737.9 10791.9 10948.6 11008.2 11028.6 10816.8 10939.4 11045.0 11129.3 11186.6 11:56:28 INFO - PROCESS | 2925 | -------- Summary: end -------- 11:56:28 INFO - PROCESS | 2925 | 11:56:29 INFO - TEST-INFO | 2925: exit 0 11:56:29 INFO - TEST-OK | dromaeo_css | took 1109817ms 11:56:29 INFO - TEST-START | kraken 11:56:29 INFO - operating with platform_type : linux_ 11:56:29 INFO - Initialising browser for kraken test... 11:56:29 INFO - TEST-INFO | started process 3170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFH3Ydh/profile http://localhost:39297/getInfo.html) 11:56:33 INFO - PROCESS | 3170 | 11:56:33 INFO - PROCESS | 3170 | (process:3245): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:56:34 INFO - PROCESS | 3170 | __metrics Screen width/height:1600/1200 11:56:34 INFO - PROCESS | 3170 | colorDepth:24 11:56:34 INFO - PROCESS | 3170 | Browser inner width/height: 1024/697 11:56:34 INFO - PROCESS | 3170 | __metrics 11:56:35 ERROR - PROCESS | 3170 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:56:35 INFO - TEST-INFO | 3170: exit 0 11:56:35 INFO - Browser initialized. 11:56:35 INFO - Running cycle 1/1 for kraken test... 11:56:35 INFO - TEST-INFO | started process 3296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFH3Ydh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:37 INFO - PROCESS | 3296 | 11:56:37 INFO - PROCESS | 3296 | (process:3364): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:56:47 INFO - PROCESS | 3296 | RSS: Main: 152702976 11:56:47 INFO - PROCESS | 3296 | 11:56:50 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-beat-detection) 11:56:51 INFO - PROCESS | 3296 | RSS: Main: 157204480 11:56:51 INFO - PROCESS | 3296 | 11:56:53 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-dft) 11:56:54 INFO - PROCESS | 3296 | RSS: Main: 157392896 11:56:54 INFO - PROCESS | 3296 | 11:56:57 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-fft) 11:56:57 INFO - PROCESS | 3296 | RSS: Main: 157839360 11:56:57 INFO - PROCESS | 3296 | 11:56:59 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-oscillator) 11:57:00 INFO - PROCESS | 3296 | RSS: Main: 157687808 11:57:00 INFO - PROCESS | 3296 | 11:57:02 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:03 INFO - PROCESS | 3296 | RSS: Main: 157564928 11:57:03 INFO - PROCESS | 3296 | 11:57:06 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:06 INFO - PROCESS | 3296 | RSS: Main: 157798400 11:57:06 INFO - PROCESS | 3296 | 11:57:10 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:11 INFO - PROCESS | 3296 | RSS: Main: 157908992 11:57:11 INFO - PROCESS | 3296 | 11:57:13 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39297/tests/kraken/driver.html?testName=json-parse-financial) 11:57:14 INFO - PROCESS | 3296 | RSS: Main: 157741056 11:57:14 INFO - PROCESS | 3296 | 11:57:15 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:16 INFO - PROCESS | 3296 | RSS: Main: 157802496 11:57:16 INFO - PROCESS | 3296 | 11:57:18 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:18 INFO - PROCESS | 3296 | RSS: Main: 157896704 11:57:18 INFO - PROCESS | 3296 | 11:57:20 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:21 INFO - PROCESS | 3296 | RSS: Main: 158015488 11:57:21 INFO - PROCESS | 3296 | 11:57:24 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:24 INFO - PROCESS | 3296 | RSS: Main: 158494720 11:57:24 INFO - PROCESS | 3296 | 11:57:27 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:28 INFO - PROCESS | 3296 | RSS: Main: 158437376 11:57:28 INFO - PROCESS | 3296 | 11:57:29 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39297/tests/kraken/driver.html?testName=ai-astar) 11:57:30 INFO - PROCESS | 3296 | RSS: Main: 159645696 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | __start_tp_report 11:57:30 INFO - PROCESS | 3296 | _x_x_mozilla_page_load 11:57:30 INFO - PROCESS | 3296 | _x_x_mozilla_page_load_details 11:57:30 INFO - PROCESS | 3296 | |i|pagename|runs| 11:57:30 INFO - PROCESS | 3296 | |0;ai-astar;111;103;111;109;109;123;111;113;112;110 11:57:30 INFO - PROCESS | 3296 | |1;audio-beat-detection;159;136;153;174;129;152;151;128;171;129 11:57:30 INFO - PROCESS | 3296 | |2;audio-dft;161;163;163;162;162;163;163;162;165;163 11:57:30 INFO - PROCESS | 3296 | |3;audio-fft;76;74;75;164;77;76;77;75;165;76 11:57:30 INFO - PROCESS | 3296 | |4;audio-oscillator;91;94;152;92;93;92;155;92;97;147 11:57:30 INFO - PROCESS | 3296 | |5;imaging-gaussian-blur;118;117;117;118;117;117;118;118;118;118 11:57:30 INFO - PROCESS | 3296 | |6;imaging-darkroom;146;147;147;146;146;148;147;148;146;145 11:57:30 INFO - PROCESS | 3296 | |7;imaging-desaturate;96;95;96;95;95;95;96;94;95;95 11:57:30 INFO - PROCESS | 3296 | |8;json-parse-financial;57;62;59;57;59;57;63;71;59;56 11:57:30 INFO - PROCESS | 3296 | |9;json-stringify-tinderbox;63;58;57;58;58;58;57;57;57;56 11:57:30 INFO - PROCESS | 3296 | |10;stanford-crypto-aes;73;74;74;72;75;81;75;74;74;73 11:57:30 INFO - PROCESS | 3296 | |11;stanford-crypto-ccm;122;122;120;132;122;127;120;120;149;123 11:57:30 INFO - PROCESS | 3296 | |12;stanford-crypto-pbkdf2;165;162;170;161;164;164;162;162;166;164 11:57:30 INFO - PROCESS | 3296 | |13;stanford-crypto-sha256-iterative;67;75;67;69;68;68;67;67;66;67 11:57:30 INFO - PROCESS | 3296 | __end_tp_report 11:57:30 INFO - PROCESS | 3296 | __start_cc_report 11:57:30 INFO - PROCESS | 3296 | _x_x_mozilla_cycle_collect,851 11:57:30 INFO - PROCESS | 3296 | __end_cc_report 11:57:30 INFO - PROCESS | 3296 | __startTimestamp1462474650027__endTimestamp 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | ------- Summary: start ------- 11:57:30 INFO - PROCESS | 3296 | Number of tests: 14 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.96 (4.5%) stddev-sans-first:5.26 11:57:30 INFO - PROCESS | 3296 | Values: 111.0 103.0 111.0 109.0 109.0 123.0 111.0 113.0 112.0 110.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:152.50 stddev:17.13 (11.2%) stddev-sans-first:17.72 11:57:30 INFO - PROCESS | 3296 | Values: 159.0 136.0 153.0 174.0 129.0 152.0 151.0 128.0 171.0 129.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:0.93 11:57:30 INFO - PROCESS | 3296 | Values: 161.0 163.0 163.0 162.0 162.0 163.0 163.0 162.0 165.0 163.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.43 (49.3%) stddev-sans-first:39.16 11:57:30 INFO - PROCESS | 3296 | Values: 76.0 74.0 75.0 164.0 77.0 76.0 77.0 75.0 165.0 76.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:28.29 (30.7%) stddev-sans-first:29.11 11:57:30 INFO - PROCESS | 3296 | Values: 91.0 94.0 152.0 92.0 93.0 92.0 155.0 92.0 97.0 147.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:57:30 INFO - PROCESS | 3296 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 11:57:30 INFO - PROCESS | 3296 | Values: 146.0 147.0 147.0 146.0 146.0 148.0 147.0 148.0 146.0 145.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 11:57:30 INFO - PROCESS | 3296 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.00 stddev:4.47 (7.6%) stddev-sans-first:4.61 11:57:30 INFO - PROCESS | 3296 | Values: 57.0 62.0 59.0 57.0 59.0 57.0 63.0 71.0 59.0 56.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:1.91 (3.3%) stddev-sans-first:0.71 11:57:30 INFO - PROCESS | 3296 | Values: 63.0 58.0 57.0 58.0 58.0 58.0 57.0 57.0 57.0 56.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.46 (3.3%) stddev-sans-first:2.55 11:57:30 INFO - PROCESS | 3296 | Values: 73.0 74.0 74.0 72.0 75.0 81.0 75.0 74.0 74.0 73.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:122.50 stddev:9.01 (7.4%) stddev-sans-first:9.45 11:57:30 INFO - PROCESS | 3296 | Values: 122.0 122.0 120.0 132.0 122.0 127.0 120.0 120.0 149.0 123.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:2.62 (1.6%) stddev-sans-first:2.76 11:57:30 INFO - PROCESS | 3296 | Values: 165.0 162.0 170.0 161.0 164.0 164.0 162.0 162.0 166.0 164.0 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - PROCESS | 3296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:2.56 (3.8%) stddev-sans-first:2.68 11:57:30 INFO - PROCESS | 3296 | Values: 67.0 75.0 67.0 69.0 68.0 68.0 67.0 67.0 66.0 67.0 11:57:30 INFO - PROCESS | 3296 | -------- Summary: end -------- 11:57:30 INFO - PROCESS | 3296 | 11:57:30 INFO - TEST-INFO | 3296: exit 0 11:57:30 INFO - TEST-OK | kraken | took 61418ms 11:57:30 INFO - SUITE-END | took 1171s 11:57:31 INFO - Completed test suite (00:19:31) 11:57:31 INFO - javascript benchmark 11:57:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3431.0907609483484, 3471.2536804587007, 3480.3735327641016, 3510.0, 3541.62812904645, 5676.631018983773, 5706.65760054397, 5760.423957604243, 5767.394423585526, 5768.942310576893, 5800.680962547058, 5855.268091488564, 5856.150858125569, 5883.941160588403, 5902.645841249528, 5279.868003299919, 5326.201069839536, 5361.624686271943, 5365.356157261134, 5372.865678358053, 5182.792688292464, 5211.322528071364, 5320.76056577455, 5395.082835917903, 5402.37872644645, 5231.738413079331, 5258.184981327881, 5278.181881808326, 5288.497592728704, 5353.3843607985, 5257.5531079858065, 5280.234366016906, 5293.0, 5297.417284098746, 5298.258243845865, 5119.692818430906, 5121.359830021247, 5124.231365295235, 5215.061288967984, 5259.342582177228, 5579.69311687857, 5581.944180558183, 5598.972005139989, 5636.71816409182, 5672.602917795756, 6117.755289788403, 6166.599171053867, 6172.537059720539, 6174.938250617482, 6176.505879529672, 6054.878902421927, 6197.938020619781, 6203.472704820096, 6218.751249949996, 6285.528585356071, 5800.071988481823, 5809.070548712186, 5812.738426770806, 5813.534917206655, 5820.854478638025, 6338.366163383625, 6353.078803573456, 6355.142055822497, 6359.395857393541, 6368.331325210786, 5990.580659353891, 6039.456448919531, 6079.544034197364, 6127.769884593299, 6153.938460615426, 6143.631382117087, 6143.877122457615, 6151.5386346024225, 6157.568970172045, 6159.414855588801, 6086.939170516033, 6108.877822443526, 6124.418180272867, 6125.356837532084, 6128.754849805958, 5976.820695379146, 6165.938340616626, 6243.594166379171, 6300.779472718433, 6308.779192728232, 4656.837010704609, 4685.508021657745, 4686.484486706459, 4689.20283551797, 4718.834840780556, 4084.571120032354, 4142.813573389205, 4192.413062171298, 4201.390798334224, 4216.388623649554, 5776.104703770922, 5803.970980145156, 5811.738471768781, 5891.852703682443, 5952.196453478811, 6182.412670796267, 6189.226346706661, 6200.410960958701, 6205.751769929243, 6211.0, 5900.76396944126, 5902.852428689232, 5907.0, 5921.585489015813, 5924.081767325985, 5021.246812978083, 5119.334486516729, 5133.153029750124, 5150.356205474316, 5218.217267409919, 6296.181496405529, 6310.0, 6372.299047104815, 6377.585456945284, 6396.040593910858, 6103.572749907464, 6198.194234749544, 6231.813045608639, 6238.282597501346, 6240.4071613196675, 6363.395477429637, 6394.968025159845, 6395.456386207225, 6407.743690252338, 6421.678916054085, 6021.819345419644, 6056.031035034373, 6077.893582007715, 6132.850133029843, 6148.538859585638, 6240.219972503437, 6243.594166379171, 6254.312025677263, 6262.373762623702, 6272.466840318624, 6002.279726432856, 6056.666883321283, 6072.453479186895, 6081.878362432815, 6086.087086936818, 6062.0, 6065.909011364744, 6070.6357618543025, 6078.270607527125, 6078.635281883101, 5846.970765146147, 5896.292444906467, 5950.523958083257, 5978.312494063064, 5989.8203053908455, 6088.269407671108, 6119.868162944292, 6133.1510485532735, 6178.783742569169, 6184.6598437086395, 5859.062549991981, 5918.496927761188, 5919.082542205965, 5921.289445266596, 5953.464188223081], "value": 5699.492532562248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.5752189837555, 672.5998031171455, 677.6374639567832, 686.8214264291286, 782.0146615264772, 33086.50370244448, 33919.0, 33977.49033764489, 34074.8296258519, 34081.488777668324, 32662.510062349025, 33210.169745756306, 33438.49842252362, 33439.66560334396, 33507.664923350756, 8619.138086191393, 8865.423747456427, 8901.554922253894, 8905.554722263892, 8927.687530936419, 8649.65401383944, 8710.956445217766, 8769.736907892742, 8818.955905220464, 8826.205641492264, 8495.490270583785, 8597.398182127254, 8598.441101328393, 8610.569471526398, 8611.655533778641, 8715.564221788916, 8778.824423511494, 8788.34087443441, 8801.779955501099, 8809.38334316598, 8626.65493380264, 8659.783505412352, 8709.956450217709, 8765.956170219171, 8766.60550275239, 30184.8490757547, 38885.80557097225, 39214.80392598047, 39687.20625587501, 39716.40425393621, 3270.9345813083605, 3619.981900090509, 3698.130939229279, 3771.9811400943095, 3947.50656167979, 29065.0, 29210.561841572395, 29449.11652650424, 30323.545146822817, 30506.389872202653, 4457.66567507435, 4471.955280447187, 4490.371348011281, 4520.0, 4579.931301030487, 280746.0, 281044.0, 283282.0, 284893.5755321231, 286724.0, 60467.0, 61496.0, 61554.38445615487, 61595.0, 61616.38383616106, 58505.0, 59001.0, 59248.0, 59525.0, 59867.700661497285, 17251.74122388165, 17676.381326653507, 17683.20425580852, 17704.55738606545, 17745.378911738026, 14788.852111478962, 14909.403623854925, 14954.775678364833, 14990.175540345386, 15018.69962600742, 19934.202631894852, 19941.700874486894, 20018.499537511678, 20205.696914546294, 20982.2656207032, 6451.129097571861, 6535.967320163369, 6550.934490655032, 6580.0, 6605.768798092044, 1059.057438879398, 1110.3726394587034, 1113.1651261553834, 1134.2683968840051, 1140.7433327501246, 32950.340993180005, 32988.38605529442, 33365.499517507254, 33739.66260337414, 33960.471778770014, 1088.2762962629763, 1092.5192915117482, 1128.1087940527057, 1155.4511606986614, 1163.1973937982764, 17517.824821751874, 17711.73432398515, 17724.20241089154, 17728.55678608045, 17730.734038989427, 283064.33871322457, 318054.0, 323472.0, 325963.0, 564181.0, 55806.16290755642, 57458.42541574614, 57508.424915751144, 57637.71181144068, 57827.4217257822, 1452.3537026023319, 1469.169918995764, 1478.9556313310618, 1512.3799242310379, 1515.8408367121515, 31262.53106203454, 31289.530657040617, 31769.364612707155, 31897.68102318947, 32384.514232287005, 54139.72930135324, 55240.44759552353, 55346.44653553574, 55363.0, 55431.0, 426257.0, 429913.0, 431171.0, 431885.0, 433907.0, 27946.860265699353, 28045.859770701016, 28118.297042573282, 28198.15405537837, 28287.0, 49531.50468495413, 50931.0, 51279.23081153711, 51547.0, 52299.47700522946, 42259.0, 42810.78594607007, 43404.0, 43686.344704828814, 44514.55485445104, 41313.58686413097, 42153.0, 42298.78850605727, 43720.56279437292, 44445.55554444544, 43129.0, 44024.0, 44170.77914610406, 44929.32606010847, 45087.774561126986, 37137.814310928276, 37577.4363384544, 37607.059823504635, 38420.42369364518, 38622.4206636895, 29750.0, 29826.85086574553, 29992.700072999865, 30012.249693756956, 30068.398632027674], "value": 19928.044412074403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.8877103182141, 415.98960025999355, 420.26453706014473, 420.90319226577884, 421.2964349536274, 12334.691632709188, 12814.743705125891, 18263.634727305445, 19112.61774764504, 19137.42587722367, 20069.297574584893, 20422.183112675513, 20982.37052888412, 21017.159313627435, 22166.335009949686, 6559.442447391977, 6561.0, 6737.006096860697, 6789.7284108635595, 6810.387065164135, 6666.500012499057, 6669.4997875159315, 6730.259671436138, 6766.0, 6770.559913605624, 6460.289368169498, 6590.967045164767, 6647.368499992493, 6688.063671086052, 6688.431483323923, 6377.585456945284, 6598.0, 6625.93374066258, 6667.766628167991, 6678.430568816324, 6489.4483968862705, 6503.122078519386, 6510.08858759774, 6512.5766825156215, 6520.152380190592, 25219.369515762068, 25472.745272547407, 26955.865220673968, 27057.1882843515, 27119.457610847672, 2568.80733944953, 2635.525605391029, 2732.8770205340807, 3004.8948286809855, 3023.6371635403893, 15806.0, 16739.916300418543, 17120.31518739249, 17187.312507499686, 17394.82605173945, 2189.770074142208, 2191.7808219178114, 2196.176433837311, 2305.101010605865, 2339.754325795801, 86756.13243867544, 87761.56119219426, 88292.0, 88791.0, 89026.0, 17492.47522574325, 17502.737458938125, 17866.91066544685, 17932.372366967094, 18026.63946721058, 15376.615584610474, 32493.18767030843, 32781.836090819874, 32886.83556582202, 32917.17707057295, 8382.245597896097, 8529.530875801891, 8543.273821725223, 8622.655093796178, 8735.121948780916, 8228.794280143044, 8389.07720150783, 8390.496570205807, 8455.196756308142, 8491.872621910676, 4865.513448655106, 4875.1712208923855, 4911.435184953704, 4924.285978533093, 4990.950090499048, 2021.1915233906261, 2044.4582185720797, 2047.5802460495563, 2095.3190213180474, 2132.2430537159394, 1022.3099407899638, 1032.6024480575034, 1038.2576457832686, 1056.8361903904906, 1165.8659254185707, 17793.377231797083, 18694.71957920632, 18828.24687012504, 18934.337298194772, 19908.203671853254, 1057.381431862369, 1057.9471026448646, 1068.3643232276784, 1108.5621179634, 1146.8222425524057, 10439.634612788668, 10986.450677466095, 10997.560097596006, 11017.0, 11178.329300242012, 484479.0, 486687.0, 495677.0, 557364.0, 570624.0, 95069.0493095074, 101119.0, 101179.0, 101203.49398252962, 103230.0, 1065.5950738719237, 1068.8503609494676, 1076.4348716923678, 1084.614961688605, 1094.2668412163869, 17034.403795867085, 17170.0, 17339.154297118625, 17622.383216587357, 17679.73480397821, 41277.0, 41334.79332603438, 41410.79294603508, 41543.169136617704, 42162.57837421587, 60272.39727602668, 60820.695896522004, 60828.6958565222, 61243.693781530805, 62667.373326266155, 8980.640774369213, 9008.41445306053, 9123.77190570241, 9187.943386510637, 9199.126083022102, 10428.478576071318, 12952.676183095122, 13078.934605326913, 13617.387217575035, 13896.861031389557, 8720.12798720123, 10832.18758593093, 11322.490487927898, 12069.094817888868, 12315.0, 11078.944605276922, 11426.428678565871, 11886.28682279066, 12129.939350303544, 12179.939100304442, 6731.966340168267, 11271.49278282463, 12217.144799863925, 12360.75278494443, 12553.49786008586, 8939.240164586083, 9062.501562413867, 9128.589213485542, 9266.675666351646, 9320.0, 9591.952040240034, 12358.320292384005, 12495.500179992698, 12539.373031348214, 12623.179493332904], "value": 10169.7637282513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.6288165077076, 1459.1026518691, 1508.9170095644736, 1518.9772153417698, 1535.963224823244, 7845.646945887434, 8616.61225244864, 8689.435186712875, 9063.139001794827, 9063.410878292907, 8745.650173993048, 8752.29981601472, 8780.209781119698, 8828.117188281169, 8847.73456796297, 2419.830611857171, 2433.0875921529428, 2434.8782560871973, 2435.1842132885504, 2439.9390015249583, 2361.1499860050367, 2393.2580899920995, 2458.201084647497, 2468.4075821802726, 2475.616279476675, 2445.6576079348906, 2452.2765784093735, 2461.064795377754, 2464.0, 2476.962845557318, 2296.942576435594, 2298.6552017197387, 2307.100230909938, 2315.5759208087075, 2339.9883000584887, 2333.568289866363, 2375.2043065573052, 2390.8206884483734, 2404.7354790972977, 2415.806735461159, 8655.17775811297, 8657.350698697559, 8736.082711315348, 8742.956285218534, 8748.475091494467, 5383.757730902119, 5456.181572764078, 5518.972405137949, 5549.5005449509335, 5563.36021357545, 3566.2154326048226, 3604.044928094057, 3626.782393056425, 3726.832292546842, 3742.55089389275, 1196.6170825335896, 1198.2510930668332, 1226.288752523543, 1230.4217018001525, 1254.2098477958828, 12572.4342404592, 12606.054545909003, 12695.873041269562, 12729.681757956032, 12746.235225886569, 4880.658353915192, 4901.191303434894, 5005.89988200234, 5051.570616497565, 5175.45657705943, 10566.947165264124, 10605.098566621924, 10640.148788096934, 10726.088282496075, 10752.784944301227, 5404.081306177959, 5462.962037212917, 5534.972325138348, 5547.944520554743, 5550.5282051026115, 4485.641148708096, 4843.491433399442, 4861.052094841472, 4992.051510213048, 5002.674826136289, 4117.691173162025, 4169.145325208325, 4222.641075508616, 4236.533981262059, 4244.724092934011, 1362.2916083636453, 1386.1752257406827, 1388.8194534710626, 1396.322783450026, 1398.4126666799766, 918.8392031394479, 1034.1726618705006, 1043.1498328861953, 1048.397171626318, 1050.3487837540774, 6112.083187521907, 6306.180196574416, 6328.873422531524, 6411.487081033506, 6411.839704007437, 1030.8917563655857, 1078.0405439159, 1080.6001779341693, 1081.1620993729764, 1095.5453486802887, 4145.751254924714, 4210.052738133957, 4291.69958102936, 4321.848735294312, 4332.913341733148, 10640.68077957647, 11030.779384412266, 11276.774464510663, 11284.210105292716, 11327.433628318551, 11363.602273920538, 11421.714457138638, 11441.885581144248, 11494.942525287488, 11511.539538418538, 7930.167332430127, 7986.121526632066, 8326.45878017927, 8404.327653787683, 8428.072911979678, 6310.905336420049, 6352.587081839665, 6490.326105853935, 6514.6416947068365, 6550.737970481127, 10255.38467691911, 10325.432101234204, 10573.62992295266, 10682.145428365868, 10745.892541074489, 10491.632792852213, 10654.520546575268, 10872.130229581773, 10873.075788557744, 10900.34597924127, 7200.315969982843, 7735.0, 7865.056193256617, 7990.680372785024, 8249.133840946854, 8161.79595510117, 8202.26179643835, 8215.630296636546, 8260.173982601691, 8285.54429506383, 7651.502652327804, 7912.723054693058, 7922.207779222032, 7982.401319901147, 8102.311303539265, 7602.961985190039, 7703.807404814925, 7705.922940770521, 7732.652030658522, 7794.0, 7337.119545654556, 7405.5926924019695, 7418.072740907387, 7464.813379665552, 7466.514676546007, 5168.560672342743, 5279.208118782213, 5329.040772660958, 5329.227262046904, 5427.810026649048, 5205.4520944631195, 5281.445448228034, 5288.153895376721, 5405.702686352289, 5407.675539467645], "value": 4814.85199888604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.7429427929053, 346.28664950202585, 350.7649874584027, 351.9208178159916, 355.9038162459624, 5599.972000140004, 5694.971525142379, 5785.537157027438, 5785.710714464276, 5824.7670093196275, 5725.856853578663, 5727.742251598677, 5738.713064346776, 5763.279590051244, 5775.768969241225, 4501.819927202916, 4506.729596224221, 4514.864554063367, 4517.841875534357, 4538.659600529957, 4436.534163912791, 4513.79687914043, 4520.779389564816, 4532.3881276027805, 4551.817927282905, 4459.843905463309, 4461.531539188387, 4477.306017567266, 4489.910201795962, 4517.367568540407, 4467.798949047301, 4493.707908985905, 4515.322701594754, 4515.819367225324, 4520.480144783326, 3944.6055394460614, 4000.6199411055904, 4005.379166229239, 4017.196560687845, 4039.555648878621, 5531.889362212773, 5547.528460080898, 5582.8325150245555, 5589.692566908819, 5615.606907516475, 5183.663061900965, 5188.870278243036, 5204.0857120012915, 5207.270982062514, 5218.921716174261, 5877.353491115974, 6001.9196544621955, 6040.96979515104, 6060.666663333515, 6088.847778805521, 4359.517763960269, 4363.6072753452345, 4394.934075988863, 4402.669799765031, 4407.977960110179, 6245.65718370548, 6281.194885912235, 6296.905546416808, 6325.114483972247, 6330.936690633081, 4103.584263429112, 4350.695451318441, 4351.3255445405375, 4355.303151495746, 4357.302831547001, 4318.3738357938555, 4359.17175736609, 4361.1495758327455, 4386.758728269976, 4434.578715022068, 5045.520675535819, 5057.443681195065, 5077.847664570068, 5088.9745551272745, 5115.897682046339, 5917.55618328627, 5966.582339236212, 6050.606710563799, 6089.451949324493, 6129.478994285447, 1600.0799540264395, 1612.6855263223558, 1619.060944652099, 1619.101398723696, 1625.4879712890402, 1058.8517607534952, 1060.5651682810164, 1073.2540884085486, 1078.6170909327234, 1089.0906093411932, 6231.750729970841, 6245.156903818017, 6251.0, 6259.374062593704, 6341.112244285804, 6629.502787290876, 6656.567323123982, 6673.63190545937, 6681.76613818514, 6687.598744075371, 5694.857628559236, 5964.940350596438, 5972.432618901197, 6005.879882402328, 6047.485963693048, 3578.2127931854952, 3594.946075808865, 3597.5503062117236, 3628.292482965849, 3628.7480819117363, 6196.566240363131, 6543.574667646683, 6588.439982601437, 6595.472362211011, 7018.789436316919, 6426.2931077581425, 6426.807195784134, 6463.0, 6477.4170324671, 6509.44669703071, 6324.932407782222, 6520.152380190545, 6552.312007239267, 6579.47364210862, 6604.768833090819, 6289.685515724104, 6341.143945567289, 6350.68246587678, 6361.4274715274, 6380.3619638035825, 5987.0, 6165.198524191826, 6267.780627678009, 6289.867823791761, 6307.873842523216, 6562.179727534059, 6568.638724869987, 6569.310222426577, 6570.77002304917, 6593.307702691341, 4372.125574885099, 4441.955580444154, 4451.732896026248, 4463.486699029653, 4466.843660471868, 5989.880202396015, 6040.738001479152, 6151.907721384094, 6317.241930968313, 6407.839804004937, 6072.848178795389, 6096.603720758137, 6137.189529088841, 6149.7847575334645, 6151.169592105009, 6059.545534084873, 6092.862175979286, 6112.934898292586, 6116.633002019893, 6145.480353055226, 5717.742701578522, 6058.515318774399, 6063.333033366238, 6081.604695694766, 6086.239220097488, 6163.568550201443, 6204.875902482016, 6226.097215903578, 6227.750889964532, 6262.2172228471445, 5903.586748927534, 5914.526837853047, 6010.278766548042, 6038.305594856648, 6053.334133245251], "value": 4679.581533716939, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.7835184500185, 856.3448961544416, 876.9170074957426, 883.748131782442, 899.2356496977566, 14589.124652520843, 14653.926730366333, 14757.409703611856, 14855.257237138154, 14898.702025959474, 11709.0, 13892.652683682913, 13895.861041389582, 13900.791488127687, 13947.0, 860.2000139869918, 889.0176355127588, 892.5760263874672, 900.7072701372048, 902.4585248850702, 896.6413434626169, 904.8099899021181, 904.9095090490931, 906.8050369170627, 908.1690253418147, 943.3962264150949, 945.9479728614923, 947.4315410753527, 947.7062110745657, 951.1487218939045, 937.1284705224139, 943.259541260111, 943.8867335919699, 945.7257395355407, 948.2366694810675, 685.5749435350065, 686.0600976661955, 688.2463702246083, 689.9448044156455, 692.3872372949925, 14285.142891426443, 14577.635559111, 14613.415463381452, 14627.926860365737, 14686.0, 11884.346360950145, 12824.23054616726, 12846.421911014028, 12895.935520322431, 14312.713745725026, 11190.38452885091, 11247.212695111346, 11327.150463715254, 11378.658640240807, 11399.202055856093, 4497.9325310120375, 4578.198815207359, 4586.7477288749105, 4666.953330466686, 4690.530946905316, 49870.0, 50152.0, 50489.74755126201, 50607.74696126533, 50641.49358506442, 10039.247056470795, 10326.741831454274, 10537.262391632512, 10574.471276436301, 10595.0, 19142.71285930712, 19261.22955081781, 19272.0, 19279.22883084661, 19329.0, 8224.671013159406, 8262.504249745034, 8348.081711011784, 8461.23848853606, 8498.192671696179, 4474.530174331649, 4542.704724192917, 4577.427821522309, 4589.449266088024, 4835.323054772335, 3154.4322022035794, 3230.111719277171, 3243.8378081095852, 3244.5295432162206, 3247.269364392993, 645.9935400646027, 649.2566011916424, 657.7730682914387, 659.3801826283278, 680.8127764864603, 729.6315360742897, 730.4631096144329, 759.1725019728523, 773.3658400111967, 796.3390385979623, 8968.506732129665, 9495.57269922855, 9561.808763824823, 9600.423974561549, 9742.220622350194, 619.5074915442234, 635.8315046512678, 721.9061522002106, 751.5565816168487, 759.5101159751929, 4364.367166760802, 4372.934405983913, 4442.822287108479, 4463.620592249695, 4558.407407037064, 69276.6536167316, 70066.0, 72048.0, 72085.27914720785, 72286.277137229, 59434.0, 60722.0, 60910.0, 61557.692211538655, 63225.05162422567, 54408.0, 55205.1719224212, 55227.171592426144, 55467.72266138724, 55980.0, 8588.785280368042, 8692.739217823475, 9127.908720912706, 9367.859482107637, 9520.428774273565, 35317.0, 35994.4600830993, 36112.277754444236, 36137.0, 36174.63825361713, 50116.0, 50156.498435015186, 50408.49591504185, 50887.98224035424, 51309.48690513196, 12636.36952094516, 12676.556320528738, 12707.87292127067, 12777.872221277668, 12852.55016074433, 14214.644633884236, 14299.0, 14312.0, 14515.346809393392, 14535.927320363331, 12714.68213294638, 12831.871681283068, 12849.935750321563, 12869.871301286867, 13068.607941761762, 13322.40049197769, 13378.13042152257, 13387.330633468482, 13562.118462299919, 13590.86409135896, 12891.935540322238, 12892.677683057998, 13158.473661053451, 13378.0, 13771.242581658105, 10737.946310268711, 10791.946040269748, 10948.56205751793, 11008.174386921173, 11028.613998510014, 10816.837747433638, 10939.398333091756, 11045.0, 11129.332240065622, 11186.608468703556], "value": 7028.782051271025, "unit": "score"}], "name": "dromaeo_css", "value": 7534.484915191041, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 111.0, 109.0, 109.0, 123.0, 111.0, 113.0, 112.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 136.0, 153.0, 174.0, 129.0, 152.0, 151.0, 128.0, 171.0, 129.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 162.0, 165.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 164.0, 77.0, 76.0, 77.0, 75.0, 165.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 152.0, 92.0, 93.0, 92.0, 155.0, 92.0, 97.0, 147.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 148.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 59.0, 57.0, 59.0, 57.0, 63.0, 71.0, 59.0, 56.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0, 56.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 72.0, 75.0, 81.0, 75.0, 74.0, 74.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 120.0, 132.0, 122.0, 127.0, 120.0, 120.0, 149.0, 123.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 170.0, 161.0, 164.0, 164.0, 162.0, 162.0, 166.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 67.0, 69.0, 68.0, 68.0, 67.0, 67.0, 66.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1535.7, "alertThreshold": 2.0}]} 11:57:31 INFO - Return code: 0 11:57:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:57:31 ERROR - # TBPL SUCCESS # 11:57:31 INFO - Running post-action listener: _resource_record_post_action 11:57:31 INFO - Running post-run listener: _resource_record_post_run 11:57:32 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 497545216; Read time: 28; Write time: 430444 11:57:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249028608; Read time: 0; Write time: 267464 11:57:32 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248516608; Read time: 28; Write time: 162980 11:57:32 INFO - Running post-run listener: _upload_blobber_files 11:57:32 INFO - Blob upload gear active. 11:57:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:57:32 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 11:57:32 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'] 11:57:32 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 11:57:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:57:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:33 INFO - (blobuploader) - INFO - Done attempting. 11:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:34 INFO - (blobuploader) - INFO - Done attempting. 11:57:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:57:34 INFO - Return code: 0 11:57:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:57:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:57:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97237260cf70967e5e25ee7574bf3571edf8c0403fc781921cf2ea744b1001facc63407939be7b729d9db223cf2dd7898fc768313b98db39b4b4a2cacc0ea769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a36b971a278c018f67ccf229a95d7d1760e1ace3da6f9db3ccfdff07a19c558dcddc63982a14e09066b9a9c85823873be1993de3af5ee69a6696ffcf5eba64fb"} 11:57:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:57:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:57:34 INFO - Contents: 11:57:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97237260cf70967e5e25ee7574bf3571edf8c0403fc781921cf2ea744b1001facc63407939be7b729d9db223cf2dd7898fc768313b98db39b4b4a2cacc0ea769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a36b971a278c018f67ccf229a95d7d1760e1ace3da6f9db3ccfdff07a19c558dcddc63982a14e09066b9a9c85823873be1993de3af5ee69a6696ffcf5eba64fb"} 11:57:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:57:34 INFO - Copying logs to upload dir... 11:57:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:57:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.784926 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-05 11:57:34.345705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 11:57:34.348859) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381 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/97237260cf70967e5e25ee7574bf3571edf8c0403fc781921cf2ea744b1001facc63407939be7b729d9db223cf2dd7898fc768313b98db39b4b4a2cacc0ea769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a36b971a278c018f67ccf229a95d7d1760e1ace3da6f9db3ccfdff07a19c558dcddc63982a14e09066b9a9c85823873be1993de3af5ee69a6696ffcf5eba64fb"} build_url:https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/Jsng451oSa-fFoPrhY3TZg/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/97237260cf70967e5e25ee7574bf3571edf8c0403fc781921cf2ea744b1001facc63407939be7b729d9db223cf2dd7898fc768313b98db39b4b4a2cacc0ea769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a36b971a278c018f67ccf229a95d7d1760e1ace3da6f9db3ccfdff07a19c558dcddc63982a14e09066b9a9c85823873be1993de3af5ee69a6696ffcf5eba64fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 11:57:34.373020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:57:34.373323) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462473419.133994-1347342381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:57:34.457138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 11:57:34.457458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 11:57:34.457738) ========= ========= Total master_lag: 0.19 =========