builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1461703556.36 results: success (0) buildid: 20160426062558 builduid: 18458ff6a626441ea2f2e0a4fd3bd5e1 revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.358098) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.358542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.358811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.375070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.375352) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 13:45:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-26 13:45:56 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195966 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.584349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.584658) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:56.633564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 13:45:56.633907) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbeae0c4410bef3864b3d3f4ad939321c61cb15b --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 cbeae0c4410bef3864b3d3f4ad939321c61cb15b --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=edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 13:45:56,772 truncating revision to first 12 chars 2016-04-26 13:45:56,772 Setting DEBUG logging. 2016-04-26 13:45:56,772 attempt 1/10 2016-04-26 13:45:56,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cbeae0c4410b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 13:45:57,923 unpacking tar archive at: mozilla-aurora-cbeae0c4410b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 13:45:58.089384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:58.089705) ========= script_repo_revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:58.090095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:58.090357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:45:58.100344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 22 secs) (at 2016-04-26 13:45:58.100615) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:45:58 INFO - MultiFileLogger online at 20160426 13:45:58 in /builds/slave/test 13:45:58 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 13:45:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:45:58 INFO - {'append_to_log': False, 13:45:58 INFO - 'base_work_dir': '/builds/slave/test', 13:45:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:45:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:45:58 INFO - 'branch': 'Mozilla-Aurora', 13:45:58 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:58 INFO - 'config_files': ('talos/linux_config.py',), 13:45:58 INFO - 'default_actions': ('clobber', 13:45:58 INFO - 'read-buildbot-config', 13:45:58 INFO - 'download-and-extract', 13:45:58 INFO - 'populate-webroot', 13:45:58 INFO - 'create-virtualenv', 13:45:58 INFO - 'install', 13:45:58 INFO - 'run-tests'), 13:45:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:58 INFO - 'download_minidump_stackwalk': True, 13:45:58 INFO - 'download_symbols': 'ondemand', 13:45:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:58 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:58 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:58 INFO - 'installer_path': 'installer.exe', 13:45:58 INFO - 'log_level': 'info', 13:45:58 INFO - 'log_name': 'talos', 13:45:58 INFO - 'log_to_console': True, 13:45:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:45:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:45:58 INFO - 'opt_config_files': (), 13:45:58 INFO - 'pip_index': False, 13:45:58 INFO - 'sps_profile': False, 13:45:58 INFO - 'sps_profile_interval': 0, 13:45:58 INFO - 'suite': 'dromaeojs-e10s', 13:45:58 INFO - 'system_bits': '32', 13:45:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:58 INFO - 'title': 'talos-linux64-ix-033', 13:45:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:58 INFO - 'use_talos_json': True, 13:45:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:45:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:58 INFO - 'work_dir': 'build'} 13:45:58 INFO - ##### 13:45:58 INFO - ##### Running clobber step. 13:45:58 INFO - ##### 13:45:58 INFO - Running pre-action listener: _resource_record_pre_action 13:45:58 INFO - Running main action method: clobber 13:45:58 INFO - rmtree: /builds/slave/test/build 13:45:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:45:59 INFO - Running post-action listener: _resource_record_post_action 13:45:59 INFO - ##### 13:45:59 INFO - ##### Running read-buildbot-config step. 13:45:59 INFO - ##### 13:45:59 INFO - Running pre-action listener: _resource_record_pre_action 13:45:59 INFO - Running main action method: read_buildbot_config 13:45:59 INFO - Using buildbot properties: 13:45:59 INFO - { 13:45:59 INFO - "project": "", 13:45:59 INFO - "product": "firefox", 13:45:59 INFO - "script_repo_revision": "production", 13:45:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:45:59 INFO - "repository": "", 13:45:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:45:59 INFO - "buildid": "20160426062558", 13:45:59 INFO - "pgo_build": "True", 13:45:59 INFO - "basedir": "/builds/slave/test", 13:45:59 INFO - "buildnumber": 260, 13:45:59 INFO - "slavename": "talos-linux64-ix-033", 13:45:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:45:59 INFO - "platform": "ubuntu64_hw", 13:45:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:45:59 INFO - "branch": "mozilla-aurora", 13:45:59 INFO - "repo_path": "releases/mozilla-aurora", 13:45:59 INFO - "revision": "cbeae0c4410bef3864b3d3f4ad939321c61cb15b", 13:45:59 INFO - "stage_platform": "linux64-pgo", 13:45:59 INFO - "builduid": "18458ff6a626441ea2f2e0a4fd3bd5e1", 13:45:59 INFO - "slavebuilddir": "test" 13:45:59 INFO - } 13:45:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:45:59 INFO - Running post-action listener: _resource_record_post_action 13:45:59 INFO - ##### 13:45:59 INFO - ##### Running download-and-extract step. 13:45:59 INFO - ##### 13:45:59 INFO - Running pre-action listener: _resource_record_pre_action 13:45:59 INFO - Running main action method: download_and_extract 13:45:59 INFO - mkdir: /builds/slave/test/build/tests 13:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:59 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:45:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:45:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:45:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:45:59 INFO - Downloaded 1361 bytes. 13:45:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:45:59 INFO - Using the following test package requirements: 13:45:59 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:45:59 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:45:59 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:45:59 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'jsshell-linux-x86_64.zip'], 13:45:59 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:45:59 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:45:59 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:45:59 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:45:59 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:45:59 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:45:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:45:59 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:59 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:45:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:45:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:52:43 INFO - Downloaded 23820445 bytes. 13:52:43 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'] 13:52:43 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 13:52:44 INFO - Return code: 0 13:52:44 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 13:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:44 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 14:00:20 INFO - Downloaded 23820445 bytes. 14:00:20 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'] 14:00:20 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 14:00:22 INFO - Return code: 0 14:00:22 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')]} 14:00:22 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 14:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 14:00:43 INFO - Downloaded 10840145 bytes. 14:00:43 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'] 14:00:43 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 14:00:43 INFO - Return code: 0 14:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:43 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 14:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 14:01:02 INFO - Downloaded 62689705 bytes. 14:01:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:01:02 INFO - mkdir: /builds/slave/test/properties 14:01:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:02 INFO - Contents: 14:01:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:01:04 INFO - Running post-action listener: _resource_record_post_action 14:01:04 INFO - Running post-action listener: set_extra_try_arguments 14:01:04 INFO - ##### 14:01:04 INFO - ##### Running populate-webroot step. 14:01:04 INFO - ##### 14:01:04 INFO - Running pre-action listener: _resource_record_pre_action 14:01:04 INFO - Running main action method: populate_webroot 14:01:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:04 INFO - '--tppagecycles', 14:01:04 INFO - '7'], 14:01:04 INFO - 'tests': ['tsvgm']}}, 14:01:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:01:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:01:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['damp', 'tps']}, 14:01:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'tests': ['damp', 'tps']}, 14:01:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['dromaeo_dom']}, 14:01:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['a11yr', 14:01:04 INFO - 'ts_paint', 14:01:04 INFO - 'tpaint', 14:01:04 INFO - 'sessionrestore', 14:01:04 INFO - 'sessionrestore_no_auto_restore', 14:01:04 INFO - 'tabpaint']}, 14:01:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:01:04 INFO - 'ts_paint', 14:01:04 INFO - 'tpaint', 14:01:04 INFO - 'sessionrestore', 14:01:04 INFO - 'sessionrestore_no_auto_restore', 14:01:04 INFO - 'tabpaint']}, 14:01:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:01:04 INFO - 'ts_paint', 14:01:04 INFO - 'tpaint', 14:01:04 INFO - 'sessionrestore', 14:01:04 INFO - 'sessionrestore_no_auto_restore', 14:01:04 INFO - 'tabpaint']}, 14:01:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:01:04 INFO - 'ts_paint', 14:01:04 INFO - 'tpaint', 14:01:04 INFO - 'sessionrestore', 14:01:04 INFO - 'sessionrestore_no_auto_restore', 14:01:04 INFO - 'tabpaint']}, 14:01:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['a11yr', 14:01:04 INFO - 'ts_paint', 14:01:04 INFO - 'tpaint', 14:01:04 INFO - 'sessionrestore', 14:01:04 INFO - 'sessionrestore_no_auto_restore', 14:01:04 INFO - 'tabpaint']}, 14:01:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['a11yr', 14:01:04 INFO - 'ts_paint', 14:01:04 INFO - 'tpaint', 14:01:04 INFO - 'sessionrestore', 14:01:04 INFO - 'sessionrestore_no_auto_restore', 14:01:04 INFO - 'tabpaint']}, 14:01:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['tsvgx', 14:01:04 INFO - 'tsvgr_opacity', 14:01:04 INFO - 'tart', 14:01:04 INFO - 'tscrollx', 14:01:04 INFO - 'cart']}, 14:01:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:01:04 INFO - 'tsvgr_opacity', 14:01:04 INFO - 'tart', 14:01:04 INFO - 'tscrollx', 14:01:04 INFO - 'cart']}, 14:01:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'talos_options': ['--disable-e10s'], 14:01:04 INFO - 'tests': ['tp5o']}, 14:01:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'tests': ['tp5o']}, 14:01:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'talos_options': ['--disable-e10s', 14:01:04 INFO - '--xperf_path', 14:01:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:04 INFO - 'tests': ['tp5n']}, 14:01:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:04 INFO - 'talos_options': ['--xperf_path', 14:01:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:04 INFO - 'tests': ['tp5n']}}, 14:01:04 INFO - 'talos.zip': {'path': '', 14:01:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:04 INFO - Running post-action listener: _resource_record_post_action 14:01:04 INFO - ##### 14:01:04 INFO - ##### Running create-virtualenv step. 14:01:04 INFO - ##### 14:01:04 INFO - Running pre-action listener: _resource_record_pre_action 14:01:04 INFO - Running main action method: create_virtualenv 14:01:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:04 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 14:01:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:04 INFO - Using real prefix '/usr' 14:01:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:06 INFO - Installing pip.................done. 14:01:06 INFO - Return code: 0 14:01:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:06 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:06 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 14:01:06 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 14:01:06 INFO - Using env: {'DISPLAY': ':0', 14:01:06 INFO - 'HOME': '/home/cltbld', 14:01:06 INFO - 'LANG': 'en_US.UTF-8', 14:01:06 INFO - 'LANGUAGE': 'en_US:en', 14:01:06 INFO - 'LOGNAME': 'cltbld', 14:01:06 INFO - 'MAIL': '/var/mail/cltbld', 14:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:06 INFO - 'MOZ_NO_REMOTE': '1', 14:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:06 INFO - 'NO_EM_RESTART': '1', 14:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:06 INFO - 'PWD': '/builds/slave/test', 14:01:06 INFO - 'SHELL': '/bin/bash', 14:01:06 INFO - 'SHLVL': '1', 14:01:06 INFO - 'TERM': 'linux', 14:01:06 INFO - 'TMOUT': '86400', 14:01:06 INFO - 'USER': 'cltbld', 14:01:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:06 INFO - '_': '/tools/buildbot/bin/python'} 14:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:06 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 14:01:06 INFO - Cleaning up... 14:01:06 INFO - Return code: 0 14:01:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:06 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:06 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 14:01:06 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 14:01:06 INFO - Using env: {'DISPLAY': ':0', 14:01:06 INFO - 'HOME': '/home/cltbld', 14:01:06 INFO - 'LANG': 'en_US.UTF-8', 14:01:06 INFO - 'LANGUAGE': 'en_US:en', 14:01:06 INFO - 'LOGNAME': 'cltbld', 14:01:06 INFO - 'MAIL': '/var/mail/cltbld', 14:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:06 INFO - 'MOZ_NO_REMOTE': '1', 14:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:06 INFO - 'NO_EM_RESTART': '1', 14:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:06 INFO - 'PWD': '/builds/slave/test', 14:01:06 INFO - 'SHELL': '/bin/bash', 14:01:06 INFO - 'SHLVL': '1', 14:01:06 INFO - 'TERM': 'linux', 14:01:06 INFO - 'TMOUT': '86400', 14:01:06 INFO - 'USER': 'cltbld', 14:01:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:06 INFO - '_': '/tools/buildbot/bin/python'} 14:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:07 INFO - Downloading/unpacking psutil>=0.7.1 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:09 INFO - Installing collected packages: psutil 14:01:09 INFO - Running setup.py install for psutil 14:01:09 INFO - building 'psutil._psutil_linux' extension 14:01:09 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 14:01:09 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 14:01:09 INFO - building 'psutil._psutil_posix' extension 14:01:09 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 14:01:09 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 14:01:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:09 INFO - Successfully installed psutil 14:01:09 INFO - Cleaning up... 14:01:09 INFO - Return code: 0 14:01:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:01:09 INFO - Using env: {'DISPLAY': ':0', 14:01:09 INFO - 'HOME': '/home/cltbld', 14:01:09 INFO - 'LANG': 'en_US.UTF-8', 14:01:09 INFO - 'LANGUAGE': 'en_US:en', 14:01:09 INFO - 'LOGNAME': 'cltbld', 14:01:09 INFO - 'MAIL': '/var/mail/cltbld', 14:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:09 INFO - 'MOZ_NO_REMOTE': '1', 14:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:09 INFO - 'NO_EM_RESTART': '1', 14:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:09 INFO - 'PWD': '/builds/slave/test', 14:01:09 INFO - 'SHELL': '/bin/bash', 14:01:09 INFO - 'SHLVL': '1', 14:01:09 INFO - 'TERM': 'linux', 14:01:09 INFO - 'TMOUT': '86400', 14:01:09 INFO - 'USER': 'cltbld', 14:01:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:09 INFO - '_': '/tools/buildbot/bin/python'} 14:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:11 INFO - Installing collected packages: mozsystemmonitor 14:01:11 INFO - Running setup.py install for mozsystemmonitor 14:01:11 INFO - Successfully installed mozsystemmonitor 14:01:11 INFO - Cleaning up... 14:01:11 INFO - Return code: 0 14:01:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:01:11 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')]} 14:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:11 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')]} 14:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:11 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:11 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 14:01:11 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 14:01:11 INFO - Using env: {'DISPLAY': ':0', 14:01:11 INFO - 'HOME': '/home/cltbld', 14:01:11 INFO - 'LANG': 'en_US.UTF-8', 14:01:11 INFO - 'LANGUAGE': 'en_US:en', 14:01:11 INFO - 'LOGNAME': 'cltbld', 14:01:11 INFO - 'MAIL': '/var/mail/cltbld', 14:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:11 INFO - 'MOZ_NO_REMOTE': '1', 14:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:11 INFO - 'NO_EM_RESTART': '1', 14:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:11 INFO - 'PWD': '/builds/slave/test', 14:01:11 INFO - 'SHELL': '/bin/bash', 14:01:11 INFO - 'SHLVL': '1', 14:01:11 INFO - 'TERM': 'linux', 14:01:11 INFO - 'TMOUT': '86400', 14:01:11 INFO - 'USER': 'cltbld', 14:01:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:11 INFO - '_': '/tools/buildbot/bin/python'} 14:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:01:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 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 14:01:14 INFO - Downloading docopt-0.6.1.tar.gz 14:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:14 INFO - Running setup.py install for blobuploader 14:01:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:01:14 INFO - Running setup.py install for requests 14:01:15 INFO - Running setup.py install for docopt 14:01:15 INFO - Successfully installed blobuploader requests docopt 14:01:15 INFO - Cleaning up... 14:01:15 INFO - Return code: 0 14:01:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:15 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:15 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 14:01:15 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 14:01:15 INFO - Using env: {'DISPLAY': ':0', 14:01:15 INFO - 'HOME': '/home/cltbld', 14:01:15 INFO - 'LANG': 'en_US.UTF-8', 14:01:15 INFO - 'LANGUAGE': 'en_US:en', 14:01:15 INFO - 'LOGNAME': 'cltbld', 14:01:15 INFO - 'MAIL': '/var/mail/cltbld', 14:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:15 INFO - 'MOZ_NO_REMOTE': '1', 14:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:15 INFO - 'NO_EM_RESTART': '1', 14:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:15 INFO - 'PWD': '/builds/slave/test', 14:01:15 INFO - 'SHELL': '/bin/bash', 14:01:15 INFO - 'SHLVL': '1', 14:01:15 INFO - 'TERM': 'linux', 14:01:15 INFO - 'TMOUT': '86400', 14:01:15 INFO - 'USER': 'cltbld', 14:01:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:15 INFO - '_': '/tools/buildbot/bin/python'} 14:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:15 INFO - Running setup.py (path:/tmp/pip-jwCYII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:15 INFO - Running setup.py (path:/tmp/pip-AZ59j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:15 INFO - Running setup.py (path:/tmp/pip-4GJwTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:15 INFO - Running setup.py (path:/tmp/pip-yNUv3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:15 INFO - Running setup.py (path:/tmp/pip-tLnAZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:15 INFO - Running setup.py (path:/tmp/pip-yojhFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:15 INFO - Running setup.py (path:/tmp/pip-lRdlo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:16 INFO - Running setup.py (path:/tmp/pip-JJsiXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:16 INFO - Running setup.py (path:/tmp/pip-9OaAhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:16 INFO - Running setup.py (path:/tmp/pip-HuF1ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:16 INFO - Running setup.py (path:/tmp/pip-7xze57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:16 INFO - Running setup.py (path:/tmp/pip-kdSHCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:16 INFO - Running setup.py (path:/tmp/pip-N0xVd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:16 INFO - Running setup.py (path:/tmp/pip-c1uamv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:16 INFO - Running setup.py (path:/tmp/pip-AX45Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:16 INFO - Running setup.py (path:/tmp/pip-YJlqPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:16 INFO - Running setup.py (path:/tmp/pip-PzxT3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:16 INFO - Running setup.py install for manifestparser 14:01:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:01:16 INFO - Running setup.py install for mozcrash 14:01:16 INFO - Running setup.py install for mozdebug 14:01:17 INFO - Running setup.py install for mozdevice 14:01:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Running setup.py install for mozfile 14:01:17 INFO - Running setup.py install for mozhttpd 14:01:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Running setup.py install for mozinfo 14:01:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Running setup.py install for mozInstall 14:01:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Running setup.py install for mozleak 14:01:17 INFO - Running setup.py install for mozlog 14:01:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Running setup.py install for moznetwork 14:01:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:01:17 INFO - Running setup.py install for mozprocess 14:01:18 INFO - Running setup.py install for mozprofile 14:01:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:01:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:01:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:01:18 INFO - Running setup.py install for mozrunner 14:01:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:01:18 INFO - Running setup.py install for mozscreenshot 14:01:18 INFO - Running setup.py install for moztest 14:01:18 INFO - Running setup.py install for mozversion 14:01:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:01:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:18 INFO - Cleaning up... 14:01:18 INFO - Return code: 0 14:01:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:18 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')]} 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 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')]} 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:18 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 14:01:18 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 14:01:18 INFO - Using env: {'DISPLAY': ':0', 14:01:18 INFO - 'HOME': '/home/cltbld', 14:01:18 INFO - 'LANG': 'en_US.UTF-8', 14:01:18 INFO - 'LANGUAGE': 'en_US:en', 14:01:18 INFO - 'LOGNAME': 'cltbld', 14:01:18 INFO - 'MAIL': '/var/mail/cltbld', 14:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:18 INFO - 'MOZ_NO_REMOTE': '1', 14:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:18 INFO - 'NO_EM_RESTART': '1', 14:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:18 INFO - 'PWD': '/builds/slave/test', 14:01:18 INFO - 'SHELL': '/bin/bash', 14:01:18 INFO - 'SHLVL': '1', 14:01:18 INFO - 'TERM': 'linux', 14:01:18 INFO - 'TMOUT': '86400', 14:01:18 INFO - 'USER': 'cltbld', 14:01:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:18 INFO - '_': '/tools/buildbot/bin/python'} 14:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:18 INFO - Running setup.py (path:/tmp/pip-vvTGLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:18 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)) 14:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:18 INFO - Running setup.py (path:/tmp/pip-IBah5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:18 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)) 14:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:18 INFO - Running setup.py (path:/tmp/pip-EEJTUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:18 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)) 14:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:19 INFO - Running setup.py (path:/tmp/pip-fTPPfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:19 INFO - Running setup.py (path:/tmp/pip-e_ylZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:19 INFO - Running setup.py (path:/tmp/pip-mh790R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:19 INFO - Running setup.py (path:/tmp/pip-vB8UEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:19 INFO - Running setup.py (path:/tmp/pip-aQTbMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:19 INFO - Running setup.py (path:/tmp/pip-I7MBgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:19 INFO - Running setup.py (path:/tmp/pip-aSpVpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:19 INFO - Running setup.py (path:/tmp/pip-WVJ7C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:19 INFO - Running setup.py (path:/tmp/pip-ocAeF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:19 INFO - Running setup.py (path:/tmp/pip-tImXCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:19 INFO - Running setup.py (path:/tmp/pip-MOp9KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:19 INFO - Running setup.py (path:/tmp/pip-C_wxVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:19 INFO - Running setup.py (path:/tmp/pip-v8dojB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:19 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)) 14:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:19 INFO - Running setup.py (path:/tmp/pip-z9JDOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:20 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)) 14:01:20 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)) 14:01:20 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)) 14:01:20 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)) 14:01:20 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)) 14:01:20 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)) 14:01:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 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 14:01:21 INFO - Downloading blessings-1.6.tar.gz 14:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:21 INFO - Installing collected packages: blessings 14:01:21 INFO - Running setup.py install for blessings 14:01:22 INFO - Successfully installed blessings 14:01:22 INFO - Cleaning up... 14:01:22 INFO - Return code: 0 14:01:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:22 INFO - Reading from file tmpfile_stdout 14:01:22 INFO - Current package versions: 14:01:22 INFO - argparse == 1.2.1 14:01:22 INFO - blessings == 1.6 14:01:22 INFO - blobuploader == 1.2.4 14:01:22 INFO - docopt == 0.6.1 14:01:22 INFO - manifestparser == 1.1 14:01:22 INFO - mozInstall == 1.12 14:01:22 INFO - mozcrash == 0.17 14:01:22 INFO - mozdebug == 0.1 14:01:22 INFO - mozdevice == 0.48 14:01:22 INFO - mozfile == 1.2 14:01:22 INFO - mozhttpd == 0.7 14:01:22 INFO - mozinfo == 0.9 14:01:22 INFO - mozleak == 0.1 14:01:22 INFO - mozlog == 3.1 14:01:22 INFO - moznetwork == 0.27 14:01:22 INFO - mozprocess == 0.22 14:01:22 INFO - mozprofile == 0.28 14:01:22 INFO - mozrunner == 6.11 14:01:22 INFO - mozscreenshot == 0.1 14:01:22 INFO - mozsystemmonitor == 0.0 14:01:22 INFO - moztest == 0.7 14:01:22 INFO - mozversion == 1.4 14:01:22 INFO - psutil == 3.1.1 14:01:22 INFO - requests == 1.2.3 14:01:22 INFO - wsgiref == 0.1.2 14:01:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:22 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')]} 14:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:22 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')]} 14:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:22 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:22 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 14:01:22 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 14:01:22 INFO - Using env: {'DISPLAY': ':0', 14:01:22 INFO - 'HOME': '/home/cltbld', 14:01:22 INFO - 'LANG': 'en_US.UTF-8', 14:01:22 INFO - 'LANGUAGE': 'en_US:en', 14:01:22 INFO - 'LOGNAME': 'cltbld', 14:01:22 INFO - 'MAIL': '/var/mail/cltbld', 14:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:22 INFO - 'MOZ_NO_REMOTE': '1', 14:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:22 INFO - 'NO_EM_RESTART': '1', 14:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:22 INFO - 'PWD': '/builds/slave/test', 14:01:22 INFO - 'SHELL': '/bin/bash', 14:01:22 INFO - 'SHLVL': '1', 14:01:22 INFO - 'TERM': 'linux', 14:01:22 INFO - 'TMOUT': '86400', 14:01:22 INFO - 'USER': 'cltbld', 14:01:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:22 INFO - '_': '/tools/buildbot/bin/python'} 14:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 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)) 14:01:22 INFO - Cleaning up... 14:01:22 INFO - Return code: 0 14:01:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:01:22 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')]} 14:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:22 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')]} 14:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:22 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:22 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 14:01:22 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 14:01:22 INFO - Using env: {'DISPLAY': ':0', 14:01:22 INFO - 'HOME': '/home/cltbld', 14:01:22 INFO - 'LANG': 'en_US.UTF-8', 14:01:22 INFO - 'LANGUAGE': 'en_US:en', 14:01:22 INFO - 'LOGNAME': 'cltbld', 14:01:22 INFO - 'MAIL': '/var/mail/cltbld', 14:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:22 INFO - 'MOZ_NO_REMOTE': '1', 14:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:22 INFO - 'NO_EM_RESTART': '1', 14:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:22 INFO - 'PWD': '/builds/slave/test', 14:01:22 INFO - 'SHELL': '/bin/bash', 14:01:22 INFO - 'SHLVL': '1', 14:01:22 INFO - 'TERM': 'linux', 14:01:22 INFO - 'TMOUT': '86400', 14:01:22 INFO - 'USER': 'cltbld', 14:01:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:22 INFO - '_': '/tools/buildbot/bin/python'} 14:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:22 INFO - Downloading/unpacking jsonschema 14:01:22 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 14:01:22 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 14:01:22 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 14:01:22 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 14:01:22 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 14:01:22 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 14:01:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:24 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:24 INFO - warning: no files found matching '*.txt' 14:01:24 INFO - no previously-included directories found matching 'build' 14:01:24 INFO - no previously-included directories found matching 'dist' 14:01:24 INFO - no previously-included directories found matching '.git*' 14:01:24 INFO - Installing collected packages: jsonschema, functools32 14:01:24 INFO - Running setup.py install for functools32 14:01:25 INFO - warning: no files found matching '*.txt' 14:01:25 INFO - no previously-included directories found matching 'build' 14:01:25 INFO - no previously-included directories found matching 'dist' 14:01:25 INFO - no previously-included directories found matching '.git*' 14:01:25 INFO - Successfully installed jsonschema functools32 14:01:25 INFO - Cleaning up... 14:01:25 INFO - Return code: 0 14:01:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:25 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 0x7f1d5dac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', '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 14:01:25 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 14:01:25 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 14:01:25 INFO - Using env: {'DISPLAY': ':0', 14:01:25 INFO - 'HOME': '/home/cltbld', 14:01:25 INFO - 'LANG': 'en_US.UTF-8', 14:01:25 INFO - 'LANGUAGE': 'en_US:en', 14:01:25 INFO - 'LOGNAME': 'cltbld', 14:01:25 INFO - 'MAIL': '/var/mail/cltbld', 14:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:25 INFO - 'MOZ_NO_REMOTE': '1', 14:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:25 INFO - 'NO_EM_RESTART': '1', 14:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:25 INFO - 'PWD': '/builds/slave/test', 14:01:25 INFO - 'SHELL': '/bin/bash', 14:01:25 INFO - 'SHLVL': '1', 14:01:25 INFO - 'TERM': 'linux', 14:01:25 INFO - 'TMOUT': '86400', 14:01:25 INFO - 'USER': 'cltbld', 14:01:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:25 INFO - '_': '/tools/buildbot/bin/python'} 14:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:25 INFO - Downloading/unpacking flake8 14:01:25 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 14:01:25 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 14:01:25 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 14:01:25 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 14:01:25 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 14:01:25 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 14:01:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 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 14:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:27 INFO - no previously-included directories found matching 'docs/_build' 14:01:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:27 INFO - Running setup.py install for pep8 14:01:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:28 INFO - no previously-included directories found matching 'docs/_build' 14:01:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:01:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:28 INFO - Cleaning up... 14:01:28 INFO - Return code: 0 14:01:28 INFO - Running post-action listener: _resource_record_post_action 14:01:28 INFO - Running post-action listener: _start_resource_monitoring 14:01:28 INFO - Starting resource monitoring. 14:01:28 INFO - ##### 14:01:28 INFO - ##### Running install step. 14:01:28 INFO - ##### 14:01:28 INFO - Running pre-action listener: _resource_record_pre_action 14:01:28 INFO - Running main action method: install 14:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:28 INFO - Reading from file tmpfile_stdout 14:01:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:01:28 INFO - Reading from file tmpfile_stdout 14:01:28 INFO - Output received: 14:01:28 INFO - Usage: mozinstall [options] installer 14:01:28 INFO - Options: 14:01:28 INFO - -h, --help show this help message and exit 14:01:28 INFO - -d DEST, --destination=DEST 14:01:28 INFO - Directory to install application into. [default: 14:01:28 INFO - "/builds/slave/test"] 14:01:28 INFO - --app=APP Application being installed. [default: firefox] 14:01:28 INFO - mkdir: /builds/slave/test/build/application 14:01:28 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'] 14:01:28 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 14:01:44 INFO - Reading from file tmpfile_stdout 14:01:44 INFO - Output received: 14:01:44 INFO - /builds/slave/test/build/application/firefox/firefox 14:01:44 INFO - Running post-action listener: _resource_record_post_action 14:01:44 INFO - ##### 14:01:44 INFO - ##### Running run-tests step. 14:01:44 INFO - ##### 14:01:44 INFO - Running pre-action listener: _resource_record_pre_action 14:01:44 INFO - Running main action method: run_tests 14:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:01:44 INFO - Python 2.7.3 14:01:44 INFO - Return code: 0 14:01:44 INFO - grabbing minidump binary from tooltool 14:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:44 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 0x28da410>, '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 0x28db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:01:44 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 14:01:44 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 14:01:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:44 INFO - Return code: 0 14:01:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:01:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:01:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:01:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:01:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:01:45 INFO - Return code: 0 14:01:45 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/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 14:01:45 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/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 14:01:45 INFO - Using env: {'DISPLAY': ':0', 14:01:45 INFO - 'HOME': '/home/cltbld', 14:01:45 INFO - 'LANG': 'en_US.UTF-8', 14:01:45 INFO - 'LANGUAGE': 'en_US:en', 14:01:45 INFO - 'LOGNAME': 'cltbld', 14:01:45 INFO - 'MAIL': '/var/mail/cltbld', 14:01:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:01:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:45 INFO - 'MOZ_NO_REMOTE': '1', 14:01:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:45 INFO - 'NO_EM_RESTART': '1', 14:01:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:45 INFO - 'PWD': '/builds/slave/test', 14:01:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:01:45 INFO - 'SHELL': '/bin/bash', 14:01:45 INFO - 'SHLVL': '1', 14:01:45 INFO - 'TERM': 'linux', 14:01:45 INFO - 'TMOUT': '86400', 14:01:45 INFO - 'USER': 'cltbld', 14:01:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580', 14:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:45 INFO - '_': '/tools/buildbot/bin/python'} 14:01:45 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/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 14:01:45 INFO - mozversion application_buildid: 20160426062558 14:01:45 INFO - mozversion application_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 14:01:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:01:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:45 INFO - mozversion application_name: Firefox 14:01:45 INFO - mozversion application_remotingname: firefox-dev 14:01:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:01:45 INFO - mozversion application_vendor: Mozilla 14:01:45 INFO - mozversion application_version: 48.0a2 14:01:45 INFO - mozversion platform_buildid: 20160426062558 14:01:45 INFO - mozversion platform_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 14:01:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:01:45 INFO - mozversion platform_version: 48.0a2 14:01:45 INFO - using testdate: 1461704505 14:01:45 INFO - actual date: 1461704505 14:01:45 INFO - starting webserver on 'localhost:46744' 14:01:45 INFO - SUITE-START | Running 2 tests 14:01:45 INFO - TEST-START | dromaeo_css 14:01:45 INFO - operating with platform_type : linux_ 14:01:45 INFO - Initialising browser for dromaeo_css test... 14:01:45 INFO - TEST-INFO | started process 7618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjOjWmi/profile http://localhost:46744/getInfo.html) 14:01:49 INFO - PROCESS | 7618 | 14:01:49 INFO - PROCESS | 7618 | (process:7698): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:01:50 INFO - PROCESS | 7618 | __metrics Screen width/height:1600/1200 14:01:50 INFO - PROCESS | 7618 | colorDepth:24 14:01:50 INFO - PROCESS | 7618 | Browser inner width/height: 1024/697 14:01:50 INFO - PROCESS | 7618 | __metrics 14:01:51 ERROR - PROCESS | 7618 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:01:52 INFO - TEST-INFO | 7618: exit 0 14:01:52 INFO - Browser initialized. 14:01:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:52 INFO - TEST-INFO | started process 7749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjOjWmi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:54 INFO - PROCESS | 7749 | 14:01:54 INFO - PROCESS | 7749 | (process:7815): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:02:04 INFO - PROCESS | 7749 | RSS: Main: 152657920 14:02:04 INFO - PROCESS | 7749 | 14:02:53 INFO - PROCESS | 7749 | 1461704573614 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] 14:05:00 INFO - PROCESS | 7749 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46744/tests/dromaeo/cssquery-ext.html) 14:05:01 INFO - PROCESS | 7749 | RSS: Main: 155406336 14:05:01 INFO - PROCESS | 7749 | 14:08:03 INFO - PROCESS | 7749 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-ext.html (next: http://localhost:46744/tests/dromaeo/cssquery-jquery.html) 14:08:04 INFO - PROCESS | 7749 | RSS: Main: 153751552 14:08:04 INFO - PROCESS | 7749 | 14:11:06 INFO - PROCESS | 7749 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46744/tests/dromaeo/cssquery-mootools.html) 14:11:06 INFO - PROCESS | 7749 | RSS: Main: 153382912 14:11:06 INFO - PROCESS | 7749 | 14:14:08 INFO - PROCESS | 7749 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46744/tests/dromaeo/cssquery-prototype.html) 14:14:09 INFO - PROCESS | 7749 | RSS: Main: 153153536 14:14:09 INFO - PROCESS | 7749 | 14:17:11 INFO - PROCESS | 7749 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46744/tests/dromaeo/cssquery-yui.html) 14:17:12 INFO - PROCESS | 7749 | RSS: Main: 154501120 14:17:12 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-yui.html (next: http://localhost:46744/tests/dromaeo/cssquery-dojo.html) 14:20:14 INFO - PROCESS | 7749 | RSS: Main: 155705344 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | __start_tp_report 14:20:14 INFO - PROCESS | 7749 | _x_x_mozilla_page_load 14:20:14 INFO - PROCESS | 7749 | _x_x_mozilla_page_load_details 14:20:14 INFO - PROCESS | 7749 | |i|pagename|runs| 14:20:14 INFO - PROCESS | 7749 | |0;dojo.html;3292.1769557610596;3331.6002079750433;3374.2745309758398;3403.1322012886712;3408.386490431721;5633.60564760467;5643.604947653661;5705.629134106281;5708.257926469563;5719.542436605072;5629.493345598895;5679.318481782181;5685.630434021786;5710.543156547476;5730.598858079936;5119.692818430897;5129.6409251352425;5146.588272938175;5162.380514338284;5235.476452354753;5026.748662566875;5212.5308722214995;5243.2659427680155;5254.973725131369;5270.209468579725;5104.821331253407;5144.922826157611;5145.716985565792;5163.845084647466;5164.2253661950635;5117.053345131144;5148.613853960968;5152.304438900738;5216.113260745682;5219.686818790847;4882.804687812483;5054.19132938728;5102.464241254689;5109.029284435983;5118.25785261135;5477.397486276506;5487.533559647435;5516.034693928546;5532.336119665666;5538.363088244863;6033.5474839387225;6049.48579370754;6055.031195008822;6061.151438798572;6064.666443345614;5903.26209223847;6038.516918646497;6088.391160883921;6145.955187618071;6148.016317389196;5683.715814209273;5685.886282274331;5686.601937864351;5693.516051135658;5709.543236541067;6146.293176284695;6197.411245931629;6204.968975155186;6213.347598502182;6216.502679785606;5706.600537962386;5948.791792287249;6022;6037.09443583466;6067.2112625359305;5966.731497082642;6001.099835024694;6011.458968692838;6018;6023.759049638053;5738.282714660668;5969.611975221596;5971.4327138921735;5974.253218347707;5988.880222395528;6019.6990150493175;6058.242719660043;6060.636361818305;6064.75740970365;6092.786752463642;4526.049529598756;4606.815727370935;4612.677112602086;4615.30770384445;4639.536046395401;4057.1479989202007;4064.1871625674985;4129.607687269705;4134.049168691218;4156.56356082613;5527.53015993645;5592.664440133523;5660.009498337775;5670.8015219467125;5687.630304030225;5995.280566332068;6058.515318774487;6059.21230240066;6092;6094.634321940698;5542.695151766611;5611.466910643482;5659.236003139606;5687.744051517691;5692.430756924357;5148.433672296044;5168.870778230499;5180.4560521145495;5196.558292545176;5219.869503262449;6069.848253793602;6081.239845019372;6105.511559075263;6113.32753397126;6116.449519543263;5884.735186916685;6042.969785151046;6043.123747056564;6076.939230607814;6137.806028951221;6112.777056696867;6119.28775993027;6130.233720784902;6139.216166136355;6148.1699970503405;5944.821655350346;5952.434518720715;5966;5970.910436343372;5989.610675306091;5815.127730840408;6033.155358249936;6060.90908636362;6119.051547010221;6136.907946380718;5880.852978675567;5937.554683398849;5965.761369545169;5983.341832398346;5986.6707331097205;5908.527317814651;5927.9703601481715;5948.345681975065;5965.985782416913;5966.970165149147;5719.599628025998;5807.680577568274;5875.059990401515;5876.6180198286975;5902.527797776082;5952.642841429528;5969.134475500941;5977.432143946492;6011.098335249572;6024.66864322449;5596.1605759136455;5867.471927526543;5873.970630146822;5886.969780288518;5909.23179986599 14:20:14 INFO - PROCESS | 7749 | |1;ext.html;645.3965542218026;657.5594351784304;671.5299290496652;719.5502810743285;724.9818754531134;41886.58113418865;43633.34549981753;43739.78130109349;43759.78120109403;43886.561134388685;43650.78174609131;44413;44431.333529997;44432.111357772825;44506;8942.374033817636;9067.229285510739;9116.453012819218;9149.954250228773;9163.633454661805;8667.739967800977;8848.867266990968;8857.468551886876;9032.729018129434;9043.366964312501;9024.278057755397;9053.547322633875;9054.094590540926;9100.08999100088;9103.95448022759;9019.188273055457;9020.413673111227;9060.7281781546;9073.59168837404;9074.909250907473;9144.634214631407;9195.356325057248;9228.03105673908;9255.305852061056;9269.073092690744;45568;46084.308735369;46092;46111.30833037507;46158.76920615409;3154.1799132225556;3814.90462738431;4065.3495440729343;4440.733555986619;4465;30385.392292154032;31141.8442907784;31453;31640.525392119136;31838.840805796055;4169.624733773944;4180.067510380464;4209.326507758775;4259.215267054683;4290.313549832012;237005;238443;238727;239804;240865;39763.204735905696;40680.79659601683;40680.79659601683;40712;40855;41455;63042.68478657577;64906.35093649098;65163.674181629736;65647.34352656508;18890.716639250422;19266.71099933502;19335.8066419334;19336.613267734567;19372.903135484514;14570.708585828224;14764.335604897806;14779.408823647149;14826.777598336033;14835.184064876536;20742;21184.894075529523;21226.575468490544;21287.68068478974;21298.25456109029;7620.618969051525;7734.806629834299;7864.4888082274465;7871.291583757489;7907.762767116996;1137.3573930729112;1166.7141550320057;1170.6694454277567;1175.3359351966112;1239.423667994387;33602;34432;34517.137071572906;34759;35015.299694005975;1116.849225354583;1141.960031398897;1189.4409627475072;1192.66605350502;1206.6681662542871;16387.34450621962;17329.133543322783;17477.421240630454;17495.30018799259;17580.38468653591;353123;355892;356023;356650;565855;58994.70502647545;59891;60027.39972600218;60305.39694602998;60507.09239361413;1448.66680663448;1504.127605988524;1509.8490150984815;1514.4926449639495;1524.6264665157107;34448;34924.825375872955;35325;35446.29107417889;35699;56918.43081569131;57248;57563;57690.711546442;57805.710971446555;490748;491915;492142;492549;494522;31389.52915706312;31521.369572608877;31688.683113169496;31806.04581862548;31934.84032579822;51889;52294.21558676699;53077;53715.46284537261;54646.453535464134;44746.77626611846;45252.77373613111;45395.773021134686;46281.305780412644;47083.52916470928;43075.56924430715;43670.781646091564;43802;44355.77822110869;45581.54418455773;43840.342394863466;44147.337789933816;45456.772716136205;45563;45600;37614;38379.42430863595;39098;39470.40794388029;39883.60116398799;29468.55797163087;29593.408131837674;30026.24934376658;30140.698593014666;30333.696663033086 14:20:14 INFO - PROCESS | 7749 | |2;jquery.html;412.55238066697615;418.5814185814186;420.1554874701848;421.1660911395437;421.8354841611771;18484.630307393843;19135.617287654237;19174.90412547937;19652.213911443527;20779.376618701426;12836.550720724776;13119;13394.12938159019;13510.797338039938;13517.526886558973;5321.36143662761;5429.321334833156;5573.498385145336;5604.915926261109;5610.382857885629;5436.130219164935;5463.071277882769;5498.065328894098;5498.202760599711;5502.367227768817;5316;5479.4520547945285;5481.643693159932;5485.753141108639;5487.890242195153;5438.912217556504;5480;5537.390887002447;5551.72241387931;5560.2493663355735;5187.170052791535;5329.467053294639;5345.224942383333;5399.514043736082;5414.214938833847;14611;14651.194184319858;14823.851761482356;14877.553673389815;21493.892530537403;2454.189623793986;2458.2379462366544;2496.8252222344445;2512.246326102162;2549.6557964674903;10656.360618362845;11038.282511636718;11205.66383008511;11289.435528223637;11306;2071.2647010311275;2104.3476522278143;2123.2674727219087;2171.1966572368324;2177.8148857347146;64234.67882660603;75884.62057689676;80930.59534702289;83770.58114709388;86257.56871215666;11217.383043932661;11493.655190344136;11535.480903359201;11662.300261984308;11746.353950532803;16578.83421165773;16595.419160329573;16691.66616667684;16692.24884880183;16695.91652041732;8837.690680826141;8882.06738292483;8946.910530894738;8983.505907175168;9056.098219374006;8803.955980220058;8930.553472326357;8939.374243803002;8946.418482798597;8948.507832069168;5053.494650534917;5057.912548802025;5178.741062946838;5244.318238628954;5300.469953004668;2093.979060209409;2097.842661800371;2110.4196346004974;2124.033564728045;2146.903389347483;963.4749061761357;1034.095166729112;1040.178259175243;1083.344576531203;1097.6926460590887;18845.24619015224;19783.40649780509;19886;19988;20580.27969021077;998.8551660009258;1061.1881910338598;1063.6543123484898;1084.8643919510062;1175.1715040896147;11277;11326.377049262204;11436.256643318324;11518.94240528792;11537.653870383901;515112;519639;522488;530262;533271;100503.49748251212;101607.49196254119;104581.47709261558;104879.4756026215;105477;1131.3155540897637;1133.7732453509166;1155.5493357590547;1161.5469966712988;1178.9174757767046;17882.821171788117;18123.637527249644;18338.17478213457;18488.630227395646;18488.72266916024;40196.799016004734;40716.79641601773;42881.35677964895;43017.569824302605;43076;54266.728666356415;54668.72665636647;60363.698181508815;62340;63023.6848815753;7918.762437126896;11837.993770529602;12844.293563853704;13664.590062298146;13945.302734863013;14511.927440363153;14613.85386146125;14729.92635036818;14956;14994.850051499345;12825.422855971317;13041.087123901236;13284.468621255428;13348.93325533405;13386.995975302087;12815.487380504675;12948.676283092998;13274.070815042855;13278.53525126616;13338.399772010089;13269.33653317311;13360;13578.524751633646;13594.320283985564;13632.113912595649;13548.458061677422;13602.25187614651;13654.385552649956;13690.110142840684;13746;13071.411786469442;13146.342682865627;13173.736525269633;13255.867441325463;13430.39563219677 14:20:14 INFO - PROCESS | 7749 | |3;mootools.html;1509.381153726972;1546.327347603792;1638.7463590353375;1759.4985429152694;1775.9965619425025;6997.475189360805;7388.335049845513;7646.579438130901;7700.1914798946145;7702.268284512962;6937;7651.579163146039;7751.728689495869;7773.067231932176;7779.572123533203;2302.838801283915;2312.364099872532;2319;2322.7212734471887;2334.9416264593438;2290.8625482471107;2304.089884495623;2312.1213938703268;2325.802306803915;2326.7789559991775;2250.5723912456665;2275.9886200568976;2276.897539610713;2277.2485079923586;2296.2307626944994;2255.1881322723807;2261.604219261639;2276.9089236430523;2278.601244782165;2279.9316020519245;2210.292706333974;2215.6898034275214;2217.2018073493527;2218.1792736687366;2218.73375194976;7886.566238856861;7901.762947111596;7919.7228097016905;7924.603769811486;7962.004749406325;4857.878553036167;4913.238448040559;4972.7513624319;5014.598832093424;5040.420351659533;3169.9366012679616;3237.287796684749;3303.8678452861855;3369.0566641340465;3390.2880395117054;1107.7119948813368;1138.1293310617384;1170.093177787213;1180.2151569206467;1188.8038473651836;10553.73615659607;10620.097291730212;10651.360918344924;10660.20048496366;10682.999999999922;4182.790860456965;4254.744715317091;4339;4343.826246950087;4371.737695738266;8945.73162805117;8982.371234013686;9015.188633023059;9021.278297736166;9041.547922603975;4908.607311415079;4942.505749425029;4946.3817022872145;4964.255361695775;4965.0566392385335;4033.6369726724147;4426.15902978433;4467.687261891637;4483.910321793546;4519.751413672214;3732.458793474931;3745.4756334113245;3848.730588858753;3858.3633700439673;3874.9806250968563;1203.6810245285008;1209.407390378708;1216.6654170103116;1219.6889793102703;1222.1261797814605;971.3346357744967;1067.8344856547249;1070.3577853287966;1087.923845330835;1102.2009043443438;5750.4249575042995;5829;5843.824685259449;5925.40745925404;6024.789132380433;432.77928256589365;436.7947064879502;437.7198592900546;437.8949052227442;439.68123110744455;4173.937390939138;4177.4569305990635;4187.392828039917;4219.303814870574;4237.427947227146;9056.184943354998;9405.200557952514;9413.811723765486;9431.811363772824;9476.715698529055;9217.262618990464;9316.627334906663;9322;9330.440173589606;9348.57931393089;7050.0482434871665;7149.320814522612;7155.105611798525;7177.820554486179;7215.098112735908;5864.208331875313;5909.054551271776;5913.319968203712;6041.365656605993;6053.576249662481;8307.543085130375;8524;8789.648414063622;8800.955995219983;8820.11798820113;8666.306695464475;8855.070217627057;8893.599788009426;8929.955350223207;8949;6461.160049193575;6809.182898052265;6896.896546551906;6952.235254121942;7190.96404517974;7554.093508778982;7577.583232922242;7596.164421913474;7622.69509219625;7642.273983971514;6827.761028363983;7099.716011359487;7106.609136497542;7181;7210.315020073084;6674.866502670016;6686.5653732507235;6730.562513436611;6775.119234499681;6807.217170025312;6362.300146983735;6398.0402939559435;6401.64790936503;6410.45511131559;6473.449756770728;5076.517730815566;5125;5187.351581052369;5190.584753219658;5219.08665983459;4967.230079337708;5100.821471248489;5160.561352285098;5177.068127737043;5215.791368345223 14:20:14 INFO - PROCESS | 7749 | |4;prototype.html;334.0912717408649;340.12757277583;347.24127780798955;350.1002423770908;352.60156023693224;5618.4943355098085;5633.126865335875;5706.3437704663975;5710.71446427678;5733.483986441224;5593.552515798737;5599.804006859761;5602.982926146584;5622.746976386063;5634.830955071344;4227.976996447539;4412.404325416068;4412.624926881203;4447.35513350564;4461.709988850731;4280.678949078816;4410.933835992462;4424.225760491917;4426.871147857292;4437.866863994085;4350.195213885426;4398.560143985608;4401.735895846259;4404.11917616478;4411.757353345564;4306.7631280279575;4393.516713161565;4415.3376993451075;4419.895026243439;4422.911541769179;3890.8832735017713;3902.6682731967817;3909.218156368709;3918.7648741075627;3918.766303207173;5446.836594902159;5466.207399926989;5468.781248750045;5478.698671573062;5492.615516913817;4972.95567930735;5068.781323859376;5083;5084.262781896604;5089.51649593288;5869.677167755772;5883.8529036774;5934.317553481362;5935.406459354073;5943.898709890205;4270.274053410928;4274.871753847358;4296.677749168824;4313.698041137121;4316.395704601358;5961.374055724174;6177.25872895251;6179.5056395488255;6200.0699895016105;6223.719932603044;4403.779811009501;4405.823767049346;4423.823047078081;4434.800433980478;4440.933385999213;4474;4487.887802804956;4497.302918047708;4511.1654343946475;4518.638508919278;4943.530364615356;5065.974670126626;5102.540771330524;5139.100657384943;5141.331626888481;5913.674747888821;5933.406659334119;5988.580799344004;6008;6021.46452654579;1608.9195540222943;1620.1332287226512;1622.594351412147;1627.1294857251314;1629.0225864481217;1065.760203954104;1097.5006372100675;1109.7114750165015;1119.4067144413473;1123.5730422439422;5536;5769;5777.046787280052;5793.188953546507;6048.153258543807;6194.38056194377;6226.501879849601;6235.127082208494;6245.219347581552;6281.309056003836;5544.390117087117;5723.799667011718;5736.848681744346;5747.540196784247;5749.626274292157;3517.085557755002;3521.436570148815;3522.9295414091575;3524.4537096750046;3545;6518.57629254097;6657.966710166418;6689.364510371507;6693.297203793629;6703.3296670332575;6763.5941843489545;6771.593704377753;6785.457163426914;6799.150106236721;6815.931840681629;6620.602763834186;6647.767328143492;6659.067730517731;6670.666466676744;6747.122874026345;6399.392057754506;6583.868322633425;6654.866902661823;6655.633940133339;6666.699998499982;6548.607083575001;6560.179977502812;6570.145881035435;6582.3746744059235;6593.538452308484;6503.764284785875;6653.168353955755;6666.600003999775;6687.164104486939;6700.430463410665;4461.241588929955;4479.664025198188;4479.888002799956;4510.706804057726;4524.52952790351;6547.639879806657;6588;6616.139901812733;6617.94112941927;6668.199816021915;6412.1343618612755;6421.165248517663;6437.517186210959;6445.967770161119;6452.386903274181;6422.839429014312;6427.618062116668;6430.871382572229;6431.421172094347;6433.967830160819;5783.132530120347;6087.178230938766;6290.685465726787;6326.272478665012;6337.936620633919;6075.149479072845;6083.9695801522475;6088.26940767093;6092.421219984094;6113.510919126548;5851.64890106595;5884.882302354014;5897.587168898308;5901.557383196192;5966.463018328372 14:20:14 INFO - PROCESS | 7749 | |5;yui.html;823.4359463767316;852.799592095857;858.8754630578567;903.5121034641294;911.3483859040784;13176.275304858229;13529.661758456043;13543.59369218925;13571.185728856275;13604.795928061087;11966.162368634199;13490.190588564694;13543.187408755482;13596.980226483003;13617.523386681469;881.8324518341527;897.2059727141461;897.7396554999042;899.7075950316141;900.6442455230181;910.644848509082;911.5168960450972;913.7578541686458;916.1113719691922;919.1360121485782;945.4988855906381;945.6642891773424;947.900470450603;948.4688574398325;952.200151872427;927.3369540778342;929.159111004542;931.4969916245219;933.6918816790443;942.3874481586989;685.7942617214866;686.9381755642016;687.2337343861608;690.3441730356132;690.3855568544;13793.862061379357;14351.067180633225;14410.567682969528;14418.783718244234;14474;14844.33200505969;14849.331780069922;14856.18290993995;14971.775423368657;14993.625159370993;11600;11617.244879082917;11731.296122232694;11805.763884722257;11954.521819127225;3978.1844721832244;3999.7400168988925;4019.4774679291795;4079.9184016319805;4171.687123465722;50047;51641;51884.22173667398;52419.47580524184;56085;11456.198066135457;11683.824742628867;11744.70638234051;11903.34531600753;11930.164888457724;19588.70616940747;19607;19650.70523942142;19698;19698.212071517264;8570.314374849997;8582.184692454206;8604.225619694258;8715.869261961076;8938.553072346356;4816.879578010507;4841.830535931225;4861.95138048615;4915.115279249698;4923.310736496894;3519.665631764978;3562.928741425157;3577.5170352002147;3583.964160358363;3602.85588576454;656.4289068510332;658.5357323087212;664.1896885799317;669.146837781832;674.4638012779852;652.7813182583888;728.4245446097524;749.8500299940034;788.9763307100797;794.6860989908954;9553.61785528585;9661.13049825519;9709.271804614682;9717.9028209717;9905.306628536078;697.5988806436319;793.2028311546974;805.7461899501639;816.7427260412951;832.1886160993105;4132.834686612502;4516.345129956138;4520.299353600197;4590.609798167193;4604.746738929391;65041;66415.66792166009;67147;68505.3149468509;68604;58443.70778146167;58511.70744146252;58811;59077.70461147753;59463;52918;53565.732171339674;53824.46175538195;53871.73064134654;54017.729911350194;8537.274331681876;8556.57217139128;8601.82796344082;8654.394192406471;8656.437331573428;33947.15132121618;34225.48661770125;34441.655583444845;34582.481262781585;34761.65238347584;45555;47713.76143119262;47847;47992.28011579759;48350;11285.661430157108;11583.07335413148;12207.38963051826;12360.75278494407;12578.55975040869;13300.201987880759;13340.533081342106;13398;13530.526431574848;13598.252096134807;12670.936645317082;13299;13316.134451260637;13343.199408035549;13594.388252528857;12530.122891397516;12663;12669.93665031669;12849.100562960502;12911.483540658268;12644;12771;12838.229706217657;13029.609111726664;13052.54316098932;11022.944885275523;11069.778604427705;11134.777304454028;11150.832737508781;11228.045616122394;10969.561217551209;10971.615993440191;11274.267172633752;11316.9434152832;11338.659840204808 14:20:14 INFO - PROCESS | 7749 | __end_tp_report 14:20:14 INFO - PROCESS | 7749 | __start_cc_report 14:20:14 INFO - PROCESS | 7749 | _x_x_mozilla_cycle_collect,320 14:20:14 INFO - PROCESS | 7749 | __end_cc_report 14:20:14 INFO - PROCESS | 7749 | __startTimestamp1461705614601__endTimestamp 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | ------- Summary: start ------- 14:20:14 INFO - PROCESS | 7749 | Number of tests: 6 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | [#0] dojo.html Cycles:165 Average:5604.49 Median:5873.97 stddev:623.05 (10.6%) stddev-sans-first:597.98 14:20:14 INFO - PROCESS | 7749 | Values: 3292.2 3331.6 3374.3 3403.1 3408.4 5633.6 5643.6 5705.6 5708.3 5719.5 5629.5 5679.3 5685.6 5710.5 5730.6 5119.7 5129.6 5146.6 5162.4 5235.5 5026.7 5212.5 5243.3 5255.0 5270.2 5104.8 5144.9 5145.7 5163.8 5164.2 5117.1 5148.6 5152.3 5216.1 5219.7 4882.8 5054.2 5102.5 5109.0 5118.3 5477.4 5487.5 5516.0 5532.3 5538.4 6033.5 6049.5 6055.0 6061.2 6064.7 5903.3 6038.5 6088.4 6146.0 6148.0 5683.7 5685.9 5686.6 5693.5 5709.5 6146.3 6197.4 6205.0 6213.3 6216.5 5706.6 5948.8 6022.0 6037.1 6067.2 5966.7 6001.1 6011.5 6018.0 6023.8 5738.3 5969.6 5971.4 5974.3 5988.9 6019.7 6058.2 6060.6 6064.8 6092.8 4526.0 4606.8 4612.7 4615.3 4639.5 4057.1 4064.2 4129.6 4134.0 4156.6 5527.5 5592.7 5660.0 5670.8 5687.6 5995.3 6058.5 6059.2 6092.0 6094.6 5542.7 5611.5 5659.2 5687.7 5692.4 5148.4 5168.9 5180.5 5196.6 5219.9 6069.8 6081.2 6105.5 6113.3 6116.4 5884.7 6043.0 6043.1 6076.9 6137.8 6112.8 6119.3 6130.2 6139.2 6148.2 5944.8 5952.4 5966.0 5970.9 5989.6 5815.1 6033.2 6060.9 6119.1 6136.9 5880.9 5937.6 5965.8 5983.3 5986.7 5908.5 5928.0 5948.3 5966.0 5967.0 5719.6 5807.7 5875.1 5876.6 5902.5 5952.6 5969.1 5977.4 6011.1 6024.7 5596.2 5867.5 5874.0 5887.0 5909.2 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | [#1] ext.html Cycles:180 Average:55778.82 Median:43642.06 stddev:104154.82 (238.7%) stddev-sans-first:104364.75 14:20:14 INFO - PROCESS | 7749 | Values: 645.4 657.6 671.5 719.6 725.0 41886.6 43633.3 43739.8 43759.8 43886.6 43650.8 44413.0 44431.3 44432.1 44506.0 8942.4 9067.2 9116.5 9150.0 9163.6 8667.7 8848.9 8857.5 9032.7 9043.4 9024.3 9053.5 9054.1 9100.1 9104.0 9019.2 9020.4 9060.7 9073.6 9074.9 9144.6 9195.4 9228.0 9255.3 9269.1 45568.0 46084.3 46092.0 46111.3 46158.8 3154.2 3814.9 4065.3 4440.7 4465.0 30385.4 31141.8 31453.0 31640.5 31838.8 4169.6 4180.1 4209.3 4259.2 4290.3 237005.0 238443.0 238727.0 239804.0 240865.0 39763.2 40680.8 40680.8 40712.0 40855.0 41455.0 63042.7 64906.4 65163.7 65647.3 18890.7 19266.7 19335.8 19336.6 19372.9 14570.7 14764.3 14779.4 14826.8 14835.2 20742.0 21184.9 21226.6 21287.7 21298.3 7620.6 7734.8 7864.5 7871.3 7907.8 1137.4 1166.7 1170.7 1175.3 1239.4 33602.0 34432.0 34517.1 34759.0 35015.3 1116.8 1142.0 1189.4 1192.7 1206.7 16387.3 17329.1 17477.4 17495.3 17580.4 353123.0 355892.0 356023.0 356650.0 565855.0 58994.7 59891.0 60027.4 60305.4 60507.1 1448.7 1504.1 1509.8 1514.5 1524.6 34448.0 34924.8 35325.0 35446.3 35699.0 56918.4 57248.0 57563.0 57690.7 57805.7 490748.0 491915.0 492142.0 492549.0 494522.0 31389.5 31521.4 31688.7 31806.0 31934.8 51889.0 52294.2 53077.0 53715.5 54646.5 44746.8 45252.8 45395.8 46281.3 47083.5 43075.6 43670.8 43802.0 44355.8 45581.5 43840.3 44147.3 45456.8 45563.0 45600.0 37614.0 38379.4 39098.0 39470.4 39883.6 29468.6 29593.4 30026.2 30140.7 30333.7 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | [#2] jquery.html Cycles:180 Average:30513.46 Median:19717.81 stddev:86394.85 (438.2%) stddev-sans-first:86607.65 14:20:14 INFO - PROCESS | 7749 | Values: 412.6 418.6 420.2 421.2 421.8 18484.6 19135.6 19174.9 19652.2 20779.4 12836.6 13119.0 13394.1 13510.8 13517.5 5321.4 5429.3 5573.5 5604.9 5610.4 5436.1 5463.1 5498.1 5498.2 5502.4 5316.0 5479.5 5481.6 5485.8 5487.9 5438.9 5480.0 5537.4 5551.7 5560.2 5187.2 5329.5 5345.2 5399.5 5414.2 14611.0 14651.2 14823.9 14877.6 21493.9 2454.2 2458.2 2496.8 2512.2 2549.7 10656.4 11038.3 11205.7 11289.4 11306.0 2071.3 2104.3 2123.3 2171.2 2177.8 64234.7 75884.6 80930.6 83770.6 86257.6 11217.4 11493.7 11535.5 11662.3 11746.4 16578.8 16595.4 16691.7 16692.2 16695.9 8837.7 8882.1 8946.9 8983.5 9056.1 8804.0 8930.6 8939.4 8946.4 8948.5 5053.5 5057.9 5178.7 5244.3 5300.5 2094.0 2097.8 2110.4 2124.0 2146.9 963.5 1034.1 1040.2 1083.3 1097.7 18845.2 19783.4 19886.0 19988.0 20580.3 998.9 1061.2 1063.7 1084.9 1175.2 11277.0 11326.4 11436.3 11518.9 11537.7 515112.0 519639.0 522488.0 530262.0 533271.0 100503.5 101607.5 104581.5 104879.5 105477.0 1131.3 1133.8 1155.5 1161.5 1178.9 17882.8 18123.6 18338.2 18488.6 18488.7 40196.8 40716.8 42881.4 43017.6 43076.0 54266.7 54668.7 60363.7 62340.0 63023.7 7918.8 11838.0 12844.3 13664.6 13945.3 14511.9 14613.9 14729.9 14956.0 14994.9 12825.4 13041.1 13284.5 13348.9 13387.0 12815.5 12948.7 13274.1 13278.5 13338.4 13269.3 13360.0 13578.5 13594.3 13632.1 13548.5 13602.3 13654.4 13690.1 13746.0 13071.4 13146.3 13173.7 13255.9 13430.4 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | [#3] mootools.html Cycles:180 Average:5265.17 Median:5088.67 stddev:2787.71 (54.8%) stddev-sans-first:2781.24 14:20:14 INFO - PROCESS | 7749 | Values: 1509.4 1546.3 1638.7 1759.5 1776.0 6997.5 7388.3 7646.6 7700.2 7702.3 6937.0 7651.6 7751.7 7773.1 7779.6 2302.8 2312.4 2319.0 2322.7 2334.9 2290.9 2304.1 2312.1 2325.8 2326.8 2250.6 2276.0 2276.9 2277.2 2296.2 2255.2 2261.6 2276.9 2278.6 2279.9 2210.3 2215.7 2217.2 2218.2 2218.7 7886.6 7901.8 7919.7 7924.6 7962.0 4857.9 4913.2 4972.8 5014.6 5040.4 3169.9 3237.3 3303.9 3369.1 3390.3 1107.7 1138.1 1170.1 1180.2 1188.8 10553.7 10620.1 10651.4 10660.2 10683.0 4182.8 4254.7 4339.0 4343.8 4371.7 8945.7 8982.4 9015.2 9021.3 9041.5 4908.6 4942.5 4946.4 4964.3 4965.1 4033.6 4426.2 4467.7 4483.9 4519.8 3732.5 3745.5 3848.7 3858.4 3875.0 1203.7 1209.4 1216.7 1219.7 1222.1 971.3 1067.8 1070.4 1087.9 1102.2 5750.4 5829.0 5843.8 5925.4 6024.8 432.8 436.8 437.7 437.9 439.7 4173.9 4177.5 4187.4 4219.3 4237.4 9056.2 9405.2 9413.8 9431.8 9476.7 9217.3 9316.6 9322.0 9330.4 9348.6 7050.0 7149.3 7155.1 7177.8 7215.1 5864.2 5909.1 5913.3 6041.4 6053.6 8307.5 8524.0 8789.6 8801.0 8820.1 8666.3 8855.1 8893.6 8930.0 8949.0 6461.2 6809.2 6896.9 6952.2 7191.0 7554.1 7577.6 7596.2 7622.7 7642.3 6827.8 7099.7 7106.6 7181.0 7210.3 6674.9 6686.6 6730.6 6775.1 6807.2 6362.3 6398.0 6401.6 6410.5 6473.4 5076.5 5125.0 5187.4 5190.6 5219.1 4967.2 5100.8 5160.6 5177.1 5215.8 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | [#4] prototype.html Cycles:180 Average:5166.11 Median:5717.26 stddev:1557.55 (27.2%) stddev-sans-first:1519.11 14:20:14 INFO - PROCESS | 7749 | Values: 334.1 340.1 347.2 350.1 352.6 5618.5 5633.1 5706.3 5710.7 5733.5 5593.6 5599.8 5603.0 5622.7 5634.8 4228.0 4412.4 4412.6 4447.4 4461.7 4280.7 4410.9 4424.2 4426.9 4437.9 4350.2 4398.6 4401.7 4404.1 4411.8 4306.8 4393.5 4415.3 4419.9 4422.9 3890.9 3902.7 3909.2 3918.8 3918.8 5446.8 5466.2 5468.8 5478.7 5492.6 4973.0 5068.8 5083.0 5084.3 5089.5 5869.7 5883.9 5934.3 5935.4 5943.9 4270.3 4274.9 4296.7 4313.7 4316.4 5961.4 6177.3 6179.5 6200.1 6223.7 4403.8 4405.8 4423.8 4434.8 4440.9 4474.0 4487.9 4497.3 4511.2 4518.6 4943.5 5066.0 5102.5 5139.1 5141.3 5913.7 5933.4 5988.6 6008.0 6021.5 1608.9 1620.1 1622.6 1627.1 1629.0 1065.8 1097.5 1109.7 1119.4 1123.6 5536.0 5769.0 5777.0 5793.2 6048.2 6194.4 6226.5 6235.1 6245.2 6281.3 5544.4 5723.8 5736.8 5747.5 5749.6 3517.1 3521.4 3522.9 3524.5 3545.0 6518.6 6658.0 6689.4 6693.3 6703.3 6763.6 6771.6 6785.5 6799.2 6815.9 6620.6 6647.8 6659.1 6670.7 6747.1 6399.4 6583.9 6654.9 6655.6 6666.7 6548.6 6560.2 6570.1 6582.4 6593.5 6503.8 6653.2 6666.6 6687.2 6700.4 4461.2 4479.7 4479.9 4510.7 4524.5 6547.6 6588.0 6616.1 6617.9 6668.2 6412.1 6421.2 6437.5 6446.0 6452.4 6422.8 6427.6 6430.9 6431.4 6434.0 5783.1 6087.2 6290.7 6326.3 6337.9 6075.1 6084.0 6088.3 6092.4 6113.5 5851.6 5884.9 5897.6 5901.6 5966.5 14:20:14 INFO - PROCESS | 7749 | 14:20:14 INFO - PROCESS | 7749 | [#5] yui.html Cycles:180 Average:15304.65 Median:26159.25 stddev:17888.18 (68.4%) stddev-sans-first:17905.31 14:20:14 INFO - PROCESS | 7749 | Values: 823.4 852.8 858.9 903.5 911.3 13176.3 13529.7 13543.6 13571.2 13604.8 11966.2 13490.2 13543.2 13597.0 13617.5 881.8 897.2 897.7 899.7 900.6 910.6 911.5 913.8 916.1 919.1 945.5 945.7 947.9 948.5 952.2 927.3 929.2 931.5 933.7 942.4 685.8 686.9 687.2 690.3 690.4 13793.9 14351.1 14410.6 14418.8 14474.0 14844.3 14849.3 14856.2 14971.8 14993.6 11600.0 11617.2 11731.3 11805.8 11954.5 3978.2 3999.7 4019.5 4079.9 4171.7 50047.0 51641.0 51884.2 52419.5 56085.0 11456.2 11683.8 11744.7 11903.3 11930.2 19588.7 19607.0 19650.7 19698.0 19698.2 8570.3 8582.2 8604.2 8715.9 8938.6 4816.9 4841.8 4862.0 4915.1 4923.3 3519.7 3562.9 3577.5 3584.0 3602.9 656.4 658.5 664.2 669.1 674.5 652.8 728.4 749.9 789.0 794.7 9553.6 9661.1 9709.3 9717.9 9905.3 697.6 793.2 805.7 816.7 832.2 4132.8 4516.3 4520.3 4590.6 4604.7 65041.0 66415.7 67147.0 68505.3 68604.0 58443.7 58511.7 58811.0 59077.7 59463.0 52918.0 53565.7 53824.5 53871.7 54017.7 8537.3 8556.6 8601.8 8654.4 8656.4 33947.2 34225.5 34441.7 34582.5 34761.7 45555.0 47713.8 47847.0 47992.3 48350.0 11285.7 11583.1 12207.4 12360.8 12578.6 13300.2 13340.5 13398.0 13530.5 13598.3 12670.9 13299.0 13316.1 13343.2 13594.4 12530.1 12663.0 12669.9 12849.1 12911.5 12644.0 12771.0 12838.2 13029.6 13052.5 11022.9 11069.8 11134.8 11150.8 11228.0 10969.6 10971.6 11274.3 11316.9 11338.7 14:20:14 INFO - PROCESS | 7749 | -------- Summary: end -------- 14:20:14 INFO - PROCESS | 7749 | 14:20:15 INFO - TEST-INFO | 7749: exit 0 14:20:15 INFO - TEST-OK | dromaeo_css | took 1110064ms 14:20:15 INFO - TEST-START | kraken 14:20:15 INFO - operating with platform_type : linux_ 14:20:15 INFO - Initialising browser for kraken test... 14:20:15 INFO - TEST-INFO | started process 7991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_9Vne/profile http://localhost:46744/getInfo.html) 14:20:19 INFO - PROCESS | 7991 | 14:20:19 INFO - PROCESS | 7991 | (process:8065): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:20:20 INFO - PROCESS | 7991 | __metrics Screen width/height:1600/1200 14:20:20 INFO - PROCESS | 7991 | colorDepth:24 14:20:20 INFO - PROCESS | 7991 | Browser inner width/height: 1024/697 14:20:20 INFO - PROCESS | 7991 | __metrics 14:20:21 ERROR - PROCESS | 7991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:20:22 INFO - TEST-INFO | 7991: exit 0 14:20:22 INFO - Browser initialized. 14:20:22 INFO - Running cycle 1/1 for kraken test... 14:20:22 INFO - TEST-INFO | started process 8116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_9Vne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:24 INFO - PROCESS | 8116 | 14:20:24 INFO - PROCESS | 8116 | (process:8187): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:20:34 INFO - PROCESS | 8116 | RSS: Main: 152125440 14:20:34 INFO - PROCESS | 8116 | 14:20:36 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:37 INFO - PROCESS | 8116 | RSS: Main: 156762112 14:20:37 INFO - PROCESS | 8116 | 14:20:40 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-dft) 14:20:40 INFO - PROCESS | 8116 | RSS: Main: 156684288 14:20:40 INFO - PROCESS | 8116 | 14:20:43 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-fft) 14:20:44 INFO - PROCESS | 8116 | RSS: Main: 156962816 14:20:44 INFO - PROCESS | 8116 | 14:20:46 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-oscillator) 14:20:46 INFO - PROCESS | 8116 | RSS: Main: 157495296 14:20:46 INFO - PROCESS | 8116 | 14:20:49 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:49 INFO - PROCESS | 8116 | RSS: Main: 156856320 14:20:49 INFO - PROCESS | 8116 | 14:20:52 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46744/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:53 INFO - PROCESS | 8116 | RSS: Main: 157503488 14:20:53 INFO - PROCESS | 8116 | 14:20:56 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46744/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:57 INFO - PROCESS | 8116 | RSS: Main: 157609984 14:20:57 INFO - PROCESS | 8116 | 14:21:00 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46744/tests/kraken/driver.html?testName=json-parse-financial) 14:21:00 INFO - PROCESS | 8116 | RSS: Main: 157626368 14:21:00 INFO - PROCESS | 8116 | 14:21:02 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:03 INFO - PROCESS | 8116 | RSS: Main: 157175808 14:21:03 INFO - PROCESS | 8116 | 14:21:04 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:05 INFO - PROCESS | 8116 | RSS: Main: 157863936 14:21:05 INFO - PROCESS | 8116 | 14:21:07 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:08 INFO - PROCESS | 8116 | RSS: Main: 157765632 14:21:08 INFO - PROCESS | 8116 | 14:21:10 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:11 INFO - PROCESS | 8116 | RSS: Main: 158097408 14:21:11 INFO - PROCESS | 8116 | 14:21:14 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:14 INFO - PROCESS | 8116 | RSS: Main: 158670848 14:21:14 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46744/tests/kraken/driver.html?testName=ai-astar) 14:21:16 INFO - PROCESS | 8116 | RSS: Main: 160129024 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | __start_tp_report 14:21:16 INFO - PROCESS | 8116 | _x_x_mozilla_page_load 14:21:16 INFO - PROCESS | 8116 | _x_x_mozilla_page_load_details 14:21:16 INFO - PROCESS | 8116 | |i|pagename|runs| 14:21:16 INFO - PROCESS | 8116 | |0;ai-astar;112;103;111;111;111;123;113;114;111;110 14:21:16 INFO - PROCESS | 8116 | |1;audio-beat-detection;154;131;151;177;135;158;153;133;169;130 14:21:16 INFO - PROCESS | 8116 | |2;audio-dft;162;163;163;161;165;163;162;162;163;163 14:21:16 INFO - PROCESS | 8116 | |3;audio-fft;77;77;73;181;75;76;76;76;163;77 14:21:16 INFO - PROCESS | 8116 | |4;audio-oscillator;92;93;153;95;93;93;157;92;92;150 14:21:16 INFO - PROCESS | 8116 | |5;imaging-gaussian-blur;117;119;118;118;118;118;118;118;117;119 14:21:16 INFO - PROCESS | 8116 | |6;imaging-darkroom;146;147;146;148;146;147;147;148;146;146 14:21:16 INFO - PROCESS | 8116 | |7;imaging-desaturate;97;95;97;96;95;96;94;95;96;95 14:21:16 INFO - PROCESS | 8116 | |8;json-parse-financial;57;58;58;58;58;65;57;74;57;56 14:21:16 INFO - PROCESS | 8116 | |9;json-stringify-tinderbox;57;57;57;57;57;57;57;58;57;57 14:21:16 INFO - PROCESS | 8116 | |10;stanford-crypto-aes;74;75;80;73;89;87;75;74;76;75 14:21:16 INFO - PROCESS | 8116 | |11;stanford-crypto-ccm;134;121;126;130;125;127;117;117;171;121 14:21:16 INFO - PROCESS | 8116 | |12;stanford-crypto-pbkdf2;162;166;164;166;158;164;159;160;165;159 14:21:16 INFO - PROCESS | 8116 | |13;stanford-crypto-sha256-iterative;70;66;66;68;66;70;71;66;70;70 14:21:16 INFO - PROCESS | 8116 | __end_tp_report 14:21:16 INFO - PROCESS | 8116 | __start_cc_report 14:21:16 INFO - PROCESS | 8116 | _x_x_mozilla_cycle_collect,853 14:21:16 INFO - PROCESS | 8116 | __end_cc_report 14:21:16 INFO - PROCESS | 8116 | __startTimestamp1461705676636__endTimestamp 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | ------- Summary: start ------- 14:21:16 INFO - PROCESS | 8116 | Number of tests: 14 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.89 (4.4%) stddev-sans-first:5.18 14:21:16 INFO - PROCESS | 8116 | Values: 112.0 103.0 111.0 111.0 111.0 123.0 113.0 114.0 111.0 110.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:153.50 stddev:16.49 (10.7%) stddev-sans-first:17.39 14:21:16 INFO - PROCESS | 8116 | Values: 154.0 131.0 151.0 177.0 135.0 158.0 153.0 133.0 169.0 130.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.09 14:21:16 INFO - PROCESS | 8116 | Values: 162.0 163.0 163.0 161.0 165.0 163.0 162.0 162.0 163.0 163.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:40.77 (53.6%) stddev-sans-first:42.71 14:21:16 INFO - PROCESS | 8116 | Values: 77.0 77.0 73.0 181.0 75.0 76.0 76.0 76.0 163.0 77.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.50 stddev:29.27 (31.6%) stddev-sans-first:30.23 14:21:16 INFO - PROCESS | 8116 | Values: 92.0 93.0 153.0 95.0 93.0 93.0 157.0 92.0 92.0 150.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 14:21:16 INFO - PROCESS | 8116 | Values: 117.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 119.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 14:21:16 INFO - PROCESS | 8116 | Values: 146.0 147.0 146.0 148.0 146.0 147.0 147.0 148.0 146.0 146.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:0.88 14:21:16 INFO - PROCESS | 8116 | Values: 97.0 95.0 97.0 96.0 95.0 96.0 94.0 95.0 96.0 95.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:5.57 (9.6%) stddev-sans-first:5.82 14:21:16 INFO - PROCESS | 8116 | Values: 57.0 58.0 58.0 58.0 58.0 65.0 57.0 74.0 57.0 56.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 14:21:16 INFO - PROCESS | 8116 | Values: 57.0 57.0 57.0 57.0 57.0 57.0 57.0 58.0 57.0 57.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:75.50 stddev:5.71 (7.6%) stddev-sans-first:5.89 14:21:16 INFO - PROCESS | 8116 | Values: 74.0 75.0 80.0 73.0 89.0 87.0 75.0 74.0 76.0 75.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:126.50 stddev:15.76 (12.5%) stddev-sans-first:16.61 14:21:16 INFO - PROCESS | 8116 | Values: 134.0 121.0 126.0 130.0 125.0 127.0 117.0 117.0 171.0 121.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:164.00 stddev:3.09 (1.9%) stddev-sans-first:3.28 14:21:16 INFO - PROCESS | 8116 | Values: 162.0 166.0 164.0 166.0 158.0 164.0 159.0 160.0 165.0 159.0 14:21:16 INFO - PROCESS | 8116 | 14:21:16 INFO - PROCESS | 8116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:2.15 14:21:16 INFO - PROCESS | 8116 | Values: 70.0 66.0 66.0 68.0 66.0 70.0 71.0 66.0 70.0 70.0 14:21:16 INFO - PROCESS | 8116 | -------- Summary: end -------- 14:21:16 INFO - PROCESS | 8116 | 14:21:17 INFO - TEST-INFO | 8116: exit 0 14:21:17 INFO - TEST-OK | kraken | took 62297ms 14:21:17 INFO - SUITE-END | took 1172s 14:21:17 INFO - Completed test suite (00:19:32) 14:21:17 INFO - javascript benchmark 14:21:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.1769557610596, 3331.6002079750433, 3374.2745309758398, 3403.1322012886712, 3408.386490431721, 5633.60564760467, 5643.604947653661, 5705.629134106281, 5708.257926469563, 5719.542436605072, 5629.493345598895, 5679.318481782181, 5685.630434021786, 5710.543156547476, 5730.598858079936, 5119.692818430897, 5129.6409251352425, 5146.588272938175, 5162.380514338284, 5235.476452354753, 5026.748662566875, 5212.5308722214995, 5243.2659427680155, 5254.973725131369, 5270.209468579725, 5104.821331253407, 5144.922826157611, 5145.716985565792, 5163.845084647466, 5164.2253661950635, 5117.053345131144, 5148.613853960968, 5152.304438900738, 5216.113260745682, 5219.686818790847, 4882.804687812483, 5054.19132938728, 5102.464241254689, 5109.029284435983, 5118.25785261135, 5477.397486276506, 5487.533559647435, 5516.034693928546, 5532.336119665666, 5538.363088244863, 6033.5474839387225, 6049.48579370754, 6055.031195008822, 6061.151438798572, 6064.666443345614, 5903.26209223847, 6038.516918646497, 6088.391160883921, 6145.955187618071, 6148.016317389196, 5683.715814209273, 5685.886282274331, 5686.601937864351, 5693.516051135658, 5709.543236541067, 6146.293176284695, 6197.411245931629, 6204.968975155186, 6213.347598502182, 6216.502679785606, 5706.600537962386, 5948.791792287249, 6022.0, 6037.09443583466, 6067.2112625359305, 5966.731497082642, 6001.099835024694, 6011.458968692838, 6018.0, 6023.759049638053, 5738.282714660668, 5969.611975221596, 5971.4327138921735, 5974.253218347707, 5988.880222395528, 6019.6990150493175, 6058.242719660043, 6060.636361818305, 6064.75740970365, 6092.786752463642, 4526.049529598756, 4606.815727370935, 4612.677112602086, 4615.30770384445, 4639.536046395401, 4057.1479989202007, 4064.1871625674985, 4129.607687269705, 4134.049168691218, 4156.56356082613, 5527.53015993645, 5592.664440133523, 5660.009498337775, 5670.8015219467125, 5687.630304030225, 5995.280566332068, 6058.515318774487, 6059.21230240066, 6092.0, 6094.634321940698, 5542.695151766611, 5611.466910643482, 5659.236003139606, 5687.744051517691, 5692.430756924357, 5148.433672296044, 5168.870778230499, 5180.4560521145495, 5196.558292545176, 5219.869503262449, 6069.848253793602, 6081.239845019372, 6105.511559075263, 6113.32753397126, 6116.449519543263, 5884.735186916685, 6042.969785151046, 6043.123747056564, 6076.939230607814, 6137.806028951221, 6112.777056696867, 6119.28775993027, 6130.233720784902, 6139.216166136355, 6148.1699970503405, 5944.821655350346, 5952.434518720715, 5966.0, 5970.910436343372, 5989.610675306091, 5815.127730840408, 6033.155358249936, 6060.90908636362, 6119.051547010221, 6136.907946380718, 5880.852978675567, 5937.554683398849, 5965.761369545169, 5983.341832398346, 5986.6707331097205, 5908.527317814651, 5927.9703601481715, 5948.345681975065, 5965.985782416913, 5966.970165149147, 5719.599628025998, 5807.680577568274, 5875.059990401515, 5876.6180198286975, 5902.527797776082, 5952.642841429528, 5969.134475500941, 5977.432143946492, 6011.098335249572, 6024.66864322449, 5596.1605759136455, 5867.471927526543, 5873.970630146822, 5886.969780288518, 5909.23179986599], "value": 5563.776842446083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.3965542218026, 657.5594351784304, 671.5299290496652, 719.5502810743285, 724.9818754531134, 41886.58113418865, 43633.34549981753, 43739.78130109349, 43759.78120109403, 43886.561134388685, 43650.78174609131, 44413.0, 44431.333529997, 44432.111357772825, 44506.0, 8942.374033817636, 9067.229285510739, 9116.453012819218, 9149.954250228773, 9163.633454661805, 8667.739967800977, 8848.867266990968, 8857.468551886876, 9032.729018129434, 9043.366964312501, 9024.278057755397, 9053.547322633875, 9054.094590540926, 9100.08999100088, 9103.95448022759, 9019.188273055457, 9020.413673111227, 9060.7281781546, 9073.59168837404, 9074.909250907473, 9144.634214631407, 9195.356325057248, 9228.03105673908, 9255.305852061056, 9269.073092690744, 45568.0, 46084.308735369, 46092.0, 46111.30833037507, 46158.76920615409, 3154.1799132225556, 3814.90462738431, 4065.3495440729343, 4440.733555986619, 4465.0, 30385.392292154032, 31141.8442907784, 31453.0, 31640.525392119136, 31838.840805796055, 4169.624733773944, 4180.067510380464, 4209.326507758775, 4259.215267054683, 4290.313549832012, 237005.0, 238443.0, 238727.0, 239804.0, 240865.0, 39763.204735905696, 40680.79659601683, 40680.79659601683, 40712.0, 40855.0, 41455.0, 63042.68478657577, 64906.35093649098, 65163.674181629736, 65647.34352656508, 18890.716639250422, 19266.71099933502, 19335.8066419334, 19336.613267734567, 19372.903135484514, 14570.708585828224, 14764.335604897806, 14779.408823647149, 14826.777598336033, 14835.184064876536, 20742.0, 21184.894075529523, 21226.575468490544, 21287.68068478974, 21298.25456109029, 7620.618969051525, 7734.806629834299, 7864.4888082274465, 7871.291583757489, 7907.762767116996, 1137.3573930729112, 1166.7141550320057, 1170.6694454277567, 1175.3359351966112, 1239.423667994387, 33602.0, 34432.0, 34517.137071572906, 34759.0, 35015.299694005975, 1116.849225354583, 1141.960031398897, 1189.4409627475072, 1192.66605350502, 1206.6681662542871, 16387.34450621962, 17329.133543322783, 17477.421240630454, 17495.30018799259, 17580.38468653591, 353123.0, 355892.0, 356023.0, 356650.0, 565855.0, 58994.70502647545, 59891.0, 60027.39972600218, 60305.39694602998, 60507.09239361413, 1448.66680663448, 1504.127605988524, 1509.8490150984815, 1514.4926449639495, 1524.6264665157107, 34448.0, 34924.825375872955, 35325.0, 35446.29107417889, 35699.0, 56918.43081569131, 57248.0, 57563.0, 57690.711546442, 57805.710971446555, 490748.0, 491915.0, 492142.0, 492549.0, 494522.0, 31389.52915706312, 31521.369572608877, 31688.683113169496, 31806.04581862548, 31934.84032579822, 51889.0, 52294.21558676699, 53077.0, 53715.46284537261, 54646.453535464134, 44746.77626611846, 45252.77373613111, 45395.773021134686, 46281.305780412644, 47083.52916470928, 43075.56924430715, 43670.781646091564, 43802.0, 44355.77822110869, 45581.54418455773, 43840.342394863466, 44147.337789933816, 45456.772716136205, 45563.0, 45600.0, 37614.0, 38379.42430863595, 39098.0, 39470.40794388029, 39883.60116398799, 29468.55797163087, 29593.408131837674, 30026.24934376658, 30140.698593014666, 30333.696663033086], "value": 20785.321814667746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.55238066697615, 418.5814185814186, 420.1554874701848, 421.1660911395437, 421.8354841611771, 18484.630307393843, 19135.617287654237, 19174.90412547937, 19652.213911443527, 20779.376618701426, 12836.550720724776, 13119.0, 13394.12938159019, 13510.797338039938, 13517.526886558973, 5321.36143662761, 5429.321334833156, 5573.498385145336, 5604.915926261109, 5610.382857885629, 5436.130219164935, 5463.071277882769, 5498.065328894098, 5498.202760599711, 5502.367227768817, 5316.0, 5479.4520547945285, 5481.643693159932, 5485.753141108639, 5487.890242195153, 5438.912217556504, 5480.0, 5537.390887002447, 5551.72241387931, 5560.2493663355735, 5187.170052791535, 5329.467053294639, 5345.224942383333, 5399.514043736082, 5414.214938833847, 14611.0, 14651.194184319858, 14823.851761482356, 14877.553673389815, 21493.892530537403, 2454.189623793986, 2458.2379462366544, 2496.8252222344445, 2512.246326102162, 2549.6557964674903, 10656.360618362845, 11038.282511636718, 11205.66383008511, 11289.435528223637, 11306.0, 2071.2647010311275, 2104.3476522278143, 2123.2674727219087, 2171.1966572368324, 2177.8148857347146, 64234.67882660603, 75884.62057689676, 80930.59534702289, 83770.58114709388, 86257.56871215666, 11217.383043932661, 11493.655190344136, 11535.480903359201, 11662.300261984308, 11746.353950532803, 16578.83421165773, 16595.419160329573, 16691.66616667684, 16692.24884880183, 16695.91652041732, 8837.690680826141, 8882.06738292483, 8946.910530894738, 8983.505907175168, 9056.098219374006, 8803.955980220058, 8930.553472326357, 8939.374243803002, 8946.418482798597, 8948.507832069168, 5053.494650534917, 5057.912548802025, 5178.741062946838, 5244.318238628954, 5300.469953004668, 2093.979060209409, 2097.842661800371, 2110.4196346004974, 2124.033564728045, 2146.903389347483, 963.4749061761357, 1034.095166729112, 1040.178259175243, 1083.344576531203, 1097.6926460590887, 18845.24619015224, 19783.40649780509, 19886.0, 19988.0, 20580.27969021077, 998.8551660009258, 1061.1881910338598, 1063.6543123484898, 1084.8643919510062, 1175.1715040896147, 11277.0, 11326.377049262204, 11436.256643318324, 11518.94240528792, 11537.653870383901, 515112.0, 519639.0, 522488.0, 530262.0, 533271.0, 100503.49748251212, 101607.49196254119, 104581.47709261558, 104879.4756026215, 105477.0, 1131.3155540897637, 1133.7732453509166, 1155.5493357590547, 1161.5469966712988, 1178.9174757767046, 17882.821171788117, 18123.637527249644, 18338.17478213457, 18488.630227395646, 18488.72266916024, 40196.799016004734, 40716.79641601773, 42881.35677964895, 43017.569824302605, 43076.0, 54266.728666356415, 54668.72665636647, 60363.698181508815, 62340.0, 63023.6848815753, 7918.762437126896, 11837.993770529602, 12844.293563853704, 13664.590062298146, 13945.302734863013, 14511.927440363153, 14613.85386146125, 14729.92635036818, 14956.0, 14994.850051499345, 12825.422855971317, 13041.087123901236, 13284.468621255428, 13348.93325533405, 13386.995975302087, 12815.487380504675, 12948.676283092998, 13274.070815042855, 13278.53525126616, 13338.399772010089, 13269.33653317311, 13360.0, 13578.524751633646, 13594.320283985564, 13632.113912595649, 13548.458061677422, 13602.25187614651, 13654.385552649956, 13690.110142840684, 13746.0, 13071.411786469442, 13146.342682865627, 13173.736525269633, 13255.867441325463, 13430.39563219677], "value": 9712.901219146474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.381153726972, 1546.327347603792, 1638.7463590353375, 1759.4985429152694, 1775.9965619425025, 6997.475189360805, 7388.335049845513, 7646.579438130901, 7700.1914798946145, 7702.268284512962, 6937.0, 7651.579163146039, 7751.728689495869, 7773.067231932176, 7779.572123533203, 2302.838801283915, 2312.364099872532, 2319.0, 2322.7212734471887, 2334.9416264593438, 2290.8625482471107, 2304.089884495623, 2312.1213938703268, 2325.802306803915, 2326.7789559991775, 2250.5723912456665, 2275.9886200568976, 2276.897539610713, 2277.2485079923586, 2296.2307626944994, 2255.1881322723807, 2261.604219261639, 2276.9089236430523, 2278.601244782165, 2279.9316020519245, 2210.292706333974, 2215.6898034275214, 2217.2018073493527, 2218.1792736687366, 2218.73375194976, 7886.566238856861, 7901.762947111596, 7919.7228097016905, 7924.603769811486, 7962.004749406325, 4857.878553036167, 4913.238448040559, 4972.7513624319, 5014.598832093424, 5040.420351659533, 3169.9366012679616, 3237.287796684749, 3303.8678452861855, 3369.0566641340465, 3390.2880395117054, 1107.7119948813368, 1138.1293310617384, 1170.093177787213, 1180.2151569206467, 1188.8038473651836, 10553.73615659607, 10620.097291730212, 10651.360918344924, 10660.20048496366, 10682.999999999922, 4182.790860456965, 4254.744715317091, 4339.0, 4343.826246950087, 4371.737695738266, 8945.73162805117, 8982.371234013686, 9015.188633023059, 9021.278297736166, 9041.547922603975, 4908.607311415079, 4942.505749425029, 4946.3817022872145, 4964.255361695775, 4965.0566392385335, 4033.6369726724147, 4426.15902978433, 4467.687261891637, 4483.910321793546, 4519.751413672214, 3732.458793474931, 3745.4756334113245, 3848.730588858753, 3858.3633700439673, 3874.9806250968563, 1203.6810245285008, 1209.407390378708, 1216.6654170103116, 1219.6889793102703, 1222.1261797814605, 971.3346357744967, 1067.8344856547249, 1070.3577853287966, 1087.923845330835, 1102.2009043443438, 5750.4249575042995, 5829.0, 5843.824685259449, 5925.40745925404, 6024.789132380433, 432.77928256589365, 436.7947064879502, 437.7198592900546, 437.8949052227442, 439.68123110744455, 4173.937390939138, 4177.4569305990635, 4187.392828039917, 4219.303814870574, 4237.427947227146, 9056.184943354998, 9405.200557952514, 9413.811723765486, 9431.811363772824, 9476.715698529055, 9217.262618990464, 9316.627334906663, 9322.0, 9330.440173589606, 9348.57931393089, 7050.0482434871665, 7149.320814522612, 7155.105611798525, 7177.820554486179, 7215.098112735908, 5864.208331875313, 5909.054551271776, 5913.319968203712, 6041.365656605993, 6053.576249662481, 8307.543085130375, 8524.0, 8789.648414063622, 8800.955995219983, 8820.11798820113, 8666.306695464475, 8855.070217627057, 8893.599788009426, 8929.955350223207, 8949.0, 6461.160049193575, 6809.182898052265, 6896.896546551906, 6952.235254121942, 7190.96404517974, 7554.093508778982, 7577.583232922242, 7596.164421913474, 7622.69509219625, 7642.273983971514, 6827.761028363983, 7099.716011359487, 7106.609136497542, 7181.0, 7210.315020073084, 6674.866502670016, 6686.5653732507235, 6730.562513436611, 6775.119234499681, 6807.217170025312, 6362.300146983735, 6398.0402939559435, 6401.64790936503, 6410.45511131559, 6473.449756770728, 5076.517730815566, 5125.0, 5187.351581052369, 5190.584753219658, 5219.08665983459, 4967.230079337708, 5100.821471248489, 5160.561352285098, 5177.068127737043, 5215.791368345223], "value": 4267.79606240045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.0912717408649, 340.12757277583, 347.24127780798955, 350.1002423770908, 352.60156023693224, 5618.4943355098085, 5633.126865335875, 5706.3437704663975, 5710.71446427678, 5733.483986441224, 5593.552515798737, 5599.804006859761, 5602.982926146584, 5622.746976386063, 5634.830955071344, 4227.976996447539, 4412.404325416068, 4412.624926881203, 4447.35513350564, 4461.709988850731, 4280.678949078816, 4410.933835992462, 4424.225760491917, 4426.871147857292, 4437.866863994085, 4350.195213885426, 4398.560143985608, 4401.735895846259, 4404.11917616478, 4411.757353345564, 4306.7631280279575, 4393.516713161565, 4415.3376993451075, 4419.895026243439, 4422.911541769179, 3890.8832735017713, 3902.6682731967817, 3909.218156368709, 3918.7648741075627, 3918.766303207173, 5446.836594902159, 5466.207399926989, 5468.781248750045, 5478.698671573062, 5492.615516913817, 4972.95567930735, 5068.781323859376, 5083.0, 5084.262781896604, 5089.51649593288, 5869.677167755772, 5883.8529036774, 5934.317553481362, 5935.406459354073, 5943.898709890205, 4270.274053410928, 4274.871753847358, 4296.677749168824, 4313.698041137121, 4316.395704601358, 5961.374055724174, 6177.25872895251, 6179.5056395488255, 6200.0699895016105, 6223.719932603044, 4403.779811009501, 4405.823767049346, 4423.823047078081, 4434.800433980478, 4440.933385999213, 4474.0, 4487.887802804956, 4497.302918047708, 4511.1654343946475, 4518.638508919278, 4943.530364615356, 5065.974670126626, 5102.540771330524, 5139.100657384943, 5141.331626888481, 5913.674747888821, 5933.406659334119, 5988.580799344004, 6008.0, 6021.46452654579, 1608.9195540222943, 1620.1332287226512, 1622.594351412147, 1627.1294857251314, 1629.0225864481217, 1065.760203954104, 1097.5006372100675, 1109.7114750165015, 1119.4067144413473, 1123.5730422439422, 5536.0, 5769.0, 5777.046787280052, 5793.188953546507, 6048.153258543807, 6194.38056194377, 6226.501879849601, 6235.127082208494, 6245.219347581552, 6281.309056003836, 5544.390117087117, 5723.799667011718, 5736.848681744346, 5747.540196784247, 5749.626274292157, 3517.085557755002, 3521.436570148815, 3522.9295414091575, 3524.4537096750046, 3545.0, 6518.57629254097, 6657.966710166418, 6689.364510371507, 6693.297203793629, 6703.3296670332575, 6763.5941843489545, 6771.593704377753, 6785.457163426914, 6799.150106236721, 6815.931840681629, 6620.602763834186, 6647.767328143492, 6659.067730517731, 6670.666466676744, 6747.122874026345, 6399.392057754506, 6583.868322633425, 6654.866902661823, 6655.633940133339, 6666.699998499982, 6548.607083575001, 6560.179977502812, 6570.145881035435, 6582.3746744059235, 6593.538452308484, 6503.764284785875, 6653.168353955755, 6666.600003999775, 6687.164104486939, 6700.430463410665, 4461.241588929955, 4479.664025198188, 4479.888002799956, 4510.706804057726, 4524.52952790351, 6547.639879806657, 6588.0, 6616.139901812733, 6617.94112941927, 6668.199816021915, 6412.1343618612755, 6421.165248517663, 6437.517186210959, 6445.967770161119, 6452.386903274181, 6422.839429014312, 6427.618062116668, 6430.871382572229, 6431.421172094347, 6433.967830160819, 5783.132530120347, 6087.178230938766, 6290.685465726787, 6326.272478665012, 6337.936620633919, 6075.149479072845, 6083.9695801522475, 6088.26940767093, 6092.421219984094, 6113.510919126548, 5851.64890106595, 5884.882302354014, 5897.587168898308, 5901.557383196192, 5966.463018328372], "value": 4673.420008186185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.4359463767316, 852.799592095857, 858.8754630578567, 903.5121034641294, 911.3483859040784, 13176.275304858229, 13529.661758456043, 13543.59369218925, 13571.185728856275, 13604.795928061087, 11966.162368634199, 13490.190588564694, 13543.187408755482, 13596.980226483003, 13617.523386681469, 881.8324518341527, 897.2059727141461, 897.7396554999042, 899.7075950316141, 900.6442455230181, 910.644848509082, 911.5168960450972, 913.7578541686458, 916.1113719691922, 919.1360121485782, 945.4988855906381, 945.6642891773424, 947.900470450603, 948.4688574398325, 952.200151872427, 927.3369540778342, 929.159111004542, 931.4969916245219, 933.6918816790443, 942.3874481586989, 685.7942617214866, 686.9381755642016, 687.2337343861608, 690.3441730356132, 690.3855568544, 13793.862061379357, 14351.067180633225, 14410.567682969528, 14418.783718244234, 14474.0, 14844.33200505969, 14849.331780069922, 14856.18290993995, 14971.775423368657, 14993.625159370993, 11600.0, 11617.244879082917, 11731.296122232694, 11805.763884722257, 11954.521819127225, 3978.1844721832244, 3999.7400168988925, 4019.4774679291795, 4079.9184016319805, 4171.687123465722, 50047.0, 51641.0, 51884.22173667398, 52419.47580524184, 56085.0, 11456.198066135457, 11683.824742628867, 11744.70638234051, 11903.34531600753, 11930.164888457724, 19588.70616940747, 19607.0, 19650.70523942142, 19698.0, 19698.212071517264, 8570.314374849997, 8582.184692454206, 8604.225619694258, 8715.869261961076, 8938.553072346356, 4816.879578010507, 4841.830535931225, 4861.95138048615, 4915.115279249698, 4923.310736496894, 3519.665631764978, 3562.928741425157, 3577.5170352002147, 3583.964160358363, 3602.85588576454, 656.4289068510332, 658.5357323087212, 664.1896885799317, 669.146837781832, 674.4638012779852, 652.7813182583888, 728.4245446097524, 749.8500299940034, 788.9763307100797, 794.6860989908954, 9553.61785528585, 9661.13049825519, 9709.271804614682, 9717.9028209717, 9905.306628536078, 697.5988806436319, 793.2028311546974, 805.7461899501639, 816.7427260412951, 832.1886160993105, 4132.834686612502, 4516.345129956138, 4520.299353600197, 4590.609798167193, 4604.746738929391, 65041.0, 66415.66792166009, 67147.0, 68505.3149468509, 68604.0, 58443.70778146167, 58511.70744146252, 58811.0, 59077.70461147753, 59463.0, 52918.0, 53565.732171339674, 53824.46175538195, 53871.73064134654, 54017.729911350194, 8537.274331681876, 8556.57217139128, 8601.82796344082, 8654.394192406471, 8656.437331573428, 33947.15132121618, 34225.48661770125, 34441.655583444845, 34582.481262781585, 34761.65238347584, 45555.0, 47713.76143119262, 47847.0, 47992.28011579759, 48350.0, 11285.661430157108, 11583.07335413148, 12207.38963051826, 12360.75278494407, 12578.55975040869, 13300.201987880759, 13340.533081342106, 13398.0, 13530.526431574848, 13598.252096134807, 12670.936645317082, 13299.0, 13316.134451260637, 13343.199408035549, 13594.388252528857, 12530.122891397516, 12663.0, 12669.93665031669, 12849.100562960502, 12911.483540658268, 12644.0, 12771.0, 12838.229706217657, 13029.609111726664, 13052.54316098932, 11022.944885275523, 11069.778604427705, 11134.777304454028, 11150.832737508781, 11228.045616122394, 10969.561217551209, 10971.615993440191, 11274.267172633752, 11316.9434152832, 11338.659840204808], "value": 7034.186772574616, "unit": "score"}], "name": "dromaeo_css", "value": 7349.574929000655, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 103.0, 111.0, 111.0, 111.0, 123.0, 113.0, 114.0, 111.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 151.0, 177.0, 135.0, 158.0, 153.0, 133.0, 169.0, 130.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 165.0, 163.0, 162.0, 162.0, 163.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 73.0, 181.0, 75.0, 76.0, 76.0, 76.0, 163.0, 77.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 95.0, 93.0, 93.0, 157.0, 92.0, 92.0, 150.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 148.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 97.0, 96.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 65.0, 57.0, 74.0, 57.0, 56.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 80.0, 73.0, 89.0, 87.0, 75.0, 74.0, 76.0, 75.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 121.0, 126.0, 130.0, 125.0, 127.0, 117.0, 117.0, 171.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 166.0, 158.0, 164.0, 159.0, 160.0, 165.0, 159.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 66.0, 68.0, 66.0, 70.0, 71.0, 66.0, 70.0, 70.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1544.3, "alertThreshold": 2.0}]} 14:21:17 INFO - Return code: 0 14:21:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:17 ERROR - # TBPL SUCCESS # 14:21:17 INFO - Running post-action listener: _resource_record_post_action 14:21:17 INFO - Running post-run listener: _resource_record_post_run 14:21:18 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259117056; Read time: 12; Write time: 437564 14:21:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16592896; Read time: 0; Write time: 28872 14:21:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 241655808; Read time: 12; Write time: 408516 14:21:19 INFO - Running post-run listener: _upload_blobber_files 14:21:19 INFO - Blob upload gear active. 14:21:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:21:19 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 14:21:19 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'] 14:21:19 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 14:21:19 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:20 INFO - (blobuploader) - INFO - Done attempting. 14:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:20 INFO - (blobuploader) - INFO - Done attempting. 14:21:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:20 INFO - Return code: 0 14:21:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:21:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6eb38d495f1e1eb50083f8a73987687a346508478df39bf0731c3917754b8b0e31a2568a4012493ca10e98304d6b1caee5b33a21ad2bf403259ffa83c57c36b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d648532dd826ea1549a664c1ded07535ded0ab2385fb24801d6268ebfdbcd390b7a4700500a13dd8312d24d3a0feffb4da5ea973d351628b3f2485d1170afe3f"} 14:21:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:21:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:21:20 INFO - Contents: 14:21:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6eb38d495f1e1eb50083f8a73987687a346508478df39bf0731c3917754b8b0e31a2568a4012493ca10e98304d6b1caee5b33a21ad2bf403259ffa83c57c36b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d648532dd826ea1549a664c1ded07535ded0ab2385fb24801d6268ebfdbcd390b7a4700500a13dd8312d24d3a0feffb4da5ea973d351628b3f2485d1170afe3f"} 14:21:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:20 INFO - Copying logs to upload dir... 14:21:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:21:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2122.814352 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 22 secs) (at 2016-04-26 14:21:20.934784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 14:21:20.938424) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580 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/a6eb38d495f1e1eb50083f8a73987687a346508478df39bf0731c3917754b8b0e31a2568a4012493ca10e98304d6b1caee5b33a21ad2bf403259ffa83c57c36b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d648532dd826ea1549a664c1ded07535ded0ab2385fb24801d6268ebfdbcd390b7a4700500a13dd8312d24d3a0feffb4da5ea973d351628b3f2485d1170afe3f"} build_url:https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/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/a6eb38d495f1e1eb50083f8a73987687a346508478df39bf0731c3917754b8b0e31a2568a4012493ca10e98304d6b1caee5b33a21ad2bf403259ffa83c57c36b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d648532dd826ea1549a664c1ded07535ded0ab2385fb24801d6268ebfdbcd390b7a4700500a13dd8312d24d3a0feffb4da5ea973d351628b3f2485d1170afe3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 14:21:20.963479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 14:21:20.963804) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461703555.798168-1147714580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 14:21:21.049232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 14:21:21.049544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 14:21:21.049883) ========= ========= Total master_lag: 0.17 =========