builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1461263114.33 results: success (0) buildid: 20160421073656 builduid: a981f61de77d4233bdc2491c7bc791bb revision: acaefb4a5fc814ad6ee2404d17f6539da82aa839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.328743) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.329176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.329451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.346133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.346492) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 11:25:14-- 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-21 11:25:14 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.316527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.676473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.676809) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.725887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:14.726252) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev acaefb4a5fc814ad6ee2404d17f6539da82aa839 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev acaefb4a5fc814ad6ee2404d17f6539da82aa839 --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=03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 11:25:14,766 truncating revision to first 12 chars 2016-04-21 11:25:14,766 Setting DEBUG logging. 2016-04-21 11:25:14,766 attempt 1/10 2016-04-21 11:25:14,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/acaefb4a5fc8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 11:25:15,031 unpacking tar archive at: mozilla-inbound-acaefb4a5fc8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:15.300356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:15.300666) ========= script_repo_revision: acaefb4a5fc814ad6ee2404d17f6539da82aa839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:15.301121) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:15.301391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 11:25:15.312152) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-21 11:25:15.312775) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:25:15 INFO - MultiFileLogger online at 20160421 11:25:15 in /builds/slave/test 11:25:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:25:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:15 INFO - {'append_to_log': False, 11:25:15 INFO - 'base_work_dir': '/builds/slave/test', 11:25:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:25:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:15 INFO - 'branch': 'Mozilla-Inbound', 11:25:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:15 INFO - 'config_files': ('talos/linux_config.py',), 11:25:15 INFO - 'default_actions': ('clobber', 11:25:15 INFO - 'read-buildbot-config', 11:25:15 INFO - 'download-and-extract', 11:25:15 INFO - 'populate-webroot', 11:25:15 INFO - 'create-virtualenv', 11:25:15 INFO - 'install', 11:25:15 INFO - 'run-tests'), 11:25:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:15 INFO - 'download_minidump_stackwalk': True, 11:25:15 INFO - 'download_symbols': 'ondemand', 11:25:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:15 INFO - 'installer_path': 'installer.exe', 11:25:15 INFO - 'log_level': 'info', 11:25:15 INFO - 'log_name': 'talos', 11:25:15 INFO - 'log_to_console': True, 11:25:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:25:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:25:15 INFO - 'opt_config_files': (), 11:25:15 INFO - 'pip_index': False, 11:25:15 INFO - 'sps_profile': False, 11:25:15 INFO - 'sps_profile_interval': 0, 11:25:15 INFO - 'suite': 'dromaeojs-e10s', 11:25:15 INFO - 'system_bits': '32', 11:25:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:15 INFO - 'title': 'talos-linux64-ix-047', 11:25:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:15 INFO - 'use_talos_json': True, 11:25:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:15 INFO - 'work_dir': 'build'} 11:25:15 INFO - ##### 11:25:15 INFO - ##### Running clobber step. 11:25:15 INFO - ##### 11:25:15 INFO - Running pre-action listener: _resource_record_pre_action 11:25:15 INFO - Running main action method: clobber 11:25:15 INFO - rmtree: /builds/slave/test/build 11:25:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:15 INFO - Running post-action listener: _resource_record_post_action 11:25:15 INFO - ##### 11:25:15 INFO - ##### Running read-buildbot-config step. 11:25:15 INFO - ##### 11:25:15 INFO - Running pre-action listener: _resource_record_pre_action 11:25:15 INFO - Running main action method: read_buildbot_config 11:25:15 INFO - Using buildbot properties: 11:25:15 INFO - { 11:25:15 INFO - "project": "", 11:25:15 INFO - "product": "firefox", 11:25:15 INFO - "script_repo_revision": "production", 11:25:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:25:15 INFO - "repository": "", 11:25:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:25:15 INFO - "buildid": "20160421073656", 11:25:15 INFO - "pgo_build": "True", 11:25:15 INFO - "basedir": "/builds/slave/test", 11:25:15 INFO - "buildnumber": 486, 11:25:15 INFO - "slavename": "talos-linux64-ix-047", 11:25:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:25:15 INFO - "platform": "ubuntu64_hw", 11:25:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:25:15 INFO - "branch": "mozilla-inbound", 11:25:15 INFO - "repo_path": "integration/mozilla-inbound", 11:25:15 INFO - "revision": "acaefb4a5fc814ad6ee2404d17f6539da82aa839", 11:25:15 INFO - "stage_platform": "linux64-pgo", 11:25:15 INFO - "builduid": "a981f61de77d4233bdc2491c7bc791bb", 11:25:15 INFO - "slavebuilddir": "test" 11:25:15 INFO - } 11:25:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:25:15 INFO - Running post-action listener: _resource_record_post_action 11:25:15 INFO - ##### 11:25:15 INFO - ##### Running download-and-extract step. 11:25:15 INFO - ##### 11:25:15 INFO - Running pre-action listener: _resource_record_pre_action 11:25:15 INFO - Running main action method: download_and_extract 11:25:15 INFO - mkdir: /builds/slave/test/build/tests 11:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:15 INFO - https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:25:17 INFO - Downloaded 1361 bytes. 11:25:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:25:17 INFO - Using the following test package requirements: 11:25:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:25:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:25:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:25:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'jsshell-linux-x86_64.zip'], 11:25:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:25:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:25:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:25:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:25:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:25:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:25:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:17 INFO - https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:25:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:25:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:25:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:25:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:25:18 INFO - Downloaded 23853208 bytes. 11:25:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:25:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:25:20 INFO - Return code: 0 11:25:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:20 INFO - https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:25:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:25:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:25:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:25:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:25:23 INFO - Downloaded 23853208 bytes. 11:25:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:25:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:25:24 INFO - Return code: 0 11:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:24 INFO - https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:25:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:25:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:25:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:25:26 INFO - Downloaded 10845952 bytes. 11:25:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:25:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:25:26 INFO - Return code: 0 11:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:26 INFO - https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:25:28 INFO - Downloaded 58320116 bytes. 11:25:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:25:28 INFO - mkdir: /builds/slave/test/properties 11:25:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:28 INFO - Contents: 11:25:28 INFO - build_url:https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:25:29 INFO - Running post-action listener: _resource_record_post_action 11:25:29 INFO - Running post-action listener: set_extra_try_arguments 11:25:29 INFO - ##### 11:25:29 INFO - ##### Running populate-webroot step. 11:25:29 INFO - ##### 11:25:29 INFO - Running pre-action listener: _resource_record_pre_action 11:25:29 INFO - Running main action method: populate_webroot 11:25:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:29 INFO - '--tppagecycles', 11:25:29 INFO - '7'], 11:25:29 INFO - 'tests': ['tsvgm']}}, 11:25:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['damp', 'tps']}, 11:25:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'tests': ['damp', 'tps']}, 11:25:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['dromaeo_dom']}, 11:25:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['a11yr', 11:25:29 INFO - 'ts_paint', 11:25:29 INFO - 'tpaint', 11:25:29 INFO - 'sessionrestore', 11:25:29 INFO - 'sessionrestore_no_auto_restore', 11:25:29 INFO - 'tabpaint']}, 11:25:29 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:29 INFO - 'ts_paint', 11:25:29 INFO - 'tpaint', 11:25:29 INFO - 'sessionrestore', 11:25:29 INFO - 'sessionrestore_no_auto_restore', 11:25:29 INFO - 'tabpaint']}, 11:25:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:25:29 INFO - 'ts_paint', 11:25:29 INFO - 'tpaint', 11:25:29 INFO - 'sessionrestore', 11:25:29 INFO - 'sessionrestore_no_auto_restore', 11:25:29 INFO - 'tabpaint']}, 11:25:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:25:29 INFO - 'ts_paint', 11:25:29 INFO - 'tpaint', 11:25:29 INFO - 'sessionrestore', 11:25:29 INFO - 'sessionrestore_no_auto_restore', 11:25:29 INFO - 'tabpaint']}, 11:25:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['a11yr', 11:25:29 INFO - 'ts_paint', 11:25:29 INFO - 'tpaint', 11:25:29 INFO - 'sessionrestore', 11:25:29 INFO - 'sessionrestore_no_auto_restore', 11:25:29 INFO - 'tabpaint']}, 11:25:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['a11yr', 11:25:29 INFO - 'ts_paint', 11:25:29 INFO - 'tpaint', 11:25:29 INFO - 'sessionrestore', 11:25:29 INFO - 'sessionrestore_no_auto_restore', 11:25:29 INFO - 'tabpaint']}, 11:25:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['tsvgx', 11:25:29 INFO - 'tsvgr_opacity', 11:25:29 INFO - 'tart', 11:25:29 INFO - 'tscrollx', 11:25:29 INFO - 'cart']}, 11:25:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:29 INFO - 'tsvgr_opacity', 11:25:29 INFO - 'tart', 11:25:29 INFO - 'tscrollx', 11:25:29 INFO - 'cart']}, 11:25:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'talos_options': ['--disable-e10s'], 11:25:29 INFO - 'tests': ['tp5o']}, 11:25:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'tests': ['tp5o']}, 11:25:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'talos_options': ['--disable-e10s', 11:25:29 INFO - '--xperf_path', 11:25:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:29 INFO - 'tests': ['tp5n']}, 11:25:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:29 INFO - 'talos_options': ['--xperf_path', 11:25:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:29 INFO - 'tests': ['tp5n']}}, 11:25:29 INFO - 'talos.zip': {'path': '', 11:25:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:29 INFO - Running post-action listener: _resource_record_post_action 11:25:29 INFO - ##### 11:25:29 INFO - ##### Running create-virtualenv step. 11:25:29 INFO - ##### 11:25:29 INFO - Running pre-action listener: _resource_record_pre_action 11:25:29 INFO - Running main action method: create_virtualenv 11:25:29 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:25:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:29 INFO - Using real prefix '/usr' 11:25:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:30 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:32 INFO - Installing pip.................done. 11:25:32 INFO - Return code: 0 11:25:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:25:32 INFO - Using env: {'DISPLAY': ':0', 11:25:32 INFO - 'HOME': '/home/cltbld', 11:25:32 INFO - 'LANG': 'en_US.UTF-8', 11:25:32 INFO - 'LANGUAGE': 'en_US:en', 11:25:32 INFO - 'LOGNAME': 'cltbld', 11:25:32 INFO - 'MAIL': '/var/mail/cltbld', 11:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:32 INFO - 'MOZ_NO_REMOTE': '1', 11:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:32 INFO - 'NO_EM_RESTART': '1', 11:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:32 INFO - 'PWD': '/builds/slave/test', 11:25:32 INFO - 'SHELL': '/bin/bash', 11:25:32 INFO - 'SHLVL': '1', 11:25:32 INFO - 'TERM': 'linux', 11:25:32 INFO - 'TMOUT': '86400', 11:25:32 INFO - 'USER': 'cltbld', 11:25:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:32 INFO - '_': '/tools/buildbot/bin/python'} 11:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:25:32 INFO - Cleaning up... 11:25:32 INFO - Return code: 0 11:25:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:25:32 INFO - Using env: {'DISPLAY': ':0', 11:25:32 INFO - 'HOME': '/home/cltbld', 11:25:32 INFO - 'LANG': 'en_US.UTF-8', 11:25:32 INFO - 'LANGUAGE': 'en_US:en', 11:25:32 INFO - 'LOGNAME': 'cltbld', 11:25:32 INFO - 'MAIL': '/var/mail/cltbld', 11:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:32 INFO - 'MOZ_NO_REMOTE': '1', 11:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:32 INFO - 'NO_EM_RESTART': '1', 11:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:32 INFO - 'PWD': '/builds/slave/test', 11:25:32 INFO - 'SHELL': '/bin/bash', 11:25:32 INFO - 'SHLVL': '1', 11:25:32 INFO - 'TERM': 'linux', 11:25:32 INFO - 'TMOUT': '86400', 11:25:32 INFO - 'USER': 'cltbld', 11:25:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:32 INFO - '_': '/tools/buildbot/bin/python'} 11:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:32 INFO - Downloading/unpacking psutil>=0.7.1 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:34 INFO - Installing collected packages: psutil 11:25:34 INFO - Running setup.py install for psutil 11:25:34 INFO - building 'psutil._psutil_linux' extension 11:25:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:25:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:25:35 INFO - building 'psutil._psutil_posix' extension 11:25:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:25:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:25:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:35 INFO - Successfully installed psutil 11:25:35 INFO - Cleaning up... 11:25:35 INFO - Return code: 0 11:25:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:35 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:25:35 INFO - Using env: {'DISPLAY': ':0', 11:25:35 INFO - 'HOME': '/home/cltbld', 11:25:35 INFO - 'LANG': 'en_US.UTF-8', 11:25:35 INFO - 'LANGUAGE': 'en_US:en', 11:25:35 INFO - 'LOGNAME': 'cltbld', 11:25:35 INFO - 'MAIL': '/var/mail/cltbld', 11:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:35 INFO - 'MOZ_NO_REMOTE': '1', 11:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:35 INFO - 'NO_EM_RESTART': '1', 11:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:35 INFO - 'PWD': '/builds/slave/test', 11:25:35 INFO - 'SHELL': '/bin/bash', 11:25:35 INFO - 'SHLVL': '1', 11:25:35 INFO - 'TERM': 'linux', 11:25:35 INFO - 'TMOUT': '86400', 11:25:35 INFO - 'USER': 'cltbld', 11:25:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:35 INFO - '_': '/tools/buildbot/bin/python'} 11:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:25:37 INFO - Installing collected packages: mozsystemmonitor 11:25:37 INFO - Running setup.py install for mozsystemmonitor 11:25:37 INFO - Successfully installed mozsystemmonitor 11:25:37 INFO - Cleaning up... 11:25:37 INFO - Return code: 0 11:25:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:37 INFO - Using env: {'DISPLAY': ':0', 11:25:37 INFO - 'HOME': '/home/cltbld', 11:25:37 INFO - 'LANG': 'en_US.UTF-8', 11:25:37 INFO - 'LANGUAGE': 'en_US:en', 11:25:37 INFO - 'LOGNAME': 'cltbld', 11:25:37 INFO - 'MAIL': '/var/mail/cltbld', 11:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:37 INFO - 'MOZ_NO_REMOTE': '1', 11:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:37 INFO - 'NO_EM_RESTART': '1', 11:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:37 INFO - 'PWD': '/builds/slave/test', 11:25:37 INFO - 'SHELL': '/bin/bash', 11:25:37 INFO - 'SHLVL': '1', 11:25:37 INFO - 'TERM': 'linux', 11:25:37 INFO - 'TMOUT': '86400', 11:25:37 INFO - 'USER': 'cltbld', 11:25:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:37 INFO - '_': '/tools/buildbot/bin/python'} 11:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:40 INFO - Downloading docopt-0.6.1.tar.gz 11:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:40 INFO - Running setup.py install for blobuploader 11:25:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:40 INFO - Running setup.py install for requests 11:25:40 INFO - Running setup.py install for docopt 11:25:40 INFO - Successfully installed blobuploader requests docopt 11:25:40 INFO - Cleaning up... 11:25:41 INFO - Return code: 0 11:25:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:41 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:41 INFO - Using env: {'DISPLAY': ':0', 11:25:41 INFO - 'HOME': '/home/cltbld', 11:25:41 INFO - 'LANG': 'en_US.UTF-8', 11:25:41 INFO - 'LANGUAGE': 'en_US:en', 11:25:41 INFO - 'LOGNAME': 'cltbld', 11:25:41 INFO - 'MAIL': '/var/mail/cltbld', 11:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:41 INFO - 'MOZ_NO_REMOTE': '1', 11:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:41 INFO - 'NO_EM_RESTART': '1', 11:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:41 INFO - 'PWD': '/builds/slave/test', 11:25:41 INFO - 'SHELL': '/bin/bash', 11:25:41 INFO - 'SHLVL': '1', 11:25:41 INFO - 'TERM': 'linux', 11:25:41 INFO - 'TMOUT': '86400', 11:25:41 INFO - 'USER': 'cltbld', 11:25:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:41 INFO - '_': '/tools/buildbot/bin/python'} 11:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:41 INFO - Running setup.py (path:/tmp/pip-_OJBGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:41 INFO - Running setup.py (path:/tmp/pip-C_EROU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:41 INFO - Running setup.py (path:/tmp/pip-M7rDOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:41 INFO - Running setup.py (path:/tmp/pip-VHf6x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:41 INFO - Running setup.py (path:/tmp/pip-r8iAid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:41 INFO - Running setup.py (path:/tmp/pip-xIy2LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:41 INFO - Running setup.py (path:/tmp/pip-4LiB1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:41 INFO - Running setup.py (path:/tmp/pip-BQso4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:41 INFO - Running setup.py (path:/tmp/pip-lLYPnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:41 INFO - Running setup.py (path:/tmp/pip-j9iyE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:41 INFO - Running setup.py (path:/tmp/pip-6qlqKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:42 INFO - Running setup.py (path:/tmp/pip-yN3lmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:42 INFO - Running setup.py (path:/tmp/pip-klZkEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:42 INFO - Running setup.py (path:/tmp/pip-a6PTix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:42 INFO - Running setup.py (path:/tmp/pip-v5Hg46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:42 INFO - Running setup.py (path:/tmp/pip-5ZNLtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:42 INFO - Running setup.py (path:/tmp/pip-Wo4FGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:42 INFO - Running setup.py install for manifestparser 11:25:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozcrash 11:25:42 INFO - Running setup.py install for mozdebug 11:25:42 INFO - Running setup.py install for mozdevice 11:25:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozfile 11:25:43 INFO - Running setup.py install for mozhttpd 11:25:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozinfo 11:25:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozInstall 11:25:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozleak 11:25:43 INFO - Running setup.py install for mozlog 11:25:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for moznetwork 11:25:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozprocess 11:25:43 INFO - Running setup.py install for mozprofile 11:25:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozrunner 11:25:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozscreenshot 11:25:44 INFO - Running setup.py install for moztest 11:25:44 INFO - Running setup.py install for mozversion 11:25:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:44 INFO - Cleaning up... 11:25:44 INFO - Return code: 0 11:25:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:44 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:44 INFO - Using env: {'DISPLAY': ':0', 11:25:44 INFO - 'HOME': '/home/cltbld', 11:25:44 INFO - 'LANG': 'en_US.UTF-8', 11:25:44 INFO - 'LANGUAGE': 'en_US:en', 11:25:44 INFO - 'LOGNAME': 'cltbld', 11:25:44 INFO - 'MAIL': '/var/mail/cltbld', 11:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:44 INFO - 'MOZ_NO_REMOTE': '1', 11:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:44 INFO - 'NO_EM_RESTART': '1', 11:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:44 INFO - 'PWD': '/builds/slave/test', 11:25:44 INFO - 'SHELL': '/bin/bash', 11:25:44 INFO - 'SHLVL': '1', 11:25:44 INFO - 'TERM': 'linux', 11:25:44 INFO - 'TMOUT': '86400', 11:25:44 INFO - 'USER': 'cltbld', 11:25:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:44 INFO - '_': '/tools/buildbot/bin/python'} 11:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:44 INFO - Running setup.py (path:/tmp/pip-xvc_c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:44 INFO - Running setup.py (path:/tmp/pip-55EiBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:44 INFO - Running setup.py (path:/tmp/pip-sKq4Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:44 INFO - Running setup.py (path:/tmp/pip-geMhGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:44 INFO - Running setup.py (path:/tmp/pip-aNIuNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:44 INFO - Running setup.py (path:/tmp/pip-rXn4Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:44 INFO - Running setup.py (path:/tmp/pip-0nbwd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:45 INFO - Running setup.py (path:/tmp/pip-HT0dI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:45 INFO - Running setup.py (path:/tmp/pip-mQFZ9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:45 INFO - Running setup.py (path:/tmp/pip-PrXxbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:45 INFO - Running setup.py (path:/tmp/pip-cgNnro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:45 INFO - Running setup.py (path:/tmp/pip-GkFAXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:45 INFO - Running setup.py (path:/tmp/pip-W9KGJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:45 INFO - Running setup.py (path:/tmp/pip-HNvPlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:45 INFO - Running setup.py (path:/tmp/pip-WyU7J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:45 INFO - Running setup.py (path:/tmp/pip-e0PuZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:45 INFO - Running setup.py (path:/tmp/pip-WBJc3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:47 INFO - Downloading blessings-1.6.tar.gz 11:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:47 INFO - Installing collected packages: blessings 11:25:47 INFO - Running setup.py install for blessings 11:25:47 INFO - Successfully installed blessings 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:48 INFO - Reading from file tmpfile_stdout 11:25:48 INFO - Current package versions: 11:25:48 INFO - argparse == 1.2.1 11:25:48 INFO - blessings == 1.6 11:25:48 INFO - blobuploader == 1.2.4 11:25:48 INFO - docopt == 0.6.1 11:25:48 INFO - manifestparser == 1.1 11:25:48 INFO - mozInstall == 1.12 11:25:48 INFO - mozcrash == 0.17 11:25:48 INFO - mozdebug == 0.1 11:25:48 INFO - mozdevice == 0.48 11:25:48 INFO - mozfile == 1.2 11:25:48 INFO - mozhttpd == 0.7 11:25:48 INFO - mozinfo == 0.9 11:25:48 INFO - mozleak == 0.1 11:25:48 INFO - mozlog == 3.1 11:25:48 INFO - moznetwork == 0.27 11:25:48 INFO - mozprocess == 0.22 11:25:48 INFO - mozprofile == 0.28 11:25:48 INFO - mozrunner == 6.11 11:25:48 INFO - mozscreenshot == 0.1 11:25:48 INFO - mozsystemmonitor == 0.0 11:25:48 INFO - moztest == 0.7 11:25:48 INFO - mozversion == 1.4 11:25:48 INFO - psutil == 3.1.1 11:25:48 INFO - requests == 1.2.3 11:25:48 INFO - wsgiref == 0.1.2 11:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:48 INFO - Using env: {'DISPLAY': ':0', 11:25:48 INFO - 'HOME': '/home/cltbld', 11:25:48 INFO - 'LANG': 'en_US.UTF-8', 11:25:48 INFO - 'LANGUAGE': 'en_US:en', 11:25:48 INFO - 'LOGNAME': 'cltbld', 11:25:48 INFO - 'MAIL': '/var/mail/cltbld', 11:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:48 INFO - 'MOZ_NO_REMOTE': '1', 11:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:48 INFO - 'NO_EM_RESTART': '1', 11:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:48 INFO - 'PWD': '/builds/slave/test', 11:25:48 INFO - 'SHELL': '/bin/bash', 11:25:48 INFO - 'SHLVL': '1', 11:25:48 INFO - 'TERM': 'linux', 11:25:48 INFO - 'TMOUT': '86400', 11:25:48 INFO - 'USER': 'cltbld', 11:25:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:48 INFO - '_': '/tools/buildbot/bin/python'} 11:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:48 INFO - Cleaning up... 11:25:48 INFO - Return code: 0 11:25:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:25:48 INFO - Using env: {'DISPLAY': ':0', 11:25:48 INFO - 'HOME': '/home/cltbld', 11:25:48 INFO - 'LANG': 'en_US.UTF-8', 11:25:48 INFO - 'LANGUAGE': 'en_US:en', 11:25:48 INFO - 'LOGNAME': 'cltbld', 11:25:48 INFO - 'MAIL': '/var/mail/cltbld', 11:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:48 INFO - 'MOZ_NO_REMOTE': '1', 11:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:48 INFO - 'NO_EM_RESTART': '1', 11:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:48 INFO - 'PWD': '/builds/slave/test', 11:25:48 INFO - 'SHELL': '/bin/bash', 11:25:48 INFO - 'SHLVL': '1', 11:25:48 INFO - 'TERM': 'linux', 11:25:48 INFO - 'TMOUT': '86400', 11:25:48 INFO - 'USER': 'cltbld', 11:25:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:48 INFO - '_': '/tools/buildbot/bin/python'} 11:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:48 INFO - Downloading/unpacking jsonschema 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:50 INFO - Downloading/unpacking functools32 (from jsonschema) 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:50 INFO - warning: no files found matching '*.txt' 11:25:50 INFO - no previously-included directories found matching 'build' 11:25:50 INFO - no previously-included directories found matching 'dist' 11:25:50 INFO - no previously-included directories found matching '.git*' 11:25:50 INFO - Installing collected packages: jsonschema, functools32 11:25:50 INFO - Running setup.py install for functools32 11:25:50 INFO - warning: no files found matching '*.txt' 11:25:50 INFO - no previously-included directories found matching 'build' 11:25:50 INFO - no previously-included directories found matching 'dist' 11:25:50 INFO - no previously-included directories found matching '.git*' 11:25:50 INFO - Successfully installed jsonschema functools32 11:25:50 INFO - Cleaning up... 11:25:50 INFO - Return code: 0 11:25:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:50 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 0x7f29086f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:25:50 INFO - Using env: {'DISPLAY': ':0', 11:25:50 INFO - 'HOME': '/home/cltbld', 11:25:50 INFO - 'LANG': 'en_US.UTF-8', 11:25:50 INFO - 'LANGUAGE': 'en_US:en', 11:25:50 INFO - 'LOGNAME': 'cltbld', 11:25:50 INFO - 'MAIL': '/var/mail/cltbld', 11:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:50 INFO - 'MOZ_NO_REMOTE': '1', 11:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:50 INFO - 'NO_EM_RESTART': '1', 11:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:50 INFO - 'PWD': '/builds/slave/test', 11:25:50 INFO - 'SHELL': '/bin/bash', 11:25:50 INFO - 'SHLVL': '1', 11:25:50 INFO - 'TERM': 'linux', 11:25:50 INFO - 'TMOUT': '86400', 11:25:50 INFO - 'USER': 'cltbld', 11:25:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:50 INFO - '_': '/tools/buildbot/bin/python'} 11:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:51 INFO - Downloading/unpacking flake8 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:53 INFO - no previously-included directories found matching 'docs/_build' 11:25:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:53 INFO - Running setup.py install for pep8 11:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:53 INFO - no previously-included directories found matching 'docs/_build' 11:25:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:53 INFO - Cleaning up... 11:25:53 INFO - Return code: 0 11:25:53 INFO - Running post-action listener: _resource_record_post_action 11:25:53 INFO - Running post-action listener: _start_resource_monitoring 11:25:53 INFO - Starting resource monitoring. 11:25:53 INFO - ##### 11:25:53 INFO - ##### Running install step. 11:25:53 INFO - ##### 11:25:53 INFO - Running pre-action listener: _resource_record_pre_action 11:25:53 INFO - Running main action method: install 11:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:54 INFO - Reading from file tmpfile_stdout 11:25:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:54 INFO - Reading from file tmpfile_stdout 11:25:54 INFO - Output received: 11:25:54 INFO - Usage: mozinstall [options] installer 11:25:54 INFO - Options: 11:25:54 INFO - -h, --help show this help message and exit 11:25:54 INFO - -d DEST, --destination=DEST 11:25:54 INFO - Directory to install application into. [default: 11:25:54 INFO - "/builds/slave/test"] 11:25:54 INFO - --app=APP Application being installed. [default: firefox] 11:25:54 INFO - mkdir: /builds/slave/test/build/application 11:25:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:26:10 INFO - Reading from file tmpfile_stdout 11:26:10 INFO - Output received: 11:26:10 INFO - /builds/slave/test/build/application/firefox/firefox 11:26:10 INFO - Running post-action listener: _resource_record_post_action 11:26:10 INFO - ##### 11:26:10 INFO - ##### Running run-tests step. 11:26:10 INFO - ##### 11:26:10 INFO - Running pre-action listener: _resource_record_pre_action 11:26:10 INFO - Running main action method: run_tests 11:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:10 INFO - Python 2.7.3 11:26:10 INFO - Return code: 0 11:26:10 INFO - grabbing minidump binary from tooltool 11:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:10 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 0x2d3c410>, '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 0x2d3d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:26:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:26:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:10 INFO - Return code: 0 11:26:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:26:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:26:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:26:11 INFO - Return code: 0 11:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:26:11 INFO - Using env: {'DISPLAY': ':0', 11:26:11 INFO - 'HOME': '/home/cltbld', 11:26:11 INFO - 'LANG': 'en_US.UTF-8', 11:26:11 INFO - 'LANGUAGE': 'en_US:en', 11:26:11 INFO - 'LOGNAME': 'cltbld', 11:26:11 INFO - 'MAIL': '/var/mail/cltbld', 11:26:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:11 INFO - 'MOZ_NO_REMOTE': '1', 11:26:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:11 INFO - 'NO_EM_RESTART': '1', 11:26:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:11 INFO - 'PWD': '/builds/slave/test', 11:26:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:11 INFO - 'SHELL': '/bin/bash', 11:26:11 INFO - 'SHLVL': '1', 11:26:11 INFO - 'TERM': 'linux', 11:26:11 INFO - 'TMOUT': '86400', 11:26:11 INFO - 'USER': 'cltbld', 11:26:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411', 11:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:11 INFO - '_': '/tools/buildbot/bin/python'} 11:26:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:26:12 INFO - mozversion application_buildid: 20160421073656 11:26:12 INFO - mozversion application_changeset: acaefb4a5fc814ad6ee2404d17f6539da82aa839 11:26:12 INFO - mozversion application_display_name: Nightly 11:26:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:12 INFO - mozversion application_name: Firefox 11:26:12 INFO - mozversion application_remotingname: firefox 11:26:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:26:12 INFO - mozversion application_vendor: Mozilla 11:26:12 INFO - mozversion application_version: 48.0a1 11:26:12 INFO - mozversion platform_buildid: 20160421073656 11:26:12 INFO - mozversion platform_changeset: acaefb4a5fc814ad6ee2404d17f6539da82aa839 11:26:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:26:12 INFO - mozversion platform_version: 48.0a1 11:26:12 INFO - using testdate: 1461263172 11:26:12 INFO - actual date: 1461263172 11:26:12 INFO - starting webserver on 'localhost:43977' 11:26:12 INFO - SUITE-START | Running 2 tests 11:26:12 INFO - TEST-START | dromaeo_css 11:26:12 INFO - operating with platform_type : linux_ 11:26:12 INFO - Initialising browser for dromaeo_css test... 11:26:12 INFO - TEST-INFO | started process 25872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM1DCp7/profile http://localhost:43977/getInfo.html) 11:26:15 INFO - PROCESS | 25872 | 11:26:15 INFO - PROCESS | 25872 | (process:25939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:16 INFO - PROCESS | 25872 | __metrics Screen width/height:1600/1200 11:26:16 INFO - PROCESS | 25872 | colorDepth:24 11:26:16 INFO - PROCESS | 25872 | Browser inner width/height: 1024/697 11:26:16 INFO - PROCESS | 25872 | __metrics 11:26:17 ERROR - PROCESS | 25872 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:26:18 INFO - TEST-INFO | 25872: exit 0 11:26:18 INFO - Browser initialized. 11:26:18 INFO - Running cycle 1/1 for dromaeo_css test... 11:26:18 INFO - TEST-INFO | started process 25990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM1DCp7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:20 INFO - PROCESS | 25990 | 11:26:20 INFO - PROCESS | 25990 | (process:26050): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:30 INFO - PROCESS | 25990 | RSS: Main: 163753984 11:26:30 INFO - PROCESS | 25990 | 11:27:19 INFO - PROCESS | 25990 | 1461263239644 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:29:27 INFO - PROCESS | 25990 | Cycle 1(1): loaded http://localhost:43977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43977/tests/dromaeo/cssquery-ext.html) 11:29:28 INFO - PROCESS | 25990 | RSS: Main: 169443328 11:29:28 INFO - PROCESS | 25990 | 11:32:30 INFO - PROCESS | 25990 | Cycle 1(1): loaded http://localhost:43977/tests/dromaeo/cssquery-ext.html (next: http://localhost:43977/tests/dromaeo/cssquery-jquery.html) 11:32:30 INFO - PROCESS | 25990 | RSS: Main: 165851136 11:32:30 INFO - PROCESS | 25990 | 11:35:32 INFO - PROCESS | 25990 | Cycle 1(1): loaded http://localhost:43977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43977/tests/dromaeo/cssquery-mootools.html) 11:35:32 INFO - PROCESS | 25990 | RSS: Main: 166928384 11:35:32 INFO - PROCESS | 25990 | 11:38:34 INFO - PROCESS | 25990 | Cycle 1(1): loaded http://localhost:43977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43977/tests/dromaeo/cssquery-prototype.html) 11:38:35 INFO - PROCESS | 25990 | RSS: Main: 164667392 11:38:35 INFO - PROCESS | 25990 | 11:41:37 INFO - PROCESS | 25990 | Cycle 1(1): loaded http://localhost:43977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43977/tests/dromaeo/cssquery-yui.html) 11:41:38 INFO - PROCESS | 25990 | RSS: Main: 166289408 11:41:38 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | Cycle 1(1): loaded http://localhost:43977/tests/dromaeo/cssquery-yui.html (next: http://localhost:43977/tests/dromaeo/cssquery-dojo.html) 11:44:40 INFO - PROCESS | 25990 | RSS: Main: 168214528 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | __start_tp_report 11:44:40 INFO - PROCESS | 25990 | _x_x_mozilla_page_load 11:44:40 INFO - PROCESS | 25990 | _x_x_mozilla_page_load_details 11:44:40 INFO - PROCESS | 25990 | |i|pagename|runs| 11:44:40 INFO - PROCESS | 25990 | |0;dojo.html;3137.215696075981;3168.635606905206;3178.6662400447967;3184.729298009669;3205.118592387093;5201.817936372227;5282.049231138393;5291.312129423174;5312.335958005249;5321.201819727043;5319.9202011969755;5381.730913454331;5424.566034717223;5462.317210348707;5470.507654311121;4865.245886887529;4886.560209581137;4934.358533390672;4966.354373931384;4982.202847544394;4780.976095119519;4999.3500844890295;5023.020511000356;5025.120603894322;5037.647364684473;4810.591099756525;4883.487233840467;4901.215805471125;4909.968906529633;4927.876803079952;4832.178529649968;4846.369971903665;4849.321095046696;4853.344798452199;4899.485554016848;4818.180909245437;4824.614030877557;4824.710517368934;4829.710217386968;4861.659683822134;5125.923111153335;5261.184516399964;5282.471752824726;5300.125479295912;5301.6818990860675;5667.688277144755;5706.28671416073;5712.057510510761;5720.71396430181;5737.483626473638;5670.121131224667;5751.079827227665;5752.36723960364;5752.36723960364;5776.508996735282;5280.419153893069;5371.979323928441;5376.4085950545405;5396.595255355864;5421.756020979065;5797.768089276382;5828.6211396259105;5834.504067154339;5835.824925252249;5859.2382990211;5507.201455788888;5581.581381396411;5591.7483713233005;5614.9719251403485;5641.915371269434;5723.341815691166;5727.341355744143;5732.455416735487;5738.598298119092;5782.508486778587;5658.066419040894;5678.517326027251;5693.60144789869;5693.9430605693415;5703.458171473703;5709.0865461525955;5731.828045158652;5737.655740655574;5742.425757424224;5796.1595568642315;4318.1363727254675;4372.562743725602;4376.606105450524;4389.582989615981;4410.095930334273;3858.7684738915195;3875.1280961783937;3927.998360418075;3940.4286378474962;3952.6047395260243;5399.78400863961;5414.35027796667;5451.427600102012;5464.890702185934;5486.149646804672;5662.37713851476;5694.117411801178;5704.828855134353;5710.400407957188;5721.170430287585;5469.316335458067;5483.8080667176455;5516.613837031369;5536.723163841792;5555.444455554493;4945;4967.627427942919;4979.850604481871;4982.302477653131;5000.174971129795;5955.612885162451;5959.0763431668165;5964;5970.910436343458;5984.73068711909;5689;5762.855928601818;5796.536277097738;5797.739101740516;5829.09649004405;5895.20414744004;5896.941030589639;5908.231929849092;5915.733791979457;5923.49650279731;5555.111182210827;5597.888042239214;5601.943980560142;5611.5230205433;5622.775088996558;5704.2014118024335;5753.1945527627;5772.393898640582;5788.21859049023;5815.621984570989;5528.585356098229;5549.805756798492;5567.164925261243;5571.331440227036;5579.414161513145;5483.561315094863;5584.162375643686;5586.944130558642;5594.692291923983;5614;5429.53848922846;5460.617756757148;5495.120780675073;5527.309086364205;5540.390557038803;5537;5554.305711786027;5567.109262517978;5596.86007849807;5609.719514024201;5433.429489903503;5456.236126942152;5487.478689524489;5494.697791621499;5544.584156188383 11:44:40 INFO - PROCESS | 25990 | |1;ext.html;614.7387360371844;641.7753786174839;657.5561495990205;659.8383396067964;663.9269680335162;31287.843560782192;37750.24499510012;38497.422538661944;38608.613913860856;38706.61293387065;40906;41679.79160104195;41725.37411938823;41770.582294177046;41780.37329440053;8432.53621050842;8630.870536941951;8675.045744968049;8744.081871403507;8772.078931712174;8608.569571521399;8769.079246679103;8785.560721963877;8789.340799440035;8972.10278972104;8938.391089603869;8960.327975401871;8990.235829954428;9017.053209413016;9021.864672029924;8930.55347232639;8992.77518062047;8997.190252877239;9000.05499422561;9020.323475739346;8683.522406267653;8721.996970348364;8739;8739.388242823004;8740.388172827905;41346.58653413458;42072.789636051624;42112.368314475;42172;42225.36661950073;3537.4163263061564;3562.786232826039;3652.6895213906582;3767.6232376762377;3829.6936245100605;28756.29258208319;29107.70892291071;29223;29339.70660293391;29623.555646665318;4173.916521669549;4198.412222288882;4247.7451352918615;4337.436133302682;4358.5859343362645;277503;282031;283188;283560;284297;35943.640563594556;55717.1642425364;56805.147922781194;56990;57040.429595703514;35769.64230357715;36081.45877811835;36086.639133608325;36156.63843361585;36178;15333.233338333039;15348.923255383652;15476.84523154754;15596.298166582304;15658.843411565738;12751.171173873669;12882.484700612058;12896.29070401137;12976.610701678965;13008.674783130307;8474.406791524658;8509.446885952393;8511.914880851236;8562.400631955703;8650.653973840976;3266.412045831773;3295.307985323061;3376.611689655721;3383.5601371821504;3425.6060553036223;1070.8875568065241;1085.940273284977;1094.6770702642739;1104.3594715065242;1144.227646338718;32511;32523.512147317808;32547.51178732321;33162;33292.167695807795;1132.0773569540797;1180.8095981953525;1184.2124986883625;1230.6185082624415;1249.038240554786;17015.744763828552;17066.743998840026;17177.227024783915;17223.91388043052;17290.654186916192;427287;432051;433317;436512;437185;56310.87378252412;57720;58090.4190958085;58097;58203.4179658198;1434.0391937401967;1437.5112461762842;1448.1383576771805;1448.7971683964042;1550.8991915525455;31465.685343146277;31815.522767158047;31979.84010079935;32401;32523.18692032718;51479.485205147466;52004.47995519996;52031.73984130055;52121.218181726545;52144;317425;320455;322329;322769;323533;28223.153305400872;28311.15066548007;28442.004529841357;28524.714752852207;28524.714752853037;48640.75679621579;49335.506644934525;49877.50367488981;49990.50009500004;50571.49428505815;40846.1830763389;41071.38392924168;41621.37567936544;41915.7904210477;42789.35815962825;40728.94532910103;41577.16845663009;41857;41911.1617767649;41996.37005444982;36754.26491470209;41140.794296028325;41387.7930610345;42483.57516424796;43844.12311753811;33500.32999340048;34371.65628343785;35093.29813403769;35839;35991.46012809758;27617.723822761516;28320.71679283181;28346.291342715773;28440.715592843808;28712.856435717687 11:44:40 INFO - PROCESS | 25990 | |2;jquery.html;363.75810086292614;364.7811313212072;368.29103974848425;371.40760487023203;374.08162959933367;18026.90986545067;18053.277868885245;19087.427377178672;19594.412167634993;19651.115699793507;18058;18424.447266582025;18905.24379024841;18931;19182.52043698908;5507.834764957058;5677.318721753375;5679.460451257124;5704.944585251742;5715;5466.644668096561;5537.141743029837;5601.971990140044;5629.324481062258;5632.098864181732;5474.2609747683955;5555.527780138693;5556.638818476807;5558.388577256498;5570.164475328713;5341.439148889369;5389;5521.972390138044;5555.2778138842095;5594.13290939905;4885.071836351118;4904.166291730378;4916.459189489154;4918.754062296871;4918.827841025547;12931.935340323333;14482.203478808662;20932.162713491594;22125.336239912827;22229.333120006424;2213.1921848525335;2235.966460503094;2264.8074913632363;2294.6443301288327;2546.834455760388;9020.954895225483;9233.815323693556;9302.069793020712;9324.533773311307;9661.275404344702;1831.0936086637066;1895.631007674932;1910.866239363245;1923.422973108076;1930.845532357408;80034.59982700108;80076.59961700212;81024;81245.59377203135;82573;10510.527026283835;10560.788784224273;10609.734756631146;10790.622328218475;10852.94573527143;14686.632834179018;14699.118052916645;14754.48359307419;14792;14859.479918202811;7544.849103017909;7727.995360603198;7760.883586746203;7829.882551761728;7887.684492620346;7182.964085179645;7207.783766487014;7367.77896663101;7401.407887368998;7410.444216683771;4134.627883490441;4197.286461301586;4336.609705126553;4500.077484115748;4562.840300589463;1825.8265464780825;1912.1873203888292;1937.9612407751765;1939.0886283446757;1939.873908195991;1006.8137394582026;1026.7997740440692;1051.4164638625484;1090.841827934945;1166.4750862112085;18461;18588.25646974106;18689;18763.718544221847;18990.43028709141;1001.9729776978655;1010.6361709784471;1032.4631191780231;1068.760945818509;1108.578740078765;8864.379493435526;10228.53971571281;10653.404835375584;10715.49576482312;10891.782164356828;478559;489410;489505;496541;517307;73855.63072184712;80020.19979800245;86832.56583717167;99957.50021249993;100429;1010.6917390196061;1012.9696109116738;1025.1388833379847;1047.1831971062584;1050.3225419604312;15942.934551689244;15948.681026379176;16003.759943600622;16072;16074.43739469113;36128;37486;37590.43614345841;40345.99135021648;41689.37465938074;50954.74522627363;51916.48083519116;58568;59193.112103317624;59236.40763592309;5562.915231529812;5948.821535353946;6240.687965601793;7728.956590860162;8173.346132309282;11026.283291586022;12964.22214667123;13105.2136871788;13151.342432878126;13286;11199.272047316897;11436.256643318158;11612.88387116118;11848.348340840992;11899.702507437383;11272.323660580392;11318.037966772916;11459.19785614999;11562.075033997427;11680.883191167979;11764.764704705687;11766.88233117658;11788.76422471563;11934.403279836148;11989.82015269789;8120.796980075545;8231.670733170606;8298.294644955246;8322.916770832457;8520.957395212985;8457.915420845713;11300.94349528247;11804.881951180378;11877.406129693654;11897.40512974365 11:44:40 INFO - PROCESS | 25990 | |3;mootools.html;1535.1710076558659;1538.6845696632192;1697.6265221651233;1789.7941736700284;1849.537615596102;7510.436717246201;8013.67945282188;8080.353571714263;8261.958690206548;8283.047449543297;8061;8089.1101978782435;8108.189181081889;8133.349332053436;8135.389845761562;2189.35414052854;2208.9668654970187;2226.421130506072;2232.1964092926532;2234.6759719840616;2198.7801219878043;2202.053117159621;2221.3558068160214;2250.0437314141423;2252.3805953362794;2196.769339219383;2224.1548211679537;2234.0728597631964;2245.38251980705;2245.5059886824956;2151.419116838445;2160.9243676471247;2163.0050176918635;2166.523364859728;2168.3386567097027;2204.9448763780874;2205.658122990939;2211.800937915579;2212.0598745533243;2222.511047569532;8241.340692744567;8247.257746802756;8282.461639993382;8301.750947471586;8375.120612335679;4725.905481890343;4860.465348811628;4888.9755551222015;4893.143699852511;4910.091633047862;3038.2404398900276;3122.594062771848;3148.2758965437847;3161.1780936956325;3169.635491918436;1039.6776999130218;1043.7390652336917;1053.7576357437756;1083.7994970930404;1084.8372744088372;11262.662120136409;11340.432978351131;11407;11411.429428528623;11420.486078126421;4119.114390406017;4188.685848561309;4346.521882592912;4366.825326986948;4388.363687265329;9755.902440975642;9784.217262618973;9791.559379827782;9801.215902727765;9822.361546499455;4869.561739443397;4890.682105663121;4892.828750993698;4897.975510122498;4905.386826646669;3931.4102884566973;4417.845375411845;4483.058557702853;4488.842890498882;4514;3657.250263695936;3664.340418724655;3715.7956312403076;3756.154865155318;3785.6025117362833;1120.2046546951592;1147.363213416545;1149.8620165580185;1152.4468255237366;1153.2676750263474;904.8326059678981;985.4727720669407;1003.9447830369254;1020.6019652335596;1026.0867827633413;5804.158397032406;6009.308929473166;6027.487663548647;6027.638341699512;6105.450509454082;987.698751880669;1001.0890090018048;1015.4516561056946;1029.2332212501733;1035.0580971316067;4137.234611596804;4190.601892820177;4210.7473551587;4236.216299984513;4282.122164956177;9639.71080867575;10078.697639070839;10152.137068349273;10196.4391958443;10242.743931401774;10288.331258468175;10311.535980880879;10319.380837149794;10383.325083869524;10403.063724264852;7765.72819951299;7987.400944929153;7993.360531157494;8014.118446970829;8024.598770061473;5628.352739434854;5813.069908814569;5855.765769369177;5879.5002424794375;5944.1975333331175;9462;9475;9552.95223523878;9555.04449555039;9601.423914565148;9384.34309598349;9539.809203816023;9631.855522167032;9804;9906.405615663083;6245.937540624535;6793.728250870107;6948.166220053626;7023.824404389931;7187.820304492429;7977.920220797718;8025.398095142771;8035.196480352152;8061.516309021477;8117.350611950912;7239.131304243525;7355.632218388952;7403.14863790671;7479.027726395751;7510.061242344707;7111.644417779194;7196.352328290479;7271.054762881004;7280.344768970818;7364.742234021784;6691.1636045494315;6751.49363797727;6787.592744435349;6801.081853949653;6801.761938332134;5006.874828129326;5038.823641172541;5042.495750424928;5051.141305978066;5084.2627818966785;5169.638125331191;5206.427292997691;5222.164453687544;5247.449017853223;5295.894082118413 11:44:40 INFO - PROCESS | 25990 | |4;prototype.html;284.29211263952766;297.99851000745;298.44787143784;299.8111189950331;303.76002957663445;5881.588288819784;5884.205632239647;5998.670073145975;6032.1856549365875;6084.239470066242;5955.702214889249;5967.880642387149;5970;5982.192404025455;5992.490638295739;4469.351943968123;4477.977610111953;4479.776011199427;4480.462344518663;4514.774261286939;4393.5606439356125;4504.752238626874;4506.8873278167985;4521.5930566249035;4528.071745292207;4450.264396885217;4456.286994080948;4464.665150113755;4467.262901621229;4474;4475.082608065339;4475.440569928743;4478.126765280772;4495.235809912323;4509.098180363924;3780.981095094507;3806.0865392305923;3855.20968201518;3871.128995975911;3874.7093967952233;5755.68343741094;5764.452377024176;5776.364599894008;5779.670675744603;5794.913076303858;5132.332796736438;5134.817702476433;5134.895997360548;5139.537441630271;5144.0740666679985;6114.938850611481;6249.9062514062325;6254.374562543755;6263.906041409383;6300.527460440485;4212.599803018708;4230.471191101113;4235.555266697014;4237.4915010198665;4241.681873859442;6324.81025569229;6502.512311576651;6573.967130164367;6583.802485925382;6590.5057120715655;4249.277622804131;4340.348947657813;4348.673849461303;4360.324149756792;4364.650827933758;4365.105153443536;4402.691811573223;4406.096750166208;4410.095930334273;4414.690971632019;5078.492150784892;5081.8475445736685;5096.745162741922;5100.158473851773;5120.795168193231;6086.786962456381;6132.202813634199;6172.69136543171;6328.6835658216905;6390.169277993831;1446.11064195519;1464.1873760063054;1465.8680718735366;1466.4500812195427;1466.486729644637;921.709661456639;932.9207017403461;954.6038394066385;959.8817377754976;961.5096300886598;6090.878182436327;6091.14723938649;6125.1731016313115;6127.2647282325515;6140.385961403824;6502.544821862424;6524.086627872101;6538.711450992209;6551.181102362205;6586.670666466657;6019.518438524908;6116.663583502861;6137.3862613738265;6145.293291271561;6150.630962142286;3489.5114683944266;3515.1739341255297;3517.9120521987156;3524.718022558189;3529.3823580873245;6655.334466553403;6801.081853949752;6825.249222585511;6830.419414349736;6834.794956151323;6661.367170118928;6664.933350666432;6665.533412661067;6674.632895190714;6688.531802773759;6587.769428069994;6806.353396427331;6815.556988795812;6821.761238356733;6832.965835170792;6457.289698133295;6465.515086368447;6491.253505846888;6539.084528165966;6542.247641521096;6228.781992630236;6410.711517981796;6417.358264173546;6423.229212494343;6459.967700161657;6719.361660642231;6728.226253980659;6742.224644165787;6746.595204287759;6759.560628559325;4178.164367126647;4181.581841815916;4189.685773567056;4203.159368126326;4208.347706105558;6327.430531252209;6345.904811427925;6564.4748420127235;6570.671466426564;6615.801525954229;6351.936480635134;6404.903926441014;6410.326915673787;6436.806895793134;6442.226932768098;6289.559730818799;6389.744410223725;6422.3577642235405;6429.132067170872;6434.967825160844;6249.937510623114;6267.905981410191;6276.780312689034;6284.497240220863;6322.49420046386;6434.710438030206;6457.096006558992;6483.578567393104;6497.902531462127;6506.934930650633;6189.907151392823;6270.874582508415;6297.653629050446;6305.211848518935;6335.90496142549 11:44:40 INFO - PROCESS | 25990 | |5;yui.html;812.9918700812992;835.9874601880969;844.8817165596815;845.627923713566;880.7137680253911;14723.779143312859;14907.627309317273;14941.17823519706;14949.10305381675;15012.399504019826;13692;13776.311184440789;13787.862121378783;13799.103058301203;13804.792928106086;668.4485299627802;786.4416264452217;811.975640730779;817.342039658075;819.0335404223015;802.5465611929242;804.1958041958042;805.6535689653447;806.5241507510567;808.5552945879772;828.2752591482453;830.9584520773938;832.0431503770652;832.9292010179142;836.3351135846985;824.2787560884226;830.7756905635505;831.9708810191645;832.4256263178448;832.7793134819278;609.8261995331309;615.1111643674892;615.1725928625991;616.3866952382408;618.0698049435571;14129.576112716635;14162.575122746333;14167.291635418187;14206;14259.073160244654;13279.00407469434;13569.864301356958;13689.31553422335;13709.45162193521;13758.31208439584;11107.278026928223;11231.831522527169;11470.197086203969;11476.311421314664;11512.884871151266;3795.886123416274;3803.6006219347123;3818.198178382543;3839.155385815144;3913.4521167036637;50884;50995.745021274655;51007.489925101014;51056;51479.22781158286;10460.738481538023;10848.78302433947;10918.617848375268;11097.778044439066;11208.439578021229;18620.813791861907;18658.067096645114;18710.064496775107;18756.155972981247;18808.623827523374;8517.318614510825;8655.870161947576;8698.95650521756;8718.084601116918;9007.144321289466;4829.13075646387;4884.389451318585;4912.164931961575;4997.600191984632;5000.049990501793;3299.290652509674;3388.102152929476;3718.888433347004;3870.9419358709642;3875.96124038756;702.9683664235122;716.4841314253729;719.5071376107384;720.4164626652429;722.6711846110007;667.1160712056544;710.948508145257;718.737660753821;734.6326836581709;744.5755919126046;9511.857322140173;9925.50372481373;9967.302288839712;9981.80036399268;10070.345427547187;582.9417058294136;648.7826578096297;746.2649290448903;756.2513112019061;766.3294617209941;4646.465656449484;4824.445188803333;4831.879203019882;4834.984653222863;4849.466558678542;66368;75730.62134689401;79064.20935790683;79697.60151199206;79903.60048199721;57525.42474575285;58329.70835145797;59365;59787.10319345213;61997.380026200066;54586.45413545814;55448;55765;56167;56870;9854.310198286052;10065.597376105166;10156.847647285149;10171.186305095722;10174.38953662753;30552.694473054984;31241.37517249688;31259.374812504077;32272.354552908342;35386;42268.577314226466;42300.57699422966;42351;42581;43059.138817222854;12879.291638959572;12880.162789418659;12913.870861291643;13066.346682666019;13085.869141308465;13186.406611702305;13392.732145356844;13408.731825363244;13413;13419.86580134186;11700.414979250832;11794.646160615195;12178.695532611755;12194.939025304817;12420.751584968431;13124.606261812161;13179.275139867399;13798.241096739775;13890.86109138936;13904.51334203298;13120.147190432592;13512.324383780968;13578.592642220749;13739;13767.586972390844;10473.68578942633;10493.9475302623;10929.071028962628;11023.44882755875;11253.66239012831;10994.505247263733;10999.175061870552;11070.335779853234;11120.332780033224;11269.267497612629 11:44:40 INFO - PROCESS | 25990 | __end_tp_report 11:44:40 INFO - PROCESS | 25990 | __start_cc_report 11:44:40 INFO - PROCESS | 25990 | _x_x_mozilla_cycle_collect,332 11:44:40 INFO - PROCESS | 25990 | __end_cc_report 11:44:40 INFO - PROCESS | 25990 | __startTimestamp1461264280931__endTimestamp 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | ------- Summary: start ------- 11:44:40 INFO - PROCESS | 25990 | Number of tests: 6 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | [#0] dojo.html Cycles:165 Average:5321.56 Median:5527.31 stddev:589.99 (10.7%) stddev-sans-first:566.37 11:44:40 INFO - PROCESS | 25990 | Values: 3137.2 3168.6 3178.7 3184.7 3205.1 5201.8 5282.0 5291.3 5312.3 5321.2 5319.9 5381.7 5424.6 5462.3 5470.5 4865.2 4886.6 4934.4 4966.4 4982.2 4781.0 4999.4 5023.0 5025.1 5037.6 4810.6 4883.5 4901.2 4910.0 4927.9 4832.2 4846.4 4849.3 4853.3 4899.5 4818.2 4824.6 4824.7 4829.7 4861.7 5125.9 5261.2 5282.5 5300.1 5301.7 5667.7 5706.3 5712.1 5720.7 5737.5 5670.1 5751.1 5752.4 5752.4 5776.5 5280.4 5372.0 5376.4 5396.6 5421.8 5797.8 5828.6 5834.5 5835.8 5859.2 5507.2 5581.6 5591.7 5615.0 5641.9 5723.3 5727.3 5732.5 5738.6 5782.5 5658.1 5678.5 5693.6 5693.9 5703.5 5709.1 5731.8 5737.7 5742.4 5796.2 4318.1 4372.6 4376.6 4389.6 4410.1 3858.8 3875.1 3928.0 3940.4 3952.6 5399.8 5414.4 5451.4 5464.9 5486.1 5662.4 5694.1 5704.8 5710.4 5721.2 5469.3 5483.8 5516.6 5536.7 5555.4 4945.0 4967.6 4979.9 4982.3 5000.2 5955.6 5959.1 5964.0 5970.9 5984.7 5689.0 5762.9 5796.5 5797.7 5829.1 5895.2 5896.9 5908.2 5915.7 5923.5 5555.1 5597.9 5601.9 5611.5 5622.8 5704.2 5753.2 5772.4 5788.2 5815.6 5528.6 5549.8 5567.2 5571.3 5579.4 5483.6 5584.2 5586.9 5594.7 5614.0 5429.5 5460.6 5495.1 5527.3 5540.4 5537.0 5554.3 5567.1 5596.9 5609.7 5433.4 5456.2 5487.5 5494.7 5544.6 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | [#1] ext.html Cycles:180 Average:50808.11 Median:38657.61 stddev:92646.86 (239.7%) stddev-sans-first:92830.11 11:44:40 INFO - PROCESS | 25990 | Values: 614.7 641.8 657.6 659.8 663.9 31287.8 37750.2 38497.4 38608.6 38706.6 40906.0 41679.8 41725.4 41770.6 41780.4 8432.5 8630.9 8675.0 8744.1 8772.1 8608.6 8769.1 8785.6 8789.3 8972.1 8938.4 8960.3 8990.2 9017.1 9021.9 8930.6 8992.8 8997.2 9000.1 9020.3 8683.5 8722.0 8739.0 8739.4 8740.4 41346.6 42072.8 42112.4 42172.0 42225.4 3537.4 3562.8 3652.7 3767.6 3829.7 28756.3 29107.7 29223.0 29339.7 29623.6 4173.9 4198.4 4247.7 4337.4 4358.6 277503.0 282031.0 283188.0 283560.0 284297.0 35943.6 55717.2 56805.1 56990.0 57040.4 35769.6 36081.5 36086.6 36156.6 36178.0 15333.2 15348.9 15476.8 15596.3 15658.8 12751.2 12882.5 12896.3 12976.6 13008.7 8474.4 8509.4 8511.9 8562.4 8650.7 3266.4 3295.3 3376.6 3383.6 3425.6 1070.9 1085.9 1094.7 1104.4 1144.2 32511.0 32523.5 32547.5 33162.0 33292.2 1132.1 1180.8 1184.2 1230.6 1249.0 17015.7 17066.7 17177.2 17223.9 17290.7 427287.0 432051.0 433317.0 436512.0 437185.0 56310.9 57720.0 58090.4 58097.0 58203.4 1434.0 1437.5 1448.1 1448.8 1550.9 31465.7 31815.5 31979.8 32401.0 32523.2 51479.5 52004.5 52031.7 52121.2 52144.0 317425.0 320455.0 322329.0 322769.0 323533.0 28223.2 28311.2 28442.0 28524.7 28524.7 48640.8 49335.5 49877.5 49990.5 50571.5 40846.2 41071.4 41621.4 41915.8 42789.4 40728.9 41577.2 41857.0 41911.2 41996.4 36754.3 41140.8 41387.8 42483.6 43844.1 33500.3 34371.7 35093.3 35839.0 35991.5 27617.7 28320.7 28346.3 28440.7 28712.9 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | [#2] jquery.html Cycles:180 Average:28440.09 Median:2250.39 stddev:81492.11 (3621.2%) stddev-sans-first:81693.45 11:44:40 INFO - PROCESS | 25990 | Values: 363.8 364.8 368.3 371.4 374.1 18026.9 18053.3 19087.4 19594.4 19651.1 18058.0 18424.4 18905.2 18931.0 19182.5 5507.8 5677.3 5679.5 5704.9 5715.0 5466.6 5537.1 5602.0 5629.3 5632.1 5474.3 5555.5 5556.6 5558.4 5570.2 5341.4 5389.0 5522.0 5555.3 5594.1 4885.1 4904.2 4916.5 4918.8 4918.8 12931.9 14482.2 20932.2 22125.3 22229.3 2213.2 2236.0 2264.8 2294.6 2546.8 9021.0 9233.8 9302.1 9324.5 9661.3 1831.1 1895.6 1910.9 1923.4 1930.8 80034.6 80076.6 81024.0 81245.6 82573.0 10510.5 10560.8 10609.7 10790.6 10852.9 14686.6 14699.1 14754.5 14792.0 14859.5 7544.8 7728.0 7760.9 7829.9 7887.7 7183.0 7207.8 7367.8 7401.4 7410.4 4134.6 4197.3 4336.6 4500.1 4562.8 1825.8 1912.2 1938.0 1939.1 1939.9 1006.8 1026.8 1051.4 1090.8 1166.5 18461.0 18588.3 18689.0 18763.7 18990.4 1002.0 1010.6 1032.5 1068.8 1108.6 8864.4 10228.5 10653.4 10715.5 10891.8 478559.0 489410.0 489505.0 496541.0 517307.0 73855.6 80020.2 86832.6 99957.5 100429.0 1010.7 1013.0 1025.1 1047.2 1050.3 15942.9 15948.7 16003.8 16072.0 16074.4 36128.0 37486.0 37590.4 40346.0 41689.4 50954.7 51916.5 58568.0 59193.1 59236.4 5562.9 5948.8 6240.7 7729.0 8173.3 11026.3 12964.2 13105.2 13151.3 13286.0 11199.3 11436.3 11612.9 11848.3 11899.7 11272.3 11318.0 11459.2 11562.1 11680.9 11764.8 11766.9 11788.8 11934.4 11989.8 8120.8 8231.7 8298.3 8322.9 8521.0 8457.9 11300.9 11804.9 11877.4 11897.4 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | [#3] mootools.html Cycles:180 Average:5497.17 Median:4891.76 stddev:3068.42 (62.7%) stddev-sans-first:3062.58 11:44:40 INFO - PROCESS | 25990 | Values: 1535.2 1538.7 1697.6 1789.8 1849.5 7510.4 8013.7 8080.4 8262.0 8283.0 8061.0 8089.1 8108.2 8133.3 8135.4 2189.4 2209.0 2226.4 2232.2 2234.7 2198.8 2202.1 2221.4 2250.0 2252.4 2196.8 2224.2 2234.1 2245.4 2245.5 2151.4 2160.9 2163.0 2166.5 2168.3 2204.9 2205.7 2211.8 2212.1 2222.5 8241.3 8247.3 8282.5 8301.8 8375.1 4725.9 4860.5 4889.0 4893.1 4910.1 3038.2 3122.6 3148.3 3161.2 3169.6 1039.7 1043.7 1053.8 1083.8 1084.8 11262.7 11340.4 11407.0 11411.4 11420.5 4119.1 4188.7 4346.5 4366.8 4388.4 9755.9 9784.2 9791.6 9801.2 9822.4 4869.6 4890.7 4892.8 4898.0 4905.4 3931.4 4417.8 4483.1 4488.8 4514.0 3657.3 3664.3 3715.8 3756.2 3785.6 1120.2 1147.4 1149.9 1152.4 1153.3 904.8 985.5 1003.9 1020.6 1026.1 5804.2 6009.3 6027.5 6027.6 6105.5 987.7 1001.1 1015.5 1029.2 1035.1 4137.2 4190.6 4210.7 4236.2 4282.1 9639.7 10078.7 10152.1 10196.4 10242.7 10288.3 10311.5 10319.4 10383.3 10403.1 7765.7 7987.4 7993.4 8014.1 8024.6 5628.4 5813.1 5855.8 5879.5 5944.2 9462.0 9475.0 9553.0 9555.0 9601.4 9384.3 9539.8 9631.9 9804.0 9906.4 6245.9 6793.7 6948.2 7023.8 7187.8 7977.9 8025.4 8035.2 8061.5 8117.4 7239.1 7355.6 7403.1 7479.0 7510.1 7111.6 7196.4 7271.1 7280.3 7364.7 6691.2 6751.5 6787.6 6801.1 6801.8 5006.9 5038.8 5042.5 5051.1 5084.3 5169.6 5206.4 5222.2 5247.4 5295.9 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | [#4] prototype.html Cycles:180 Average:5250.60 Median:6120.92 stddev:1639.34 (26.8%) stddev-sans-first:1601.00 11:44:40 INFO - PROCESS | 25990 | Values: 284.3 298.0 298.4 299.8 303.8 5881.6 5884.2 5998.7 6032.2 6084.2 5955.7 5967.9 5970.0 5982.2 5992.5 4469.4 4478.0 4479.8 4480.5 4514.8 4393.6 4504.8 4506.9 4521.6 4528.1 4450.3 4456.3 4464.7 4467.3 4474.0 4475.1 4475.4 4478.1 4495.2 4509.1 3781.0 3806.1 3855.2 3871.1 3874.7 5755.7 5764.5 5776.4 5779.7 5794.9 5132.3 5134.8 5134.9 5139.5 5144.1 6114.9 6249.9 6254.4 6263.9 6300.5 4212.6 4230.5 4235.6 4237.5 4241.7 6324.8 6502.5 6574.0 6583.8 6590.5 4249.3 4340.3 4348.7 4360.3 4364.7 4365.1 4402.7 4406.1 4410.1 4414.7 5078.5 5081.8 5096.7 5100.2 5120.8 6086.8 6132.2 6172.7 6328.7 6390.2 1446.1 1464.2 1465.9 1466.5 1466.5 921.7 932.9 954.6 959.9 961.5 6090.9 6091.1 6125.2 6127.3 6140.4 6502.5 6524.1 6538.7 6551.2 6586.7 6019.5 6116.7 6137.4 6145.3 6150.6 3489.5 3515.2 3517.9 3524.7 3529.4 6655.3 6801.1 6825.2 6830.4 6834.8 6661.4 6664.9 6665.5 6674.6 6688.5 6587.8 6806.4 6815.6 6821.8 6833.0 6457.3 6465.5 6491.3 6539.1 6542.2 6228.8 6410.7 6417.4 6423.2 6460.0 6719.4 6728.2 6742.2 6746.6 6759.6 4178.2 4181.6 4189.7 4203.2 4208.3 6327.4 6345.9 6564.5 6570.7 6615.8 6351.9 6404.9 6410.3 6436.8 6442.2 6289.6 6389.7 6422.4 6429.1 6435.0 6249.9 6267.9 6276.8 6284.5 6322.5 6434.7 6457.1 6483.6 6497.9 6506.9 6189.9 6270.9 6297.7 6305.2 6335.9 11:44:40 INFO - PROCESS | 25990 | 11:44:40 INFO - PROCESS | 25990 | [#5] yui.html Cycles:180 Average:15407.20 Median:42284.58 stddev:18480.90 (43.7%) stddev-sans-first:18500.25 11:44:40 INFO - PROCESS | 25990 | Values: 813.0 836.0 844.9 845.6 880.7 14723.8 14907.6 14941.2 14949.1 15012.4 13692.0 13776.3 13787.9 13799.1 13804.8 668.4 786.4 812.0 817.3 819.0 802.5 804.2 805.7 806.5 808.6 828.3 831.0 832.0 832.9 836.3 824.3 830.8 832.0 832.4 832.8 609.8 615.1 615.2 616.4 618.1 14129.6 14162.6 14167.3 14206.0 14259.1 13279.0 13569.9 13689.3 13709.5 13758.3 11107.3 11231.8 11470.2 11476.3 11512.9 3795.9 3803.6 3818.2 3839.2 3913.5 50884.0 50995.7 51007.5 51056.0 51479.2 10460.7 10848.8 10918.6 11097.8 11208.4 18620.8 18658.1 18710.1 18756.2 18808.6 8517.3 8655.9 8699.0 8718.1 9007.1 4829.1 4884.4 4912.2 4997.6 5000.0 3299.3 3388.1 3718.9 3870.9 3876.0 703.0 716.5 719.5 720.4 722.7 667.1 710.9 718.7 734.6 744.6 9511.9 9925.5 9967.3 9981.8 10070.3 582.9 648.8 746.3 756.3 766.3 4646.5 4824.4 4831.9 4835.0 4849.5 66368.0 75730.6 79064.2 79697.6 79903.6 57525.4 58329.7 59365.0 59787.1 61997.4 54586.5 55448.0 55765.0 56167.0 56870.0 9854.3 10065.6 10156.8 10171.2 10174.4 30552.7 31241.4 31259.4 32272.4 35386.0 42268.6 42300.6 42351.0 42581.0 43059.1 12879.3 12880.2 12913.9 13066.3 13085.9 13186.4 13392.7 13408.7 13413.0 13419.9 11700.4 11794.6 12178.7 12194.9 12420.8 13124.6 13179.3 13798.2 13890.9 13904.5 13120.1 13512.3 13578.6 13739.0 13767.6 10473.7 10493.9 10929.1 11023.4 11253.7 10994.5 10999.2 11070.3 11120.3 11269.3 11:44:40 INFO - PROCESS | 25990 | -------- Summary: end -------- 11:44:40 INFO - PROCESS | 25990 | 11:44:41 INFO - TEST-INFO | 25990: exit 0 11:44:41 INFO - TEST-OK | dromaeo_css | took 1109572ms 11:44:41 INFO - TEST-START | kraken 11:44:41 INFO - operating with platform_type : linux_ 11:44:41 INFO - Initialising browser for kraken test... 11:44:41 INFO - TEST-INFO | started process 26223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3k_2p/profile http://localhost:43977/getInfo.html) 11:44:45 INFO - PROCESS | 26223 | 11:44:45 INFO - PROCESS | 26223 | (process:26294): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:44:45 INFO - PROCESS | 26223 | __metrics Screen width/height:1600/1200 11:44:45 INFO - PROCESS | 26223 | colorDepth:24 11:44:45 INFO - PROCESS | 26223 | Browser inner width/height: 1024/697 11:44:45 INFO - PROCESS | 26223 | __metrics 11:44:46 ERROR - PROCESS | 26223 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:44:47 INFO - TEST-INFO | 26223: exit 0 11:44:47 INFO - Browser initialized. 11:44:47 INFO - Running cycle 1/1 for kraken test... 11:44:47 INFO - TEST-INFO | started process 26345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3k_2p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:49 INFO - PROCESS | 26345 | 11:44:49 INFO - PROCESS | 26345 | (process:26407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:44:59 INFO - PROCESS | 26345 | RSS: Main: 163438592 11:44:59 INFO - PROCESS | 26345 | 11:45:01 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43977/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:02 INFO - PROCESS | 26345 | RSS: Main: 168431616 11:45:02 INFO - PROCESS | 26345 | 11:45:05 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43977/tests/kraken/driver.html?testName=audio-dft) 11:45:06 INFO - PROCESS | 26345 | RSS: Main: 172060672 11:45:06 INFO - PROCESS | 26345 | 11:45:08 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43977/tests/kraken/driver.html?testName=audio-fft) 11:45:09 INFO - PROCESS | 26345 | RSS: Main: 164306944 11:45:09 INFO - PROCESS | 26345 | 11:45:11 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43977/tests/kraken/driver.html?testName=audio-oscillator) 11:45:12 INFO - PROCESS | 26345 | RSS: Main: 163676160 11:45:12 INFO - PROCESS | 26345 | 11:45:14 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:15 INFO - PROCESS | 26345 | RSS: Main: 164065280 11:45:15 INFO - PROCESS | 26345 | 11:45:18 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43977/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:18 INFO - PROCESS | 26345 | RSS: Main: 165117952 11:45:18 INFO - PROCESS | 26345 | 11:45:22 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43977/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:22 INFO - PROCESS | 26345 | RSS: Main: 165076992 11:45:22 INFO - PROCESS | 26345 | 11:45:25 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43977/tests/kraken/driver.html?testName=json-parse-financial) 11:45:26 INFO - PROCESS | 26345 | RSS: Main: 165711872 11:45:26 INFO - PROCESS | 26345 | 11:45:27 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:28 INFO - PROCESS | 26345 | RSS: Main: 165494784 11:45:28 INFO - PROCESS | 26345 | 11:45:30 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:30 INFO - PROCESS | 26345 | RSS: Main: 165273600 11:45:30 INFO - PROCESS | 26345 | 11:45:33 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:33 INFO - PROCESS | 26345 | RSS: Main: 165593088 11:45:33 INFO - PROCESS | 26345 | 11:45:36 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:36 INFO - PROCESS | 26345 | RSS: Main: 166154240 11:45:36 INFO - PROCESS | 26345 | 11:45:39 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:40 INFO - PROCESS | 26345 | RSS: Main: 165949440 11:45:40 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | Cycle 1(1): loaded http://localhost:43977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43977/tests/kraken/driver.html?testName=ai-astar) 11:45:42 INFO - PROCESS | 26345 | RSS: Main: 167575552 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | __start_tp_report 11:45:42 INFO - PROCESS | 26345 | _x_x_mozilla_page_load 11:45:42 INFO - PROCESS | 26345 | _x_x_mozilla_page_load_details 11:45:42 INFO - PROCESS | 26345 | |i|pagename|runs| 11:45:42 INFO - PROCESS | 26345 | |0;ai-astar;112;105;112;109;112;123;111;111;110;110 11:45:42 INFO - PROCESS | 26345 | |1;audio-beat-detection;161;140;160;195;132;153;156;131;196;129 11:45:42 INFO - PROCESS | 26345 | |2;audio-dft;160;162;161;161;162;165;166;161;166;162 11:45:42 INFO - PROCESS | 26345 | |3;audio-fft;73;74;73;154;74;76;74;73;164;78 11:45:42 INFO - PROCESS | 26345 | |4;audio-oscillator;93;92;148;94;93;94;148;92;93;158 11:45:42 INFO - PROCESS | 26345 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;118;117 11:45:42 INFO - PROCESS | 26345 | |6;imaging-darkroom;147;147;148;146;147;148;145;146;146;147 11:45:42 INFO - PROCESS | 26345 | |7;imaging-desaturate;97;95;100;95;96;95;96;95;95;95 11:45:42 INFO - PROCESS | 26345 | |8;json-parse-financial;58;58;59;57;57;59;58;82;56;56 11:45:42 INFO - PROCESS | 26345 | |9;json-stringify-tinderbox;62;61;61;63;62;61;61;63;61;62 11:45:42 INFO - PROCESS | 26345 | |10;stanford-crypto-aes;85;78;78;79;79;79;78;80;88;80 11:45:42 INFO - PROCESS | 26345 | |11;stanford-crypto-ccm;131;142;127;124;125;127;124;128;158;128 11:45:42 INFO - PROCESS | 26345 | |12;stanford-crypto-pbkdf2;169;173;169;167;168;168;174;174;171;172 11:45:42 INFO - PROCESS | 26345 | |13;stanford-crypto-sha256-iterative;72;69;68;71;70;68;69;67;68;68 11:45:42 INFO - PROCESS | 26345 | __end_tp_report 11:45:42 INFO - PROCESS | 26345 | __start_cc_report 11:45:42 INFO - PROCESS | 26345 | _x_x_mozilla_cycle_collect,850 11:45:42 INFO - PROCESS | 26345 | __end_cc_report 11:45:42 INFO - PROCESS | 26345 | __startTimestamp1461264342319__endTimestamp 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | ------- Summary: start ------- 11:45:42 INFO - PROCESS | 26345 | Number of tests: 14 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:4.55 (4.1%) stddev-sans-first:4.82 11:45:42 INFO - PROCESS | 26345 | Values: 112.0 105.0 112.0 109.0 112.0 123.0 111.0 111.0 110.0 110.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:158.00 stddev:24.39 (15.4%) stddev-sans-first:25.78 11:45:42 INFO - PROCESS | 26345 | Values: 161.0 140.0 160.0 195.0 132.0 153.0 156.0 131.0 196.0 129.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.22 (1.4%) stddev-sans-first:2.15 11:45:42 INFO - PROCESS | 26345 | Values: 160.0 162.0 161.0 161.0 162.0 165.0 166.0 161.0 166.0 162.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#3] audio-fft Cycles:10 Average:91.30 Median:74.00 stddev:35.79 (48.4%) stddev-sans-first:37.35 11:45:42 INFO - PROCESS | 26345 | Values: 73.0 74.0 73.0 154.0 74.0 76.0 74.0 73.0 164.0 78.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:93.00 stddev:28.32 (30.4%) stddev-sans-first:29.32 11:45:42 INFO - PROCESS | 26345 | Values: 93.0 92.0 148.0 94.0 93.0 94.0 148.0 92.0 93.0 158.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:45:42 INFO - PROCESS | 26345 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 11:45:42 INFO - PROCESS | 26345 | Values: 147.0 147.0 148.0 146.0 147.0 148.0 145.0 146.0 146.0 147.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.64 11:45:42 INFO - PROCESS | 26345 | Values: 97.0 95.0 100.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:58.00 stddev:7.80 (13.5%) stddev-sans-first:8.24 11:45:42 INFO - PROCESS | 26345 | Values: 58.0 58.0 59.0 57.0 57.0 59.0 58.0 82.0 56.0 56.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 11:45:42 INFO - PROCESS | 26345 | Values: 62.0 61.0 61.0 63.0 62.0 61.0 61.0 63.0 61.0 62.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.50 stddev:3.37 (4.2%) stddev-sans-first:3.14 11:45:42 INFO - PROCESS | 26345 | Values: 85.0 78.0 78.0 79.0 79.0 79.0 78.0 80.0 88.0 80.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:128.00 stddev:10.71 (8.4%) stddev-sans-first:11.36 11:45:42 INFO - PROCESS | 26345 | Values: 131.0 142.0 127.0 124.0 125.0 127.0 124.0 128.0 158.0 128.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:2.64 (1.5%) stddev-sans-first:2.74 11:45:42 INFO - PROCESS | 26345 | Values: 169.0 173.0 169.0 167.0 168.0 168.0 174.0 174.0 171.0 172.0 11:45:42 INFO - PROCESS | 26345 | 11:45:42 INFO - PROCESS | 26345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.56 (2.3%) stddev-sans-first:1.22 11:45:42 INFO - PROCESS | 26345 | Values: 72.0 69.0 68.0 71.0 70.0 68.0 69.0 67.0 68.0 68.0 11:45:42 INFO - PROCESS | 26345 | -------- Summary: end -------- 11:45:42 INFO - PROCESS | 26345 | 11:45:43 INFO - TEST-INFO | 26345: exit 0 11:45:43 INFO - TEST-OK | kraken | took 61689ms 11:45:43 INFO - SUITE-END | took 1171s 11:45:43 INFO - Completed test suite (00:19:31) 11:45:43 INFO - javascript benchmark 11:45:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.215696075981, 3168.635606905206, 3178.6662400447967, 3184.729298009669, 3205.118592387093, 5201.817936372227, 5282.049231138393, 5291.312129423174, 5312.335958005249, 5321.201819727043, 5319.9202011969755, 5381.730913454331, 5424.566034717223, 5462.317210348707, 5470.507654311121, 4865.245886887529, 4886.560209581137, 4934.358533390672, 4966.354373931384, 4982.202847544394, 4780.976095119519, 4999.3500844890295, 5023.020511000356, 5025.120603894322, 5037.647364684473, 4810.591099756525, 4883.487233840467, 4901.215805471125, 4909.968906529633, 4927.876803079952, 4832.178529649968, 4846.369971903665, 4849.321095046696, 4853.344798452199, 4899.485554016848, 4818.180909245437, 4824.614030877557, 4824.710517368934, 4829.710217386968, 4861.659683822134, 5125.923111153335, 5261.184516399964, 5282.471752824726, 5300.125479295912, 5301.6818990860675, 5667.688277144755, 5706.28671416073, 5712.057510510761, 5720.71396430181, 5737.483626473638, 5670.121131224667, 5751.079827227665, 5752.36723960364, 5752.36723960364, 5776.508996735282, 5280.419153893069, 5371.979323928441, 5376.4085950545405, 5396.595255355864, 5421.756020979065, 5797.768089276382, 5828.6211396259105, 5834.504067154339, 5835.824925252249, 5859.2382990211, 5507.201455788888, 5581.581381396411, 5591.7483713233005, 5614.9719251403485, 5641.915371269434, 5723.341815691166, 5727.341355744143, 5732.455416735487, 5738.598298119092, 5782.508486778587, 5658.066419040894, 5678.517326027251, 5693.60144789869, 5693.9430605693415, 5703.458171473703, 5709.0865461525955, 5731.828045158652, 5737.655740655574, 5742.425757424224, 5796.1595568642315, 4318.1363727254675, 4372.562743725602, 4376.606105450524, 4389.582989615981, 4410.095930334273, 3858.7684738915195, 3875.1280961783937, 3927.998360418075, 3940.4286378474962, 3952.6047395260243, 5399.78400863961, 5414.35027796667, 5451.427600102012, 5464.890702185934, 5486.149646804672, 5662.37713851476, 5694.117411801178, 5704.828855134353, 5710.400407957188, 5721.170430287585, 5469.316335458067, 5483.8080667176455, 5516.613837031369, 5536.723163841792, 5555.444455554493, 4945.0, 4967.627427942919, 4979.850604481871, 4982.302477653131, 5000.174971129795, 5955.612885162451, 5959.0763431668165, 5964.0, 5970.910436343458, 5984.73068711909, 5689.0, 5762.855928601818, 5796.536277097738, 5797.739101740516, 5829.09649004405, 5895.20414744004, 5896.941030589639, 5908.231929849092, 5915.733791979457, 5923.49650279731, 5555.111182210827, 5597.888042239214, 5601.943980560142, 5611.5230205433, 5622.775088996558, 5704.2014118024335, 5753.1945527627, 5772.393898640582, 5788.21859049023, 5815.621984570989, 5528.585356098229, 5549.805756798492, 5567.164925261243, 5571.331440227036, 5579.414161513145, 5483.561315094863, 5584.162375643686, 5586.944130558642, 5594.692291923983, 5614.0, 5429.53848922846, 5460.617756757148, 5495.120780675073, 5527.309086364205, 5540.390557038803, 5537.0, 5554.305711786027, 5567.109262517978, 5596.86007849807, 5609.719514024201, 5433.429489903503, 5456.236126942152, 5487.478689524489, 5494.697791621499, 5544.584156188383], "value": 5282.869620021319, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.7387360371844, 641.7753786174839, 657.5561495990205, 659.8383396067964, 663.9269680335162, 31287.843560782192, 37750.24499510012, 38497.422538661944, 38608.613913860856, 38706.61293387065, 40906.0, 41679.79160104195, 41725.37411938823, 41770.582294177046, 41780.37329440053, 8432.53621050842, 8630.870536941951, 8675.045744968049, 8744.081871403507, 8772.078931712174, 8608.569571521399, 8769.079246679103, 8785.560721963877, 8789.340799440035, 8972.10278972104, 8938.391089603869, 8960.327975401871, 8990.235829954428, 9017.053209413016, 9021.864672029924, 8930.55347232639, 8992.77518062047, 8997.190252877239, 9000.05499422561, 9020.323475739346, 8683.522406267653, 8721.996970348364, 8739.0, 8739.388242823004, 8740.388172827905, 41346.58653413458, 42072.789636051624, 42112.368314475, 42172.0, 42225.36661950073, 3537.4163263061564, 3562.786232826039, 3652.6895213906582, 3767.6232376762377, 3829.6936245100605, 28756.29258208319, 29107.70892291071, 29223.0, 29339.70660293391, 29623.555646665318, 4173.916521669549, 4198.412222288882, 4247.7451352918615, 4337.436133302682, 4358.5859343362645, 277503.0, 282031.0, 283188.0, 283560.0, 284297.0, 35943.640563594556, 55717.1642425364, 56805.147922781194, 56990.0, 57040.429595703514, 35769.64230357715, 36081.45877811835, 36086.639133608325, 36156.63843361585, 36178.0, 15333.233338333039, 15348.923255383652, 15476.84523154754, 15596.298166582304, 15658.843411565738, 12751.171173873669, 12882.484700612058, 12896.29070401137, 12976.610701678965, 13008.674783130307, 8474.406791524658, 8509.446885952393, 8511.914880851236, 8562.400631955703, 8650.653973840976, 3266.412045831773, 3295.307985323061, 3376.611689655721, 3383.5601371821504, 3425.6060553036223, 1070.8875568065241, 1085.940273284977, 1094.6770702642739, 1104.3594715065242, 1144.227646338718, 32511.0, 32523.512147317808, 32547.51178732321, 33162.0, 33292.167695807795, 1132.0773569540797, 1180.8095981953525, 1184.2124986883625, 1230.6185082624415, 1249.038240554786, 17015.744763828552, 17066.743998840026, 17177.227024783915, 17223.91388043052, 17290.654186916192, 427287.0, 432051.0, 433317.0, 436512.0, 437185.0, 56310.87378252412, 57720.0, 58090.4190958085, 58097.0, 58203.4179658198, 1434.0391937401967, 1437.5112461762842, 1448.1383576771805, 1448.7971683964042, 1550.8991915525455, 31465.685343146277, 31815.522767158047, 31979.84010079935, 32401.0, 32523.18692032718, 51479.485205147466, 52004.47995519996, 52031.73984130055, 52121.218181726545, 52144.0, 317425.0, 320455.0, 322329.0, 322769.0, 323533.0, 28223.153305400872, 28311.15066548007, 28442.004529841357, 28524.714752852207, 28524.714752853037, 48640.75679621579, 49335.506644934525, 49877.50367488981, 49990.50009500004, 50571.49428505815, 40846.1830763389, 41071.38392924168, 41621.37567936544, 41915.7904210477, 42789.35815962825, 40728.94532910103, 41577.16845663009, 41857.0, 41911.1617767649, 41996.37005444982, 36754.26491470209, 41140.794296028325, 41387.7930610345, 42483.57516424796, 43844.12311753811, 33500.32999340048, 34371.65628343785, 35093.29813403769, 35839.0, 35991.46012809758, 27617.723822761516, 28320.71679283181, 28346.291342715773, 28440.715592843808, 28712.856435717687], "value": 18543.1953385823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.75810086292614, 364.7811313212072, 368.29103974848425, 371.40760487023203, 374.08162959933367, 18026.90986545067, 18053.277868885245, 19087.427377178672, 19594.412167634993, 19651.115699793507, 18058.0, 18424.447266582025, 18905.24379024841, 18931.0, 19182.52043698908, 5507.834764957058, 5677.318721753375, 5679.460451257124, 5704.944585251742, 5715.0, 5466.644668096561, 5537.141743029837, 5601.971990140044, 5629.324481062258, 5632.098864181732, 5474.2609747683955, 5555.527780138693, 5556.638818476807, 5558.388577256498, 5570.164475328713, 5341.439148889369, 5389.0, 5521.972390138044, 5555.2778138842095, 5594.13290939905, 4885.071836351118, 4904.166291730378, 4916.459189489154, 4918.754062296871, 4918.827841025547, 12931.935340323333, 14482.203478808662, 20932.162713491594, 22125.336239912827, 22229.333120006424, 2213.1921848525335, 2235.966460503094, 2264.8074913632363, 2294.6443301288327, 2546.834455760388, 9020.954895225483, 9233.815323693556, 9302.069793020712, 9324.533773311307, 9661.275404344702, 1831.0936086637066, 1895.631007674932, 1910.866239363245, 1923.422973108076, 1930.845532357408, 80034.59982700108, 80076.59961700212, 81024.0, 81245.59377203135, 82573.0, 10510.527026283835, 10560.788784224273, 10609.734756631146, 10790.622328218475, 10852.94573527143, 14686.632834179018, 14699.118052916645, 14754.48359307419, 14792.0, 14859.479918202811, 7544.849103017909, 7727.995360603198, 7760.883586746203, 7829.882551761728, 7887.684492620346, 7182.964085179645, 7207.783766487014, 7367.77896663101, 7401.407887368998, 7410.444216683771, 4134.627883490441, 4197.286461301586, 4336.609705126553, 4500.077484115748, 4562.840300589463, 1825.8265464780825, 1912.1873203888292, 1937.9612407751765, 1939.0886283446757, 1939.873908195991, 1006.8137394582026, 1026.7997740440692, 1051.4164638625484, 1090.841827934945, 1166.4750862112085, 18461.0, 18588.25646974106, 18689.0, 18763.718544221847, 18990.43028709141, 1001.9729776978655, 1010.6361709784471, 1032.4631191780231, 1068.760945818509, 1108.578740078765, 8864.379493435526, 10228.53971571281, 10653.404835375584, 10715.49576482312, 10891.782164356828, 478559.0, 489410.0, 489505.0, 496541.0, 517307.0, 73855.63072184712, 80020.19979800245, 86832.56583717167, 99957.50021249993, 100429.0, 1010.6917390196061, 1012.9696109116738, 1025.1388833379847, 1047.1831971062584, 1050.3225419604312, 15942.934551689244, 15948.681026379176, 16003.759943600622, 16072.0, 16074.43739469113, 36128.0, 37486.0, 37590.43614345841, 40345.99135021648, 41689.37465938074, 50954.74522627363, 51916.48083519116, 58568.0, 59193.112103317624, 59236.40763592309, 5562.915231529812, 5948.821535353946, 6240.687965601793, 7728.956590860162, 8173.346132309282, 11026.283291586022, 12964.22214667123, 13105.2136871788, 13151.342432878126, 13286.0, 11199.272047316897, 11436.256643318158, 11612.88387116118, 11848.348340840992, 11899.702507437383, 11272.323660580392, 11318.037966772916, 11459.19785614999, 11562.075033997427, 11680.883191167979, 11764.764704705687, 11766.88233117658, 11788.76422471563, 11934.403279836148, 11989.82015269789, 8120.796980075545, 8231.670733170606, 8298.294644955246, 8322.916770832457, 8520.957395212985, 8457.915420845713, 11300.94349528247, 11804.881951180378, 11877.406129693654, 11897.40512974365], "value": 8833.918221285201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.1710076558659, 1538.6845696632192, 1697.6265221651233, 1789.7941736700284, 1849.537615596102, 7510.436717246201, 8013.67945282188, 8080.353571714263, 8261.958690206548, 8283.047449543297, 8061.0, 8089.1101978782435, 8108.189181081889, 8133.349332053436, 8135.389845761562, 2189.35414052854, 2208.9668654970187, 2226.421130506072, 2232.1964092926532, 2234.6759719840616, 2198.7801219878043, 2202.053117159621, 2221.3558068160214, 2250.0437314141423, 2252.3805953362794, 2196.769339219383, 2224.1548211679537, 2234.0728597631964, 2245.38251980705, 2245.5059886824956, 2151.419116838445, 2160.9243676471247, 2163.0050176918635, 2166.523364859728, 2168.3386567097027, 2204.9448763780874, 2205.658122990939, 2211.800937915579, 2212.0598745533243, 2222.511047569532, 8241.340692744567, 8247.257746802756, 8282.461639993382, 8301.750947471586, 8375.120612335679, 4725.905481890343, 4860.465348811628, 4888.9755551222015, 4893.143699852511, 4910.091633047862, 3038.2404398900276, 3122.594062771848, 3148.2758965437847, 3161.1780936956325, 3169.635491918436, 1039.6776999130218, 1043.7390652336917, 1053.7576357437756, 1083.7994970930404, 1084.8372744088372, 11262.662120136409, 11340.432978351131, 11407.0, 11411.429428528623, 11420.486078126421, 4119.114390406017, 4188.685848561309, 4346.521882592912, 4366.825326986948, 4388.363687265329, 9755.902440975642, 9784.217262618973, 9791.559379827782, 9801.215902727765, 9822.361546499455, 4869.561739443397, 4890.682105663121, 4892.828750993698, 4897.975510122498, 4905.386826646669, 3931.4102884566973, 4417.845375411845, 4483.058557702853, 4488.842890498882, 4514.0, 3657.250263695936, 3664.340418724655, 3715.7956312403076, 3756.154865155318, 3785.6025117362833, 1120.2046546951592, 1147.363213416545, 1149.8620165580185, 1152.4468255237366, 1153.2676750263474, 904.8326059678981, 985.4727720669407, 1003.9447830369254, 1020.6019652335596, 1026.0867827633413, 5804.158397032406, 6009.308929473166, 6027.487663548647, 6027.638341699512, 6105.450509454082, 987.698751880669, 1001.0890090018048, 1015.4516561056946, 1029.2332212501733, 1035.0580971316067, 4137.234611596804, 4190.601892820177, 4210.7473551587, 4236.216299984513, 4282.122164956177, 9639.71080867575, 10078.697639070839, 10152.137068349273, 10196.4391958443, 10242.743931401774, 10288.331258468175, 10311.535980880879, 10319.380837149794, 10383.325083869524, 10403.063724264852, 7765.72819951299, 7987.400944929153, 7993.360531157494, 8014.118446970829, 8024.598770061473, 5628.352739434854, 5813.069908814569, 5855.765769369177, 5879.5002424794375, 5944.1975333331175, 9462.0, 9475.0, 9552.95223523878, 9555.04449555039, 9601.423914565148, 9384.34309598349, 9539.809203816023, 9631.855522167032, 9804.0, 9906.405615663083, 6245.937540624535, 6793.728250870107, 6948.166220053626, 7023.824404389931, 7187.820304492429, 7977.920220797718, 8025.398095142771, 8035.196480352152, 8061.516309021477, 8117.350611950912, 7239.131304243525, 7355.632218388952, 7403.14863790671, 7479.027726395751, 7510.061242344707, 7111.644417779194, 7196.352328290479, 7271.054762881004, 7280.344768970818, 7364.742234021784, 6691.1636045494315, 6751.49363797727, 6787.592744435349, 6801.081853949653, 6801.761938332134, 5006.874828129326, 5038.823641172541, 5042.495750424928, 5051.141305978066, 5084.2627818966785, 5169.638125331191, 5206.427292997691, 5222.164453687544, 5247.449017853223, 5295.894082118413], "value": 4436.934894059337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.29211263952766, 297.99851000745, 298.44787143784, 299.8111189950331, 303.76002957663445, 5881.588288819784, 5884.205632239647, 5998.670073145975, 6032.1856549365875, 6084.239470066242, 5955.702214889249, 5967.880642387149, 5970.0, 5982.192404025455, 5992.490638295739, 4469.351943968123, 4477.977610111953, 4479.776011199427, 4480.462344518663, 4514.774261286939, 4393.5606439356125, 4504.752238626874, 4506.8873278167985, 4521.5930566249035, 4528.071745292207, 4450.264396885217, 4456.286994080948, 4464.665150113755, 4467.262901621229, 4474.0, 4475.082608065339, 4475.440569928743, 4478.126765280772, 4495.235809912323, 4509.098180363924, 3780.981095094507, 3806.0865392305923, 3855.20968201518, 3871.128995975911, 3874.7093967952233, 5755.68343741094, 5764.452377024176, 5776.364599894008, 5779.670675744603, 5794.913076303858, 5132.332796736438, 5134.817702476433, 5134.895997360548, 5139.537441630271, 5144.0740666679985, 6114.938850611481, 6249.9062514062325, 6254.374562543755, 6263.906041409383, 6300.527460440485, 4212.599803018708, 4230.471191101113, 4235.555266697014, 4237.4915010198665, 4241.681873859442, 6324.81025569229, 6502.512311576651, 6573.967130164367, 6583.802485925382, 6590.5057120715655, 4249.277622804131, 4340.348947657813, 4348.673849461303, 4360.324149756792, 4364.650827933758, 4365.105153443536, 4402.691811573223, 4406.096750166208, 4410.095930334273, 4414.690971632019, 5078.492150784892, 5081.8475445736685, 5096.745162741922, 5100.158473851773, 5120.795168193231, 6086.786962456381, 6132.202813634199, 6172.69136543171, 6328.6835658216905, 6390.169277993831, 1446.11064195519, 1464.1873760063054, 1465.8680718735366, 1466.4500812195427, 1466.486729644637, 921.709661456639, 932.9207017403461, 954.6038394066385, 959.8817377754976, 961.5096300886598, 6090.878182436327, 6091.14723938649, 6125.1731016313115, 6127.2647282325515, 6140.385961403824, 6502.544821862424, 6524.086627872101, 6538.711450992209, 6551.181102362205, 6586.670666466657, 6019.518438524908, 6116.663583502861, 6137.3862613738265, 6145.293291271561, 6150.630962142286, 3489.5114683944266, 3515.1739341255297, 3517.9120521987156, 3524.718022558189, 3529.3823580873245, 6655.334466553403, 6801.081853949752, 6825.249222585511, 6830.419414349736, 6834.794956151323, 6661.367170118928, 6664.933350666432, 6665.533412661067, 6674.632895190714, 6688.531802773759, 6587.769428069994, 6806.353396427331, 6815.556988795812, 6821.761238356733, 6832.965835170792, 6457.289698133295, 6465.515086368447, 6491.253505846888, 6539.084528165966, 6542.247641521096, 6228.781992630236, 6410.711517981796, 6417.358264173546, 6423.229212494343, 6459.967700161657, 6719.361660642231, 6728.226253980659, 6742.224644165787, 6746.595204287759, 6759.560628559325, 4178.164367126647, 4181.581841815916, 4189.685773567056, 4203.159368126326, 4208.347706105558, 6327.430531252209, 6345.904811427925, 6564.4748420127235, 6570.671466426564, 6615.801525954229, 6351.936480635134, 6404.903926441014, 6410.326915673787, 6436.806895793134, 6442.226932768098, 6289.559730818799, 6389.744410223725, 6422.3577642235405, 6429.132067170872, 6434.967825160844, 6249.937510623114, 6267.905981410191, 6276.780312689034, 6284.497240220863, 6322.49420046386, 6434.710438030206, 6457.096006558992, 6483.578567393104, 6497.902531462127, 6506.934930650633, 6189.907151392823, 6270.874582508415, 6297.653629050446, 6305.211848518935, 6335.90496142549], "value": 4691.770557732054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.9918700812992, 835.9874601880969, 844.8817165596815, 845.627923713566, 880.7137680253911, 14723.779143312859, 14907.627309317273, 14941.17823519706, 14949.10305381675, 15012.399504019826, 13692.0, 13776.311184440789, 13787.862121378783, 13799.103058301203, 13804.792928106086, 668.4485299627802, 786.4416264452217, 811.975640730779, 817.342039658075, 819.0335404223015, 802.5465611929242, 804.1958041958042, 805.6535689653447, 806.5241507510567, 808.5552945879772, 828.2752591482453, 830.9584520773938, 832.0431503770652, 832.9292010179142, 836.3351135846985, 824.2787560884226, 830.7756905635505, 831.9708810191645, 832.4256263178448, 832.7793134819278, 609.8261995331309, 615.1111643674892, 615.1725928625991, 616.3866952382408, 618.0698049435571, 14129.576112716635, 14162.575122746333, 14167.291635418187, 14206.0, 14259.073160244654, 13279.00407469434, 13569.864301356958, 13689.31553422335, 13709.45162193521, 13758.31208439584, 11107.278026928223, 11231.831522527169, 11470.197086203969, 11476.311421314664, 11512.884871151266, 3795.886123416274, 3803.6006219347123, 3818.198178382543, 3839.155385815144, 3913.4521167036637, 50884.0, 50995.745021274655, 51007.489925101014, 51056.0, 51479.22781158286, 10460.738481538023, 10848.78302433947, 10918.617848375268, 11097.778044439066, 11208.439578021229, 18620.813791861907, 18658.067096645114, 18710.064496775107, 18756.155972981247, 18808.623827523374, 8517.318614510825, 8655.870161947576, 8698.95650521756, 8718.084601116918, 9007.144321289466, 4829.13075646387, 4884.389451318585, 4912.164931961575, 4997.600191984632, 5000.049990501793, 3299.290652509674, 3388.102152929476, 3718.888433347004, 3870.9419358709642, 3875.96124038756, 702.9683664235122, 716.4841314253729, 719.5071376107384, 720.4164626652429, 722.6711846110007, 667.1160712056544, 710.948508145257, 718.737660753821, 734.6326836581709, 744.5755919126046, 9511.857322140173, 9925.50372481373, 9967.302288839712, 9981.80036399268, 10070.345427547187, 582.9417058294136, 648.7826578096297, 746.2649290448903, 756.2513112019061, 766.3294617209941, 4646.465656449484, 4824.445188803333, 4831.879203019882, 4834.984653222863, 4849.466558678542, 66368.0, 75730.62134689401, 79064.20935790683, 79697.60151199206, 79903.60048199721, 57525.42474575285, 58329.70835145797, 59365.0, 59787.10319345213, 61997.380026200066, 54586.45413545814, 55448.0, 55765.0, 56167.0, 56870.0, 9854.310198286052, 10065.597376105166, 10156.847647285149, 10171.186305095722, 10174.38953662753, 30552.694473054984, 31241.37517249688, 31259.374812504077, 32272.354552908342, 35386.0, 42268.577314226466, 42300.57699422966, 42351.0, 42581.0, 43059.138817222854, 12879.291638959572, 12880.162789418659, 12913.870861291643, 13066.346682666019, 13085.869141308465, 13186.406611702305, 13392.732145356844, 13408.731825363244, 13413.0, 13419.86580134186, 11700.414979250832, 11794.646160615195, 12178.695532611755, 12194.939025304817, 12420.751584968431, 13124.606261812161, 13179.275139867399, 13798.241096739775, 13890.86109138936, 13904.51334203298, 13120.147190432592, 13512.324383780968, 13578.592642220749, 13739.0, 13767.586972390844, 10473.68578942633, 10493.9475302623, 10929.071028962628, 11023.44882755875, 11253.66239012831, 10994.505247263733, 10999.175061870552, 11070.335779853234, 11120.332780033224, 11269.267497612629], "value": 6918.947730402609, "unit": "score"}], "name": "dromaeo_css", "value": 7067.804114078817, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 109.0, 112.0, 123.0, 111.0, 111.0, 110.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 140.0, 160.0, 195.0, 132.0, 153.0, 156.0, 131.0, 196.0, 129.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 165.0, 166.0, 161.0, 166.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 154.0, 74.0, 76.0, 74.0, 73.0, 164.0, 78.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 148.0, 94.0, 93.0, 94.0, 148.0, 92.0, 93.0, 158.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 145.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 100.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 57.0, 57.0, 59.0, 58.0, 82.0, 56.0, 56.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 78.0, 79.0, 79.0, 79.0, 78.0, 80.0, 88.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 142.0, 127.0, 124.0, 125.0, 127.0, 124.0, 128.0, 158.0, 128.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 169.0, 167.0, 168.0, 168.0, 174.0, 174.0, 171.0, 172.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 68.0, 71.0, 70.0, 68.0, 69.0, 67.0, 68.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1564.0000000000002, "alertThreshold": 2.0}]} 11:45:43 INFO - Return code: 0 11:45:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:45:43 ERROR - # TBPL SUCCESS # 11:45:43 INFO - Running post-action listener: _resource_record_post_action 11:45:43 INFO - Running post-run listener: _resource_record_post_run 11:45:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543363072; Read time: 12; Write time: 582208 11:45:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 184274944; Read time: 0; Write time: 280308 11:45:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291581952; Read time: 12; Write time: 251956 11:45:44 INFO - Running post-run listener: _upload_blobber_files 11:45:44 INFO - Blob upload gear active. 11:45:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:45:44 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:44 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:45 INFO - (blobuploader) - INFO - Done attempting. 11:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:46 INFO - (blobuploader) - INFO - Done attempting. 11:45:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:46 INFO - Return code: 0 11:45:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9291ba7f8775e81e52de4f89d9ffb391a993b98e17489446aee1ddd2f490867281d13961c99177c9943d5cd848e80024c9d5f2e52c25564bca83b382e28745f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b76b508584c179a6c06ccedf330952b11d22d21a62fe6dd6ecb2f4b88470dc3bcb4edb1ce2e74e8e6ded8d45d25c0102eb10eaecf9fae155566a0e503eefd5"} 11:45:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:46 INFO - Contents: 11:45:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9291ba7f8775e81e52de4f89d9ffb391a993b98e17489446aee1ddd2f490867281d13961c99177c9943d5cd848e80024c9d5f2e52c25564bca83b382e28745f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b76b508584c179a6c06ccedf330952b11d22d21a62fe6dd6ecb2f4b88470dc3bcb4edb1ce2e74e8e6ded8d45d25c0102eb10eaecf9fae155566a0e503eefd5"} 11:45:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:46 INFO - Copying logs to upload dir... 11:45:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.407072 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-21 11:45:46.744946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 11:45:46.748610) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411 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-Inbound/sha512/9291ba7f8775e81e52de4f89d9ffb391a993b98e17489446aee1ddd2f490867281d13961c99177c9943d5cd848e80024c9d5f2e52c25564bca83b382e28745f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b76b508584c179a6c06ccedf330952b11d22d21a62fe6dd6ecb2f4b88470dc3bcb4edb1ce2e74e8e6ded8d45d25c0102eb10eaecf9fae155566a0e503eefd5"} build_url:https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/QDhAE2yWRTilOLYEbRpjKw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9291ba7f8775e81e52de4f89d9ffb391a993b98e17489446aee1ddd2f490867281d13961c99177c9943d5cd848e80024c9d5f2e52c25564bca83b382e28745f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b76b508584c179a6c06ccedf330952b11d22d21a62fe6dd6ecb2f4b88470dc3bcb4edb1ce2e74e8e6ded8d45d25c0102eb10eaecf9fae155566a0e503eefd5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 11:45:46.773518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:45:46.773912) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461262629.352769-1836707411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:45:46.857095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 11:45:46.857420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 11:45:46.857710) ========= ========= Total master_lag: 0.18 =========