builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1460992053.48 results: success (0) buildid: 20160418030305 builduid: 77bf842e77b14c10a37b789d99c2991a revision: 1f16d3da9280e40ada252acf8110b91ee1edbb08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.479909) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.480453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.480741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.498390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.498848) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 08:07:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.2M=0s 2016-04-18 08:07:33 (89.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.637816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.638181) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.688269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:33.688813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1f16d3da9280e40ada252acf8110b91ee1edbb08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1f16d3da9280e40ada252acf8110b91ee1edbb08 --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=aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 08:07:33,934 truncating revision to first 12 chars 2016-04-18 08:07:33,935 Setting DEBUG logging. 2016-04-18 08:07:33,935 attempt 1/10 2016-04-18 08:07:33,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1f16d3da9280?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 08:07:34,178 unpacking tar archive at: mozilla-central-1f16d3da9280/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:34.227870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:34.228438) ========= script_repo_revision: 1f16d3da9280e40ada252acf8110b91ee1edbb08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:34.229120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:34.229596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:34.241288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-18 08:07:34.241703) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:34 INFO - MultiFileLogger online at 20160418 08:07:34 in /builds/slave/test 08:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:34 INFO - {'append_to_log': False, 08:07:34 INFO - 'base_work_dir': '/builds/slave/test', 08:07:34 INFO - 'blob_upload_branch': 'Firefox', 08:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:34 INFO - 'branch': 'Firefox', 08:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:34 INFO - 'config_files': ('talos/linux_config.py',), 08:07:34 INFO - 'default_actions': ('clobber', 08:07:34 INFO - 'read-buildbot-config', 08:07:34 INFO - 'download-and-extract', 08:07:34 INFO - 'populate-webroot', 08:07:34 INFO - 'create-virtualenv', 08:07:34 INFO - 'install', 08:07:34 INFO - 'run-tests'), 08:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:34 INFO - 'download_minidump_stackwalk': True, 08:07:34 INFO - 'download_symbols': 'ondemand', 08:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:34 INFO - 'installer_path': 'installer.exe', 08:07:34 INFO - 'log_level': 'info', 08:07:34 INFO - 'log_name': 'talos', 08:07:34 INFO - 'log_to_console': True, 08:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:34 INFO - 'opt_config_files': (), 08:07:34 INFO - 'pip_index': False, 08:07:34 INFO - 'sps_profile': False, 08:07:34 INFO - 'sps_profile_interval': 0, 08:07:34 INFO - 'suite': 'dromaeojs-e10s', 08:07:34 INFO - 'system_bits': '32', 08:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:34 INFO - 'title': 'talos-linux64-ix-037', 08:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:34 INFO - 'use_talos_json': True, 08:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:34 INFO - 'work_dir': 'build'} 08:07:34 INFO - ##### 08:07:34 INFO - ##### Running clobber step. 08:07:34 INFO - ##### 08:07:34 INFO - Running pre-action listener: _resource_record_pre_action 08:07:34 INFO - Running main action method: clobber 08:07:34 INFO - rmtree: /builds/slave/test/build 08:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:35 INFO - Running post-action listener: _resource_record_post_action 08:07:35 INFO - ##### 08:07:35 INFO - ##### Running read-buildbot-config step. 08:07:35 INFO - ##### 08:07:35 INFO - Running pre-action listener: _resource_record_pre_action 08:07:35 INFO - Running main action method: read_buildbot_config 08:07:35 INFO - Using buildbot properties: 08:07:35 INFO - { 08:07:35 INFO - "project": "", 08:07:35 INFO - "product": "firefox", 08:07:35 INFO - "script_repo_revision": "production", 08:07:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:07:35 INFO - "repository": "", 08:07:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:07:35 INFO - "buildid": "20160418030305", 08:07:35 INFO - "stage_platform": "linux64-pgo", 08:07:35 INFO - "basedir": "/builds/slave/test", 08:07:35 INFO - "nightly_build": "True", 08:07:35 INFO - "buildnumber": 416, 08:07:35 INFO - "slavename": "talos-linux64-ix-037", 08:07:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:07:35 INFO - "platform": "ubuntu64_hw", 08:07:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:07:35 INFO - "branch": "mozilla-central", 08:07:35 INFO - "repo_path": "mozilla-central", 08:07:35 INFO - "revision": "1f16d3da9280e40ada252acf8110b91ee1edbb08", 08:07:35 INFO - "pgo_build": "True", 08:07:35 INFO - "builduid": "77bf842e77b14c10a37b789d99c2991a", 08:07:35 INFO - "slavebuilddir": "test" 08:07:35 INFO - } 08:07:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:07:35 INFO - Running post-action listener: _resource_record_post_action 08:07:35 INFO - ##### 08:07:35 INFO - ##### Running download-and-extract step. 08:07:35 INFO - ##### 08:07:35 INFO - Running pre-action listener: _resource_record_pre_action 08:07:35 INFO - Running main action method: download_and_extract 08:07:35 INFO - mkdir: /builds/slave/test/build/tests 08:07: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')]} 08:07:35 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:40 INFO - Downloaded 1361 bytes. 08:07:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:40 INFO - Using the following test package requirements: 08:07:40 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'jsshell-linux-x86_64.zip'], 08:07:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:40 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:40 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')]} 08:07:40 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:45 INFO - Downloaded 23774931 bytes. 08:07:45 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'] 08:07:45 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 08:07:46 INFO - Return code: 0 08:07:46 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 08:07:46 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')]} 08:07:46 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:51 INFO - Downloaded 23774931 bytes. 08:07:51 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'] 08:07:51 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 08:07:53 INFO - Return code: 0 08:07:53 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')]} 08:07:53 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:54 INFO - Downloaded 10841076 bytes. 08:07:54 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'] 08:07:54 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 08:07:54 INFO - Return code: 0 08:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:54 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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 08:07:56 INFO - Downloaded 58220647 bytes. 08:07:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:56 INFO - mkdir: /builds/slave/test/properties 08:07:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:56 INFO - Contents: 08:07:56 INFO - build_url:https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:56 INFO - Running post-action listener: _resource_record_post_action 08:07:56 INFO - Running post-action listener: set_extra_try_arguments 08:07:56 INFO - ##### 08:07:56 INFO - ##### Running populate-webroot step. 08:07:56 INFO - ##### 08:07:56 INFO - Running pre-action listener: _resource_record_pre_action 08:07:56 INFO - Running main action method: populate_webroot 08:07:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:56 INFO - '--tppagecycles', 08:07:56 INFO - '7'], 08:07:56 INFO - 'tests': ['tsvgm']}}, 08:07:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['damp', 'tps']}, 08:07:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'tests': ['damp', 'tps']}, 08:07:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['dromaeo_dom']}, 08:07:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tsvgx', 08:07:56 INFO - 'tsvgr_opacity', 08:07:56 INFO - 'tart', 08:07:56 INFO - 'tscrollx', 08:07:56 INFO - 'cart']}, 08:07:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:56 INFO - 'tsvgr_opacity', 08:07:56 INFO - 'tart', 08:07:56 INFO - 'tscrollx', 08:07:56 INFO - 'cart']}, 08:07:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tp5o']}, 08:07:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'tests': ['tp5o']}, 08:07:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s', 08:07:56 INFO - '--xperf_path', 08:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:56 INFO - 'tests': ['tp5n']}, 08:07:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--xperf_path', 08:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:56 INFO - 'tests': ['tp5n']}}, 08:07:56 INFO - 'talos.zip': {'path': '', 08:07:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:56 INFO - Running post-action listener: _resource_record_post_action 08:07:56 INFO - ##### 08:07:56 INFO - ##### Running create-virtualenv step. 08:07:56 INFO - ##### 08:07:56 INFO - Running pre-action listener: _resource_record_pre_action 08:07:56 INFO - Running main action method: create_virtualenv 08:07:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:56 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 08:07:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:57 INFO - Using real prefix '/usr' 08:07:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:59 INFO - Installing pip.................done. 08:07:59 INFO - Return code: 0 08:07:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:07:59 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 08:07:59 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 08:07:59 INFO - Using env: {'DISPLAY': ':0', 08:07:59 INFO - 'HOME': '/home/cltbld', 08:07:59 INFO - 'LANG': 'en_US.UTF-8', 08:07:59 INFO - 'LANGUAGE': 'en_US:en', 08:07:59 INFO - 'LOGNAME': 'cltbld', 08:07:59 INFO - 'MAIL': '/var/mail/cltbld', 08:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:59 INFO - 'MOZ_NO_REMOTE': '1', 08:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:59 INFO - 'NO_EM_RESTART': '1', 08:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:59 INFO - 'PWD': '/builds/slave/test', 08:07:59 INFO - 'SHELL': '/bin/bash', 08:07:59 INFO - 'SHLVL': '1', 08:07:59 INFO - 'TERM': 'linux', 08:07:59 INFO - 'TMOUT': '86400', 08:07:59 INFO - 'USER': 'cltbld', 08:07:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:59 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 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 08:07:59 INFO - Cleaning up... 08:07:59 INFO - Return code: 0 08:07:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:07:59 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 08:07:59 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 08:07:59 INFO - Using env: {'DISPLAY': ':0', 08:07:59 INFO - 'HOME': '/home/cltbld', 08:07:59 INFO - 'LANG': 'en_US.UTF-8', 08:07:59 INFO - 'LANGUAGE': 'en_US:en', 08:07:59 INFO - 'LOGNAME': 'cltbld', 08:07:59 INFO - 'MAIL': '/var/mail/cltbld', 08:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:59 INFO - 'MOZ_NO_REMOTE': '1', 08:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:59 INFO - 'NO_EM_RESTART': '1', 08:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:59 INFO - 'PWD': '/builds/slave/test', 08:07:59 INFO - 'SHELL': '/bin/bash', 08:07:59 INFO - 'SHLVL': '1', 08:07:59 INFO - 'TERM': 'linux', 08:07:59 INFO - 'TMOUT': '86400', 08:07:59 INFO - 'USER': 'cltbld', 08:07:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:59 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 INFO - Downloading/unpacking psutil>=0.7.1 08:07:59 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 08:07:59 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 08:07:59 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 08:07:59 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 08:07:59 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 08:07:59 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 08:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:01 INFO - Installing collected packages: psutil 08:08:01 INFO - Running setup.py install for psutil 08:08:02 INFO - building 'psutil._psutil_linux' extension 08:08:02 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 08:08:02 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 08:08:02 INFO - building 'psutil._psutil_posix' extension 08:08:02 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 08:08:02 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 08:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:02 INFO - Successfully installed psutil 08:08:02 INFO - Cleaning up... 08:08:02 INFO - Return code: 0 08:08:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:08:02 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')]} 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 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')]} 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:02 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 08:08:02 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 08:08:02 INFO - Using env: {'DISPLAY': ':0', 08:08:02 INFO - 'HOME': '/home/cltbld', 08:08:02 INFO - 'LANG': 'en_US.UTF-8', 08:08:02 INFO - 'LANGUAGE': 'en_US:en', 08:08:02 INFO - 'LOGNAME': 'cltbld', 08:08:02 INFO - 'MAIL': '/var/mail/cltbld', 08:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:02 INFO - 'MOZ_NO_REMOTE': '1', 08:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:02 INFO - 'NO_EM_RESTART': '1', 08:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:02 INFO - 'PWD': '/builds/slave/test', 08:08:02 INFO - 'SHELL': '/bin/bash', 08:08:02 INFO - 'SHLVL': '1', 08:08:02 INFO - 'TERM': 'linux', 08:08:02 INFO - 'TMOUT': '86400', 08:08:02 INFO - 'USER': 'cltbld', 08:08:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:02 INFO - '_': '/tools/buildbot/bin/python'} 08:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:02 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 08:08:02 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 08:08:02 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 08:08:02 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 08:08:02 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 08:08:02 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 08:08:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:04 INFO - Installing collected packages: mozsystemmonitor 08:08:04 INFO - Running setup.py install for mozsystemmonitor 08:08:04 INFO - Successfully installed mozsystemmonitor 08:08:04 INFO - Cleaning up... 08:08:04 INFO - Return code: 0 08:08:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:04 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')]} 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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')]} 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:04 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 08:08:04 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 08:08:04 INFO - Using env: {'DISPLAY': ':0', 08:08:04 INFO - 'HOME': '/home/cltbld', 08:08:04 INFO - 'LANG': 'en_US.UTF-8', 08:08:04 INFO - 'LANGUAGE': 'en_US:en', 08:08:04 INFO - 'LOGNAME': 'cltbld', 08:08:04 INFO - 'MAIL': '/var/mail/cltbld', 08:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:04 INFO - 'MOZ_NO_REMOTE': '1', 08:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:04 INFO - 'NO_EM_RESTART': '1', 08:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:04 INFO - 'PWD': '/builds/slave/test', 08:08:04 INFO - 'SHELL': '/bin/bash', 08:08:04 INFO - 'SHLVL': '1', 08:08:04 INFO - 'TERM': 'linux', 08:08:04 INFO - 'TMOUT': '86400', 08:08:04 INFO - 'USER': 'cltbld', 08:08:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:04 INFO - '_': '/tools/buildbot/bin/python'} 08:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:07 INFO - Downloading docopt-0.6.1.tar.gz 08:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:07 INFO - Running setup.py install for blobuploader 08:08:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:07 INFO - Running setup.py install for requests 08:08:08 INFO - Running setup.py install for docopt 08:08:08 INFO - Successfully installed blobuploader requests docopt 08:08:08 INFO - Cleaning up... 08:08:08 INFO - Return code: 0 08:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:08 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')]} 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:08 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')]} 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:08 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:08 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 08:08:08 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 08:08:08 INFO - Using env: {'DISPLAY': ':0', 08:08:08 INFO - 'HOME': '/home/cltbld', 08:08:08 INFO - 'LANG': 'en_US.UTF-8', 08:08:08 INFO - 'LANGUAGE': 'en_US:en', 08:08:08 INFO - 'LOGNAME': 'cltbld', 08:08:08 INFO - 'MAIL': '/var/mail/cltbld', 08:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:08 INFO - 'MOZ_NO_REMOTE': '1', 08:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:08 INFO - 'NO_EM_RESTART': '1', 08:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:08 INFO - 'PWD': '/builds/slave/test', 08:08:08 INFO - 'SHELL': '/bin/bash', 08:08:08 INFO - 'SHLVL': '1', 08:08:08 INFO - 'TERM': 'linux', 08:08:08 INFO - 'TMOUT': '86400', 08:08:08 INFO - 'USER': 'cltbld', 08:08:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:08 INFO - '_': '/tools/buildbot/bin/python'} 08:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:08 INFO - Running setup.py (path:/tmp/pip-MOR25f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:08 INFO - Running setup.py (path:/tmp/pip-GVjgU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:08 INFO - Running setup.py (path:/tmp/pip-bT_LX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:08 INFO - Running setup.py (path:/tmp/pip-lrmyIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:08 INFO - Running setup.py (path:/tmp/pip-LllIyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:08 INFO - Running setup.py (path:/tmp/pip-q0exZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:08 INFO - Running setup.py (path:/tmp/pip-lGW8Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:08 INFO - Running setup.py (path:/tmp/pip-0P6Bg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:08 INFO - Running setup.py (path:/tmp/pip-bhOHQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:09 INFO - Running setup.py (path:/tmp/pip-P0E6Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:09 INFO - Running setup.py (path:/tmp/pip-efh_A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:09 INFO - Running setup.py (path:/tmp/pip-RNsYd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:09 INFO - Running setup.py (path:/tmp/pip-CArcPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:09 INFO - Running setup.py (path:/tmp/pip-lrdf7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:09 INFO - Running setup.py (path:/tmp/pip-iSNckO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:09 INFO - Running setup.py (path:/tmp/pip-dxC6s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:09 INFO - Running setup.py (path:/tmp/pip-vMo8PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:09 INFO - Running setup.py install for manifestparser 08:08:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Running setup.py install for mozcrash 08:08:09 INFO - Running setup.py install for mozdebug 08:08:09 INFO - Running setup.py install for mozdevice 08:08:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozfile 08:08:10 INFO - Running setup.py install for mozhttpd 08:08:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozinfo 08:08:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozInstall 08:08:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozleak 08:08:10 INFO - Running setup.py install for mozlog 08:08:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for moznetwork 08:08:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozprocess 08:08:10 INFO - Running setup.py install for mozprofile 08:08:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozrunner 08:08:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:11 INFO - Running setup.py install for mozscreenshot 08:08:11 INFO - Running setup.py install for moztest 08:08:11 INFO - Running setup.py install for mozversion 08:08:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:11 INFO - Cleaning up... 08:08:11 INFO - Return code: 0 08:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:11 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:11 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 08:08:11 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 08:08:11 INFO - Using env: {'DISPLAY': ':0', 08:08:11 INFO - 'HOME': '/home/cltbld', 08:08:11 INFO - 'LANG': 'en_US.UTF-8', 08:08:11 INFO - 'LANGUAGE': 'en_US:en', 08:08:11 INFO - 'LOGNAME': 'cltbld', 08:08:11 INFO - 'MAIL': '/var/mail/cltbld', 08:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:11 INFO - 'MOZ_NO_REMOTE': '1', 08:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:11 INFO - 'NO_EM_RESTART': '1', 08:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:11 INFO - 'PWD': '/builds/slave/test', 08:08:11 INFO - 'SHELL': '/bin/bash', 08:08:11 INFO - 'SHLVL': '1', 08:08:11 INFO - 'TERM': 'linux', 08:08:11 INFO - 'TMOUT': '86400', 08:08:11 INFO - 'USER': 'cltbld', 08:08:11 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:11 INFO - '_': '/tools/buildbot/bin/python'} 08:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:11 INFO - Running setup.py (path:/tmp/pip-x12aXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:11 INFO - Running setup.py (path:/tmp/pip-khHNio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:11 INFO - Running setup.py (path:/tmp/pip-oDcyqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:11 INFO - Running setup.py (path:/tmp/pip-wCGDYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:11 INFO - Running setup.py (path:/tmp/pip-8iKpPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:11 INFO - Running setup.py (path:/tmp/pip-JKBY6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:12 INFO - Running setup.py (path:/tmp/pip-yBrwya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:12 INFO - Running setup.py (path:/tmp/pip-AbDXsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:12 INFO - Running setup.py (path:/tmp/pip-Wep8cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:12 INFO - Running setup.py (path:/tmp/pip-bkKy79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:12 INFO - Running setup.py (path:/tmp/pip-cDS7_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:12 INFO - Running setup.py (path:/tmp/pip-xZssC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:12 INFO - Running setup.py (path:/tmp/pip-DvU7Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:12 INFO - Running setup.py (path:/tmp/pip-vqeSgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:12 INFO - Running setup.py (path:/tmp/pip-PX6MMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:12 INFO - Running setup.py (path:/tmp/pip-6QeiXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:12 INFO - Running setup.py (path:/tmp/pip-1fjqHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:14 INFO - Downloading blessings-1.6.tar.gz 08:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:14 INFO - Installing collected packages: blessings 08:08:14 INFO - Running setup.py install for blessings 08:08:14 INFO - Successfully installed blessings 08:08:14 INFO - Cleaning up... 08:08:14 INFO - Return code: 0 08:08:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:15 INFO - Reading from file tmpfile_stdout 08:08:15 INFO - Current package versions: 08:08:15 INFO - argparse == 1.2.1 08:08:15 INFO - blessings == 1.6 08:08:15 INFO - blobuploader == 1.2.4 08:08:15 INFO - docopt == 0.6.1 08:08:15 INFO - manifestparser == 1.1 08:08:15 INFO - mozInstall == 1.12 08:08:15 INFO - mozcrash == 0.17 08:08:15 INFO - mozdebug == 0.1 08:08:15 INFO - mozdevice == 0.48 08:08:15 INFO - mozfile == 1.2 08:08:15 INFO - mozhttpd == 0.7 08:08:15 INFO - mozinfo == 0.9 08:08:15 INFO - mozleak == 0.1 08:08:15 INFO - mozlog == 3.1 08:08:15 INFO - moznetwork == 0.27 08:08:15 INFO - mozprocess == 0.22 08:08:15 INFO - mozprofile == 0.28 08:08:15 INFO - mozrunner == 6.11 08:08:15 INFO - mozscreenshot == 0.1 08:08:15 INFO - mozsystemmonitor == 0.0 08:08:15 INFO - moztest == 0.7 08:08:15 INFO - mozversion == 1.4 08:08:15 INFO - psutil == 3.1.1 08:08:15 INFO - requests == 1.2.3 08:08:15 INFO - wsgiref == 0.1.2 08:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:15 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 08:08:15 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 08:08:15 INFO - Using env: {'DISPLAY': ':0', 08:08:15 INFO - 'HOME': '/home/cltbld', 08:08:15 INFO - 'LANG': 'en_US.UTF-8', 08:08:15 INFO - 'LANGUAGE': 'en_US:en', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MAIL': '/var/mail/cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SHLVL': '1', 08:08:15 INFO - 'TERM': 'linux', 08:08:15 INFO - 'TMOUT': '86400', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 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)) 08:08:15 INFO - Cleaning up... 08:08:15 INFO - Return code: 0 08:08:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:15 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 08:08:15 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 08:08:15 INFO - Using env: {'DISPLAY': ':0', 08:08:15 INFO - 'HOME': '/home/cltbld', 08:08:15 INFO - 'LANG': 'en_US.UTF-8', 08:08:15 INFO - 'LANGUAGE': 'en_US:en', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MAIL': '/var/mail/cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SHLVL': '1', 08:08:15 INFO - 'TERM': 'linux', 08:08:15 INFO - 'TMOUT': '86400', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 INFO - Downloading/unpacking jsonschema 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:17 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:17 INFO - warning: no files found matching '*.txt' 08:08:17 INFO - no previously-included directories found matching 'build' 08:08:17 INFO - no previously-included directories found matching 'dist' 08:08:17 INFO - no previously-included directories found matching '.git*' 08:08:17 INFO - Installing collected packages: jsonschema, functools32 08:08:17 INFO - Running setup.py install for functools32 08:08:17 INFO - warning: no files found matching '*.txt' 08:08:17 INFO - no previously-included directories found matching 'build' 08:08:17 INFO - no previously-included directories found matching 'dist' 08:08:17 INFO - no previously-included directories found matching '.git*' 08:08:17 INFO - Successfully installed jsonschema functools32 08:08:17 INFO - Cleaning up... 08:08:17 INFO - Return code: 0 08:08:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:17 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 0x7fc81f1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', '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 08:08:17 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 08:08:17 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 08:08:17 INFO - Using env: {'DISPLAY': ':0', 08:08:17 INFO - 'HOME': '/home/cltbld', 08:08:17 INFO - 'LANG': 'en_US.UTF-8', 08:08:17 INFO - 'LANGUAGE': 'en_US:en', 08:08:17 INFO - 'LOGNAME': 'cltbld', 08:08:17 INFO - 'MAIL': '/var/mail/cltbld', 08:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:17 INFO - 'MOZ_NO_REMOTE': '1', 08:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:17 INFO - 'NO_EM_RESTART': '1', 08:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:17 INFO - 'PWD': '/builds/slave/test', 08:08:17 INFO - 'SHELL': '/bin/bash', 08:08:17 INFO - 'SHLVL': '1', 08:08:17 INFO - 'TERM': 'linux', 08:08:17 INFO - 'TMOUT': '86400', 08:08:17 INFO - 'USER': 'cltbld', 08:08:17 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:17 INFO - '_': '/tools/buildbot/bin/python'} 08:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:18 INFO - Downloading/unpacking flake8 08:08:18 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 08:08:18 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 08:08:18 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 08:08:18 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 08:08:18 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 08:08:18 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 08:08:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:19 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 08:08:19 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 08:08:19 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 08:08:19 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 08:08:19 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 08:08:19 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 08:08:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:20 INFO - no previously-included directories found matching 'docs/_build' 08:08:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:20 INFO - Running setup.py install for pep8 08:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:20 INFO - no previously-included directories found matching 'docs/_build' 08:08:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:20 INFO - Cleaning up... 08:08:20 INFO - Return code: 0 08:08:20 INFO - Running post-action listener: _resource_record_post_action 08:08:20 INFO - Running post-action listener: _start_resource_monitoring 08:08:20 INFO - Starting resource monitoring. 08:08:20 INFO - ##### 08:08:20 INFO - ##### Running install step. 08:08:20 INFO - ##### 08:08:20 INFO - Running pre-action listener: _resource_record_pre_action 08:08:20 INFO - Running main action method: install 08:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:21 INFO - Reading from file tmpfile_stdout 08:08:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:21 INFO - Reading from file tmpfile_stdout 08:08:21 INFO - Output received: 08:08:21 INFO - Usage: mozinstall [options] installer 08:08:21 INFO - Options: 08:08:21 INFO - -h, --help show this help message and exit 08:08:21 INFO - -d DEST, --destination=DEST 08:08:21 INFO - Directory to install application into. [default: 08:08:21 INFO - "/builds/slave/test"] 08:08:21 INFO - --app=APP Application being installed. [default: firefox] 08:08:21 INFO - mkdir: /builds/slave/test/build/application 08:08:21 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'] 08:08:21 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 08:08:37 INFO - Reading from file tmpfile_stdout 08:08:37 INFO - Output received: 08:08:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:37 INFO - Running post-action listener: _resource_record_post_action 08:08:37 INFO - ##### 08:08:37 INFO - ##### Running run-tests step. 08:08:37 INFO - ##### 08:08:37 INFO - Running pre-action listener: _resource_record_pre_action 08:08:37 INFO - Running main action method: run_tests 08:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:37 INFO - Python 2.7.3 08:08:37 INFO - Return code: 0 08:08:37 INFO - grabbing minidump binary from tooltool 08:08: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')]} 08:08:37 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 0x1e64640>, '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 0x1e65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e659d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:37 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 08:08:37 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 08:08:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:37 INFO - Return code: 0 08:08:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:38 INFO - Return code: 0 08:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 08:08:38 INFO - Using env: {'DISPLAY': ':0', 08:08:38 INFO - 'HOME': '/home/cltbld', 08:08:38 INFO - 'LANG': 'en_US.UTF-8', 08:08:38 INFO - 'LANGUAGE': 'en_US:en', 08:08:38 INFO - 'LOGNAME': 'cltbld', 08:08:38 INFO - 'MAIL': '/var/mail/cltbld', 08:08:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:38 INFO - 'MOZ_NO_REMOTE': '1', 08:08:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:38 INFO - 'NO_EM_RESTART': '1', 08:08:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:38 INFO - 'PWD': '/builds/slave/test', 08:08:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:38 INFO - 'SHELL': '/bin/bash', 08:08:38 INFO - 'SHLVL': '1', 08:08:38 INFO - 'TERM': 'linux', 08:08:38 INFO - 'TMOUT': '86400', 08:08:38 INFO - 'USER': 'cltbld', 08:08:38 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649', 08:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:38 INFO - '_': '/tools/buildbot/bin/python'} 08:08:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:08:39 INFO - mozversion application_buildid: 20160418030305 08:08:39 INFO - mozversion application_changeset: 1f16d3da9280e40ada252acf8110b91ee1edbb08 08:08:39 INFO - mozversion application_display_name: Nightly 08:08:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:39 INFO - mozversion application_name: Firefox 08:08:39 INFO - mozversion application_remotingname: firefox 08:08:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:08:39 INFO - mozversion application_vendor: Mozilla 08:08:39 INFO - mozversion application_version: 48.0a1 08:08:39 INFO - mozversion platform_buildid: 20160418030305 08:08:39 INFO - mozversion platform_changeset: 1f16d3da9280e40ada252acf8110b91ee1edbb08 08:08:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:08:39 INFO - mozversion platform_version: 48.0a1 08:08:39 INFO - using testdate: 1460992119 08:08:39 INFO - actual date: 1460992119 08:08:39 INFO - starting webserver on 'localhost:45969' 08:08:39 INFO - SUITE-START | Running 2 tests 08:08:39 INFO - TEST-START | dromaeo_css 08:08:39 INFO - operating with platform_type : linux_ 08:08:39 INFO - Initialising browser for dromaeo_css test... 08:08:39 INFO - TEST-INFO | started process 12005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4C8exH/profile http://localhost:45969/getInfo.html) 08:08:42 INFO - PROCESS | 12005 | 08:08:42 INFO - PROCESS | 12005 | (process:12075): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:43 INFO - PROCESS | 12005 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:08:43 INFO - PROCESS | 12005 | __metrics Screen width/height:1600/1200 08:08:43 INFO - PROCESS | 12005 | colorDepth:24 08:08:43 INFO - PROCESS | 12005 | Browser inner width/height: 1024/697 08:08:43 INFO - PROCESS | 12005 | __metrics 08:08:44 ERROR - PROCESS | 12005 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:08:45 INFO - TEST-INFO | 12005: exit 0 08:08:45 INFO - Browser initialized. 08:08:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:45 INFO - TEST-INFO | started process 12126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4C8exH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:46 INFO - PROCESS | 12126 | 08:08:46 INFO - PROCESS | 12126 | (process:12184): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:56 INFO - PROCESS | 12126 | RSS: Main: 163528704 08:08:56 INFO - PROCESS | 12126 | 08:09:46 INFO - PROCESS | 12126 | 1460992186478 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] 08:11:54 INFO - PROCESS | 12126 | Cycle 1(1): loaded http://localhost:45969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45969/tests/dromaeo/cssquery-ext.html) 08:11:55 INFO - PROCESS | 12126 | RSS: Main: 169115648 08:11:55 INFO - PROCESS | 12126 | 08:14:57 INFO - PROCESS | 12126 | Cycle 1(1): loaded http://localhost:45969/tests/dromaeo/cssquery-ext.html (next: http://localhost:45969/tests/dromaeo/cssquery-jquery.html) 08:14:58 INFO - PROCESS | 12126 | RSS: Main: 165859328 08:14:58 INFO - PROCESS | 12126 | 08:17:59 INFO - PROCESS | 12126 | Cycle 1(1): loaded http://localhost:45969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45969/tests/dromaeo/cssquery-mootools.html) 08:18:00 INFO - PROCESS | 12126 | RSS: Main: 166256640 08:18:00 INFO - PROCESS | 12126 | 08:21:02 INFO - PROCESS | 12126 | Cycle 1(1): loaded http://localhost:45969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45969/tests/dromaeo/cssquery-prototype.html) 08:21:02 INFO - PROCESS | 12126 | RSS: Main: 164040704 08:21:02 INFO - PROCESS | 12126 | 08:24:05 INFO - PROCESS | 12126 | Cycle 1(1): loaded http://localhost:45969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45969/tests/dromaeo/cssquery-yui.html) 08:24:05 INFO - PROCESS | 12126 | RSS: Main: 165511168 08:24:05 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | Cycle 1(1): loaded http://localhost:45969/tests/dromaeo/cssquery-yui.html (next: http://localhost:45969/tests/dromaeo/cssquery-dojo.html) 08:27:08 INFO - PROCESS | 12126 | RSS: Main: 167563264 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | __start_tp_report 08:27:08 INFO - PROCESS | 12126 | _x_x_mozilla_page_load 08:27:08 INFO - PROCESS | 12126 | _x_x_mozilla_page_load_details 08:27:08 INFO - PROCESS | 12126 | |i|pagename|runs| 08:27:08 INFO - PROCESS | 12126 | |0;dojo.html;3125.9062228133157;3158.9842050789744;3174.6984036516537;3213.277012672149;3215.099772063823;5410.83767486975;5472.069748142815;5484.287042684446;5496.725163741807;5527.364353099395;5432.91850622241;5498.697571633558;5517.200005999128;5539.058360078786;5591.30108736408;4953.628477864157;4963.751812409383;4966.056449274644;5080.314157588715;5088.363954505687;4994.875128121808;5017.974910125445;5054.620903432257;5068.366454193226;5108.003939231851;4893.045856058088;4929.827456039039;4979.253112033188;5007.298978143063;5032.924506132411;4870.147724148295;4909.361782968192;4911.214205727102;4911.45973942866;4949.084419382426;4843.6851604645935;4880.194767863299;4897;4904.558589726942;4924.4583095859425;5363.785448582052;5415.864603384907;5458.972705136489;5462.399136095027;5492.725363731797;5811.79658711943;5868.559858010623;5870.148828419855;5875.764969401262;5903.527717782567;5771.913421298684;5924.851878703023;5926.525877929756;5929.911051334234;5937.614055086448;5434.483724046209;5467.644603100785;5474.479924407175;5482.725863706799;5495.6153069285165;5996.610220335664;6016.127661489059;6017.6389416634265;6027.578069535178;6049.153118563405;5776.855578610484;5786.305643322744;5791.044477661223;5820.941790582125;5849.561282903799;5803.912941305884;5894.410558944157;5895.528357731371;5916.674582897896;5944.8811023780145;5928.555358348141;5973.641581505037;5983.1623572699855;5984.521238300926;5985;5686.14707793826;5796.681182535001;5824.737886795019;5842.795502157489;5890.322612899571;4483.103379324149;4497.910041799146;4503.81984720614;4507.5943165115295;4544.7500387479;3945.270125026879;3987.282289187974;4006.639402453735;4008.7193896427552;4028.0332720146953;5646.040173170571;5648.491635752802;5674.574406919498;5713.171590119409;5722.914156287659;5870.794522191788;5884.764609415661;5894;5909.911351329733;5919.704014799243;5545.750441230154;5549.5837812163445;5553.028220061473;5567.749451274703;5571.693556854412;4757.524247575215;4866.46468888422;4869.732164730903;4959.429665588431;4982.302477653131;6104.969475152685;6179.134921111048;6194.907076393858;6199.969000154971;6216.4405203531;5906.232189815297;5989.221401217814;6009.36901625323;6011.338752737282;6022.728977196124;6105.603135796159;6123.069106197319;6137.41694539018;6174.043023331391;6179.412955769195;5839.912401314069;5865.120231965068;5870.735816888165;5877.882442351214;5880.911786323123;5689.804276299552;5920;5965.492933100735;5965.761369545169;5978.940210597838;5644;5670.234518339971;5680.829575112753;5702.37273899879;5815.9709201453725;5717.942820571741;5729.3984131665575;5748.080307150836;5748.45389687979;5754.424557544212;5615.775368985358;5658.207850900795;5658.405867383865;5677.432256774289;5692.857678558069;5815.883682326245;5900.734466949083;5910.615809972338;5928.3775203603;5936.139259807217;5569.693666848362;5604.635698679573;5628.690422026828;5636.4927156556105;5654.378018417889 08:27:08 INFO - PROCESS | 12126 | |1;ext.html;601.4376557918347;649.4220144071777;660.5211221864146;664.8670265946812;666.7233098264221;33348.83325583372;34461.31077378454;34709.826450867775;34718.826405868;34858.12854678634;34907.301853962905;35062.66904644061;35195;35304.64695353046;35340.469892951565;8340.08259091501;8528.78678033048;8543.700970466034;8556.18716221958;8564;8354.832903341929;8703.216710496054;8770.122987701243;8771.03518612952;8790.560471976407;8680.305575553972;8808.515531645757;8808.735737927873;8830.735077947671;8851.114888511162;8704.30365570756;8780.990186128613;8793.824123517526;8796.516191609458;8818.86771698425;8535.231829135346;8629.395942284043;8664.39349245553;8697;8719.346049046348;32031;36525.63474365249;36764;36890.81554592236;36929.26141477182;3359.932801343984;3364.7068167828243;3441;3803.581606023335;4113.177364527107;29217.41565168706;29327.560086598718;29576.40847183066;30138;30217.395652086834;3907.433422153772;3951.8024098794945;3982.900427489307;3991.2217117662067;4045.8583949561917;284006;286748.56625716947;290986;291406;291620;61414;62943;62974.685126574994;63136;63396.36603633997;64481.355186448476;65041;65156.348436515975;65318.67340663266;65630.67184664142;14978;15216.847831521543;15219.315130819139;15221.695566088616;15222.314995825214;11844.466998985066;12104.334261615695;12128.151029427856;12132.878671213175;12134.332611706264;19126.71523800936;19240.71138932917;19358;19866.90066549658;19962.401127965895;7610.695572177162;7830.334421574116;8003.919960800434;8107.635156417975;8159.918400816035;1067.514281002142;1087.8096333141668;1114.6098865397207;1120.8318752187074;1132;31503.84248078791;31717.841410792797;31960.360792784013;32262.354752904812;32985.83507082449;1124.4995976790412;1141.4235810915434;1174.9953789510016;1181.2499063094997;1199.0767109325946;14988.47540336083;15257;15283.943211357551;17243.310267589408;18149.909250453664;466984;470275;470617;472553;473158;56776.432235677115;57350.426495735344;57547.13679294814;57653;57654.4234557649;1399.5801259622074;1424.145512692397;1430.0561629324595;1448.3120517753982;1477.047304488599;32046.19884502906;32240.677593224707;32298.83850580732;32880.01359959205;32907.341853163285;50894.745526272134;51622.48377516177;52233.7388313056;52251.47748522618;52290;412137;413214;413262;416905;417264;28282.15153545397;28466.288342791595;28670.569941450478;28699.28251793722;28832.711672883004;45753.54246457493;45909.31136033029;46484;46691.53308466872;47022.29466557936;38901;39902.80048599738;40248;40281.597184027785;41050.79474602608;39768.403473947335;39780.60219397769;40285.59714402819;41174.79412602918;41325.38011929884;36425.635743642226;36458.27083458369;37201.25597488089;37392.81303593465;37469.250614987;29661.25846853846;31578.526322104728;31696.36607267888;32255.838720806245;32532.83733581317;25531;26637.334066648487;27633.309167270978;27749.44501110007;27795 08:27:08 INFO - PROCESS | 12126 | |2;jquery.html;394.400511222941;395.1070580488096;398.43621275894594;399.8820347997341;403.5298876808518;14247.572572822806;15254.16102114386;17828.82171178288;18531.72202416963;18558.1648825803;15870.571648551628;17589.82410175898;18325.541861453472;18350.816491835078;18399.90800046001;5072.797088116471;5164.380274367072;5339;5346.679199248058;5347.358317001946;5213.791448342062;5226.111561034614;5297.867553311159;5309.495597918191;5311.9468805312035;5073.974630126844;5246.816361427351;5255.5795536357;5261.289725887013;5283.762230699608;5282.4717528246865;5316.441773613773;5346.091164502044;5348.946510534904;5371.597130215249;4847.272909063633;5138.2549530318265;5172.431032586413;5215.426303106655;5230.476952304777;13296.867031329659;13448.865511344859;13450.12574182675;13524.18854868711;15163.696726065416;2262.751097379287;2279.3731723775927;2327.8603283803027;2369.1234243329905;2504.474060447308;9837.754056148582;10114.291999560033;10135.89864101357;11043.558257669683;13808.792868106986;1929.4308179087202;1965.557749506364;2008.4677560446494;2030.8781473111512;2042.234162189179;74445;82894.58552707198;83292.58353708193;84071.579642102;87136;10152.289339746147;10330.380177189392;10514.631987880388;10990.560377584807;11095.50070246841;15352.692946141015;15437.922810385877;15466;15470.458533951258;15480.458183963732;7696.807579810549;7763.573003484863;7889.447738658238;7905.604719764104;7961.840763184704;7311.561306321638;7348.191698913115;7453.291937265951;7476.401887848959;7479.391930734918;4672.859814205579;4689.7655117244;4703.623710103184;4771.665983381199;4852.296417019513;1959.177145598852;1966.1054220329715;1974.2695202774778;1985.4738494299022;2036.847236457242;952.7713348796239;1016.1464369929295;1045.4459136657583;1121.7532142928706;1133.3030186435449;18150.81849181518;18528.44414667562;19106.426807195807;19239.422817315222;19591.804081959;1016.0753714120116;1030.340582027503;1037.9636712715019;1058.9788204235872;1128.7629597784558;10250.641227557;10538.473076346152;10564.841527377095;10625.149988000941;10710.946445267724;474727;477284;481991;505728;507936;88710.55644721736;91430;92219.53890230505;93027.53486232525;93882.53058734663;1010.7877345757473;1018.3126389686931;1030.8144533983955;1036.233187441288;1039.1478987230398;16337.83662163363;16395.716003132817;16649.833501664827;16672.83327166713;16921.576960576083;33811.83094084514;35239.82380088083;36779.63220367762;36832.26335473329;37162.28377162262;46280.768596156806;47591.76204118957;49010.50989490202;50817;51686;8507.659693612433;8518.23335899772;8698.608562614823;8750.562471876508;8972.775680608038;9454.19639330637;11831.408429578314;12929.513105992932;13099.559048504467;13261.270630115436;11770.76458470843;11780.82328765052;11794.705132371759;12077.57728479499;12152;11382.715432114263;11696.590619328623;11746.941265293619;11822.231554948901;11912.047036237254;6664.83337916556;11202.38386888729;11694.415279236175;11771.23486973344;12017.399130043637;8351.24838764514;8659.622747128498;8829.11708829112;8907.910920890708;9050.954745226232;11303.830442543203;12132.939335303266;12250.938745306574;12261.938690306491;12426.689332766753 08:27:08 INFO - PROCESS | 12126 | |3;mootools.html;1489.210718319291;1530.8163020437546;1668.9833101668987;1792.9551761205976;1836.7336736173256;7724;8214.671413143475;8269.37979651527;8480.575971201439;8512.063672995973;8281.461704989171;8289.792755181123;8298.751037468886;8310.293625041879;8352.958235208831;2307.884605769709;2336.5210131923;2337.181986304788;2342.8242881783935;2348.5420343033115;2278.601244782165;2289.599320118981;2310.06442390832;2310.353101131686;2314.6759453676414;2298.5747636687183;2300.620397634388;2322.2684854270933;2350.588646986779;2359.327591636384;2265.5015896502828;2271.931842044741;2273.30664147435;2274.942151899375;2294.4608017115966;2257.2776711452343;2257.34536984276;2261.3894248552965;2269.296518079384;2273.158931195468;8502;8532;8551.273141782956;8580.82838343236;8594.312455003585;5081.237814327844;5198.610104242197;5226.947730522684;5235.738213089368;5255.343082114736;3297.258116923697;3346.9330613387597;3442.397580423441;3455.87904423344;3485.1635607454027;1126.6901602059418;1130.1128614038023;1131.835883796853;1162.6744511536783;1169.5321871251483;11616;11649.941750291278;11651.475683594173;11656.242344247597;11685.357305348287;4431;4587.977060114678;4761.595264402565;4762.309465127606;4769.236922092448;9262.073792620818;9322.114399132071;9343.018983006823;9356.157945784911;9371.953140234255;5119.129747942859;5128.640995130305;5135.871603209875;5136.43499215086;5171.5345618893725;4297.05464797744;4744.952550474451;4804.903901921942;4812;4845.53967373099;3647.361711700442;3745.8127093645207;3818.7899665518107;3829.3872980323013;3851.557070936878;1150.2753265442718;1162.9709257268637;1175.3535555444641;1175.9000484958704;1178.3165763856941;962.5091203486132;976.1312431935582;982.3467394182788;992.6873034994098;1013.4881884648205;5636.718164091779;5703.74333155009;5819.941800582024;5987.1318658794235;6008.669523176267;429.3173853572834;435.24919513839006;442.06723812755064;442.92369542012574;448.7195502810743;4014.538328092307;4046.5548789633117;4071.796410179479;4081.10215752534;4100.507939047274;10294.536745846455;10667.986541278566;10697.41164235959;10733.731656708645;10761.085307748772;10367.896321036844;10483.161347092215;10599.947000265103;10619.84070238947;10621.84067238992;7701.422393320411;7873.606319683993;8009;8081.434299599089;8091.676332946617;5765.3946335634155;5996.2504686914135;6007.639541627516;6105.603135796159;6206.06908963641;9678.75803104928;9736.464494452874;9750.853737193806;9839.360441571562;9847.803043938939;9757.756056098655;9758.658446954323;9972.152367048882;10019.749506262402;10070.597176112873;7991.680332786624;8187.426880118573;8254.711085111992;8257.876131857907;8276.751697449086;8213.630386632496;8235.547044912348;8304.169583041648;8320.167983201873;8321.209485098905;7432.739854105297;7473.551586904803;7519.473636845369;7524.134724506752;7609.809754756176;7147.1780745214965;7324.157721862054;7331.083614548182;7414.036175297177;7459.216782237787;6882.242953275236;6910.896336554855;6932.544165725254;6940.1671799382375;6955.513114081966;4997.800087996585;5106.106431374569;5149.948500514947;5202;5214.530692237565;4980.676256043345;5007.499250075109;5025.271335656383;5037.899242015213;5205.141151709925 08:27:08 INFO - PROCESS | 12126 | |4;prototype.html;326.26752939650487;335.0818756606897;339.9376947040497;344.56928838951313;345.0511094490153;5888.057910734284;5963.612365196264;5978.02461363194;6118.898598252313;6122.602030867991;6019.7893073742425;6044.969775151129;6045.425684559971;6057.242844644419;6061;4567.611753000999;4574.885627859297;4601.792919318638;4601.93097103542;4614.838480653178;4347.956520434786;4539.273716205408;4561.657875659323;4562.498125206224;4589.747563883985;4469.508354081048;4501.662375321847;4521.841735539257;4524.696971211018;4525.502194758574;4478.798454069559;4519.751413672247;4538.977305113486;4560.156371071329;4563.794629241692;3618.3306088373733;3852.8266228019806;3870;3925.666318362914;3951.6443520083044;5739.684317362543;5743.16724075011;5757.992351338499;5765.827025189251;5775.306963164405;5164.767585458663;5176.482351764831;5187.48125187482;5203.713795741232;5205.479452054802;6002.159697642333;6276.717547710318;6298.4646305064125;6341.112244285804;6352.396522330371;4286.614204721559;4325.13497300538;4342.370356298351;4344.522102568715;4347.239233134221;6288.559800813945;6521.510886683518;6579.835504112435;6596.868062638769;6598.076269322299;4388.210122178039;4428.402165707588;4442.73343599385;4443.200223959654;4466.3523789050405;4532.4334458192725;4533.957189846288;4535.843359943194;4538.115067561794;4542.863714088583;5126.282320475137;5243.9213411798855;5254.264402983586;5262.342207224097;5288.101022826128;6125.387461253928;6354.3963323484195;6374.713137908805;6415.422611964946;6438.259600146043;1506.691128318714;1527.1219049046842;1535.3704980957755;1543.4597890738376;1544.9073055616475;1009.4750729620556;1019.5666841592293;1029.6447725534679;1032.8605638238741;1038.8649475568127;5977.372375900555;6021.909671354933;6091.659834836329;6150;6154.78458253959;6521.47828173745;6535.346465353522;6550.7707230246715;6555.4427873631275;6579.47364210862;5991.400859913973;6003.939960600338;6072.635641861414;6079.635221886701;6103.908441373383;3454.1191996040848;3504.421770407905;3509.2279698466295;3535.292941411728;3541.6281290464644;6624.569402988886;6784.728610855609;6798.558093723892;6815.829604259933;6844.486663500257;6567.1462709848365;6613.5370524062855;6667.699953502104;6675.499337549703;6705.731770729116;6466.191726034246;6669.7665581704405;6673.399394054559;6702.39678428934;6791.45668346541;6478.6760661967655;6491.415772580491;6492.220933488012;6520.445762110084;6531.771388001397;6320.5259605528845;6435.967820160869;6446.67766611677;6454.451371633464;6488.513361497812;6721.092652491851;6753.459723222229;6763.086983257394;6816.7614133505085;6826.556273842184;4441.667499749998;4470.418845550058;4472.843450479218;4488.102379524043;4499.595036446604;6229.595076320024;6362.586431881913;6440.8389790255615;6556.541042127005;6671.733130674913;6356.841078972878;6413.743450261937;6445.806625801233;6471.191101112361;6508.949680850517;6238.656873871981;6384.872302554016;6420.518461115342;6427.935720642734;6446.871062578816;6279.183706118175;6290.433860952537;6315.3053164152825;6327.746890124527;6336.112944187726;6387.616742995435;6458.515611329263;6490.253620833664;6519.934800651933;6533.901991470037;6117.868194384053;6148.3236843948025;6288.402601752826;6312.210973628296;6320.778772742932 08:27:08 INFO - PROCESS | 12126 | |5;yui.html;790.0440467034888;796.2276591706043;822.3626689315779;841.1840514700739;886.3131073418105;14230.71538569228;14264.500742474029;14281.357338919748;14314.785278220808;14519.927400362996;13019.934900325508;13057.216567005986;13117.409716562754;13119;13195.406206720696;685.4413652872918;792.2552800367665;813.5688085314763;819.2462934100612;823.3207603726919;825.2201669422399;825.8141918068446;827.2224109337234;830.0205757206494;832.9625166867476;865.2429124516049;868.7741187291318;870.1602953150241;871.5424402188838;871.7428358634187;861.4013260783727;863.5423225690331;863.7408777366765;864.4078806017866;867.2628265973872;627.5732501898707;631.251966419794;633.4045996763074;634.1724050114599;635.3106879036205;14718.779218311734;14748.262586870613;14824.03643763152;14862.777058344134;14902.925485372503;14065.226412547307;14093.436262549485;14266.714665706628;14427.567172984827;14460.132392056405;11658.533658653643;11817.35004574748;11848.644540663794;11858.11064170182;11919.284842909366;3780.867669631577;3801.7528860624247;3828.89053836613;3840.539135303781;3900.8829735107993;51973.48026519724;52706.20940685893;52743.73628131835;52819.20771188435;52919.20621190685;11066.612668556723;11219.382933938548;11394.316341019565;11437.71405714847;11445.08439324852;20263;20502.282420115225;20597.691034634492;20618.27836025762;20718.689219661715;8324.750257492286;8378.874316885129;8480.321574274043;8511.57442127891;8630.611622477003;4790.520947905182;4813.542713442217;4896.853094407174;4916.754162291871;4918.360613120343;3312.585926759155;3429.53701250333;3442.535257740173;3448.5689288838894;3450.447928331455;630.8359826445065;649.5355820588302;652.6932341799346;669.7019826177304;670.4066900792736;766.7929658992152;767.1331395523023;778.3034184404926;783.8275579372529;785.2090830127808;9237.907620923705;9613.855792163124;9876.654317098866;9964.701058968243;10082;581.8429024163452;678.9984772460581;732.6629750314914;763.8090477380655;773.9226077392216;4550.840720574764;4588.357629931812;4678.485366609671;4684.1568517666465;4699.295105734167;51623;64671.67664161743;65216.347836521025;65462;65568.67215663986;51042;51347.22979155316;51559.226611600854;52198.21702674463;52568.737156313975;36968.63031369706;37226.255474890895;44112.77943610262;44654;46427.767861161155;9004.639814407612;9486.762830929281;9572.521373931137;9591.18474929611;9594.808103838024;31621.841890790398;32031.6796832038;32617.18457038593;32812;32952.34095318128;42517.787411062745;42913.35629965491;42917;43130.78434607807;43435;11812.70468238301;11959.641210763692;12265.509379624715;12321.93839030799;12460.688482788002;13397.33013349348;13758.174509529461;14349.641258968191;14372.425102995763;14418.495352662607;12737.745245095231;13052.21686698801;13600.183988960694;13841.37713802861;14133.15201087938;12621.93689031549;13230.669233269246;13262.933685331898;13310.933445332712;13328.33358332099;12240.632781016584;12406.193597416139;12537.122401431812;12747.107702460738;12801.167924084904;10262.127719143957;10276.845847312446;10478.109360704426;10587.258891877495;10866.891331086588;10347.534360953925;10537.42044187577;10596.89403105959;10638.308509946828;10640.148788097089 08:27:08 INFO - PROCESS | 12126 | __end_tp_report 08:27:08 INFO - PROCESS | 12126 | __start_cc_report 08:27:08 INFO - PROCESS | 12126 | _x_x_mozilla_cycle_collect,341 08:27:08 INFO - PROCESS | 12126 | __end_cc_report 08:27:08 INFO - PROCESS | 12126 | __startTimestamp1460993228434__endTimestamp 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | ------- Summary: start ------- 08:27:08 INFO - PROCESS | 12126 | Number of tests: 6 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | [#0] dojo.html Cycles:165 Average:5466.54 Median:5674.57 stddev:642.12 (11.3%) stddev-sans-first:617.27 08:27:08 INFO - PROCESS | 12126 | Values: 3125.9 3159.0 3174.7 3213.3 3215.1 5410.8 5472.1 5484.3 5496.7 5527.4 5432.9 5498.7 5517.2 5539.1 5591.3 4953.6 4963.8 4966.1 5080.3 5088.4 4994.9 5018.0 5054.6 5068.4 5108.0 4893.0 4929.8 4979.3 5007.3 5032.9 4870.1 4909.4 4911.2 4911.5 4949.1 4843.7 4880.2 4897.0 4904.6 4924.5 5363.8 5415.9 5459.0 5462.4 5492.7 5811.8 5868.6 5870.1 5875.8 5903.5 5771.9 5924.9 5926.5 5929.9 5937.6 5434.5 5467.6 5474.5 5482.7 5495.6 5996.6 6016.1 6017.6 6027.6 6049.2 5776.9 5786.3 5791.0 5820.9 5849.6 5803.9 5894.4 5895.5 5916.7 5944.9 5928.6 5973.6 5983.2 5984.5 5985.0 5686.1 5796.7 5824.7 5842.8 5890.3 4483.1 4497.9 4503.8 4507.6 4544.8 3945.3 3987.3 4006.6 4008.7 4028.0 5646.0 5648.5 5674.6 5713.2 5722.9 5870.8 5884.8 5894.0 5909.9 5919.7 5545.8 5549.6 5553.0 5567.7 5571.7 4757.5 4866.5 4869.7 4959.4 4982.3 6105.0 6179.1 6194.9 6200.0 6216.4 5906.2 5989.2 6009.4 6011.3 6022.7 6105.6 6123.1 6137.4 6174.0 6179.4 5839.9 5865.1 5870.7 5877.9 5880.9 5689.8 5920.0 5965.5 5965.8 5978.9 5644.0 5670.2 5680.8 5702.4 5816.0 5717.9 5729.4 5748.1 5748.5 5754.4 5615.8 5658.2 5658.4 5677.4 5692.9 5815.9 5900.7 5910.6 5928.4 5936.1 5569.7 5604.6 5628.7 5636.5 5654.4 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | [#1] ext.html Cycles:180 Average:55233.00 Median:37297.03 stddev:105540.16 (283.0%) stddev-sans-first:105756.52 08:27:08 INFO - PROCESS | 12126 | Values: 601.4 649.4 660.5 664.9 666.7 33348.8 34461.3 34709.8 34718.8 34858.1 34907.3 35062.7 35195.0 35304.6 35340.5 8340.1 8528.8 8543.7 8556.2 8564.0 8354.8 8703.2 8770.1 8771.0 8790.6 8680.3 8808.5 8808.7 8830.7 8851.1 8704.3 8781.0 8793.8 8796.5 8818.9 8535.2 8629.4 8664.4 8697.0 8719.3 32031.0 36525.6 36764.0 36890.8 36929.3 3359.9 3364.7 3441.0 3803.6 4113.2 29217.4 29327.6 29576.4 30138.0 30217.4 3907.4 3951.8 3982.9 3991.2 4045.9 284006.0 286748.6 290986.0 291406.0 291620.0 61414.0 62943.0 62974.7 63136.0 63396.4 64481.4 65041.0 65156.3 65318.7 65630.7 14978.0 15216.8 15219.3 15221.7 15222.3 11844.5 12104.3 12128.2 12132.9 12134.3 19126.7 19240.7 19358.0 19866.9 19962.4 7610.7 7830.3 8003.9 8107.6 8159.9 1067.5 1087.8 1114.6 1120.8 1132.0 31503.8 31717.8 31960.4 32262.4 32985.8 1124.5 1141.4 1175.0 1181.2 1199.1 14988.5 15257.0 15283.9 17243.3 18149.9 466984.0 470275.0 470617.0 472553.0 473158.0 56776.4 57350.4 57547.1 57653.0 57654.4 1399.6 1424.1 1430.1 1448.3 1477.0 32046.2 32240.7 32298.8 32880.0 32907.3 50894.7 51622.5 52233.7 52251.5 52290.0 412137.0 413214.0 413262.0 416905.0 417264.0 28282.2 28466.3 28670.6 28699.3 28832.7 45753.5 45909.3 46484.0 46691.5 47022.3 38901.0 39902.8 40248.0 40281.6 41050.8 39768.4 39780.6 40285.6 41174.8 41325.4 36425.6 36458.3 37201.3 37392.8 37469.3 29661.3 31578.5 31696.4 32255.8 32532.8 25531.0 26637.3 27633.3 27749.4 27795.0 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | [#2] jquery.html Cycles:180 Average:28118.54 Median:2152.49 stddev:80758.38 (3751.9%) stddev-sans-first:80958.10 08:27:08 INFO - PROCESS | 12126 | Values: 394.4 395.1 398.4 399.9 403.5 14247.6 15254.2 17828.8 18531.7 18558.2 15870.6 17589.8 18325.5 18350.8 18399.9 5072.8 5164.4 5339.0 5346.7 5347.4 5213.8 5226.1 5297.9 5309.5 5311.9 5074.0 5246.8 5255.6 5261.3 5283.8 5282.5 5316.4 5346.1 5348.9 5371.6 4847.3 5138.3 5172.4 5215.4 5230.5 13296.9 13448.9 13450.1 13524.2 15163.7 2262.8 2279.4 2327.9 2369.1 2504.5 9837.8 10114.3 10135.9 11043.6 13808.8 1929.4 1965.6 2008.5 2030.9 2042.2 74445.0 82894.6 83292.6 84071.6 87136.0 10152.3 10330.4 10514.6 10990.6 11095.5 15352.7 15437.9 15466.0 15470.5 15480.5 7696.8 7763.6 7889.4 7905.6 7961.8 7311.6 7348.2 7453.3 7476.4 7479.4 4672.9 4689.8 4703.6 4771.7 4852.3 1959.2 1966.1 1974.3 1985.5 2036.8 952.8 1016.1 1045.4 1121.8 1133.3 18150.8 18528.4 19106.4 19239.4 19591.8 1016.1 1030.3 1038.0 1059.0 1128.8 10250.6 10538.5 10564.8 10625.1 10710.9 474727.0 477284.0 481991.0 505728.0 507936.0 88710.6 91430.0 92219.5 93027.5 93882.5 1010.8 1018.3 1030.8 1036.2 1039.1 16337.8 16395.7 16649.8 16672.8 16921.6 33811.8 35239.8 36779.6 36832.3 37162.3 46280.8 47591.8 49010.5 50817.0 51686.0 8507.7 8518.2 8698.6 8750.6 8972.8 9454.2 11831.4 12929.5 13099.6 13261.3 11770.8 11780.8 11794.7 12077.6 12152.0 11382.7 11696.6 11746.9 11822.2 11912.0 6664.8 11202.4 11694.4 11771.2 12017.4 8351.2 8659.6 8829.1 8907.9 9051.0 11303.8 12132.9 12250.9 12261.9 12426.7 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | [#3] mootools.html Cycles:180 Average:5639.36 Median:5016.39 stddev:3162.62 (63.0%) stddev-sans-first:3156.11 08:27:08 INFO - PROCESS | 12126 | Values: 1489.2 1530.8 1669.0 1793.0 1836.7 7724.0 8214.7 8269.4 8480.6 8512.1 8281.5 8289.8 8298.8 8310.3 8353.0 2307.9 2336.5 2337.2 2342.8 2348.5 2278.6 2289.6 2310.1 2310.4 2314.7 2298.6 2300.6 2322.3 2350.6 2359.3 2265.5 2271.9 2273.3 2274.9 2294.5 2257.3 2257.3 2261.4 2269.3 2273.2 8502.0 8532.0 8551.3 8580.8 8594.3 5081.2 5198.6 5226.9 5235.7 5255.3 3297.3 3346.9 3442.4 3455.9 3485.2 1126.7 1130.1 1131.8 1162.7 1169.5 11616.0 11649.9 11651.5 11656.2 11685.4 4431.0 4588.0 4761.6 4762.3 4769.2 9262.1 9322.1 9343.0 9356.2 9372.0 5119.1 5128.6 5135.9 5136.4 5171.5 4297.1 4745.0 4804.9 4812.0 4845.5 3647.4 3745.8 3818.8 3829.4 3851.6 1150.3 1163.0 1175.4 1175.9 1178.3 962.5 976.1 982.3 992.7 1013.5 5636.7 5703.7 5819.9 5987.1 6008.7 429.3 435.2 442.1 442.9 448.7 4014.5 4046.6 4071.8 4081.1 4100.5 10294.5 10668.0 10697.4 10733.7 10761.1 10367.9 10483.2 10599.9 10619.8 10621.8 7701.4 7873.6 8009.0 8081.4 8091.7 5765.4 5996.3 6007.6 6105.6 6206.1 9678.8 9736.5 9750.9 9839.4 9847.8 9757.8 9758.7 9972.2 10019.7 10070.6 7991.7 8187.4 8254.7 8257.9 8276.8 8213.6 8235.5 8304.2 8320.2 8321.2 7432.7 7473.6 7519.5 7524.1 7609.8 7147.2 7324.2 7331.1 7414.0 7459.2 6882.2 6910.9 6932.5 6940.2 6955.5 4997.8 5106.1 5149.9 5202.0 5214.5 4980.7 5007.5 5025.3 5037.9 5205.1 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | [#4] prototype.html Cycles:180 Average:5285.96 Median:6051.33 stddev:1613.20 (26.7%) stddev-sans-first:1574.18 08:27:08 INFO - PROCESS | 12126 | Values: 326.3 335.1 339.9 344.6 345.1 5888.1 5963.6 5978.0 6118.9 6122.6 6019.8 6045.0 6045.4 6057.2 6061.0 4567.6 4574.9 4601.8 4601.9 4614.8 4348.0 4539.3 4561.7 4562.5 4589.7 4469.5 4501.7 4521.8 4524.7 4525.5 4478.8 4519.8 4539.0 4560.2 4563.8 3618.3 3852.8 3870.0 3925.7 3951.6 5739.7 5743.2 5758.0 5765.8 5775.3 5164.8 5176.5 5187.5 5203.7 5205.5 6002.2 6276.7 6298.5 6341.1 6352.4 4286.6 4325.1 4342.4 4344.5 4347.2 6288.6 6521.5 6579.8 6596.9 6598.1 4388.2 4428.4 4442.7 4443.2 4466.4 4532.4 4534.0 4535.8 4538.1 4542.9 5126.3 5243.9 5254.3 5262.3 5288.1 6125.4 6354.4 6374.7 6415.4 6438.3 1506.7 1527.1 1535.4 1543.5 1544.9 1009.5 1019.6 1029.6 1032.9 1038.9 5977.4 6021.9 6091.7 6150.0 6154.8 6521.5 6535.3 6550.8 6555.4 6579.5 5991.4 6003.9 6072.6 6079.6 6103.9 3454.1 3504.4 3509.2 3535.3 3541.6 6624.6 6784.7 6798.6 6815.8 6844.5 6567.1 6613.5 6667.7 6675.5 6705.7 6466.2 6669.8 6673.4 6702.4 6791.5 6478.7 6491.4 6492.2 6520.4 6531.8 6320.5 6436.0 6446.7 6454.5 6488.5 6721.1 6753.5 6763.1 6816.8 6826.6 4441.7 4470.4 4472.8 4488.1 4499.6 6229.6 6362.6 6440.8 6556.5 6671.7 6356.8 6413.7 6445.8 6471.2 6508.9 6238.7 6384.9 6420.5 6427.9 6446.9 6279.2 6290.4 6315.3 6327.7 6336.1 6387.6 6458.5 6490.3 6519.9 6533.9 6117.9 6148.3 6288.4 6312.2 6320.8 08:27:08 INFO - PROCESS | 12126 | 08:27:08 INFO - PROCESS | 12126 | [#5] yui.html Cycles:180 Average:14503.69 Median:43023.89 stddev:16188.46 (37.6%) stddev-sans-first:16201.11 08:27:08 INFO - PROCESS | 12126 | Values: 790.0 796.2 822.4 841.2 886.3 14230.7 14264.5 14281.4 14314.8 14519.9 13019.9 13057.2 13117.4 13119.0 13195.4 685.4 792.3 813.6 819.2 823.3 825.2 825.8 827.2 830.0 833.0 865.2 868.8 870.2 871.5 871.7 861.4 863.5 863.7 864.4 867.3 627.6 631.3 633.4 634.2 635.3 14718.8 14748.3 14824.0 14862.8 14902.9 14065.2 14093.4 14266.7 14427.6 14460.1 11658.5 11817.4 11848.6 11858.1 11919.3 3780.9 3801.8 3828.9 3840.5 3900.9 51973.5 52706.2 52743.7 52819.2 52919.2 11066.6 11219.4 11394.3 11437.7 11445.1 20263.0 20502.3 20597.7 20618.3 20718.7 8324.8 8378.9 8480.3 8511.6 8630.6 4790.5 4813.5 4896.9 4916.8 4918.4 3312.6 3429.5 3442.5 3448.6 3450.4 630.8 649.5 652.7 669.7 670.4 766.8 767.1 778.3 783.8 785.2 9237.9 9613.9 9876.7 9964.7 10082.0 581.8 679.0 732.7 763.8 773.9 4550.8 4588.4 4678.5 4684.2 4699.3 51623.0 64671.7 65216.3 65462.0 65568.7 51042.0 51347.2 51559.2 52198.2 52568.7 36968.6 37226.3 44112.8 44654.0 46427.8 9004.6 9486.8 9572.5 9591.2 9594.8 31621.8 32031.7 32617.2 32812.0 32952.3 42517.8 42913.4 42917.0 43130.8 43435.0 11812.7 11959.6 12265.5 12321.9 12460.7 13397.3 13758.2 14349.6 14372.4 14418.5 12737.7 13052.2 13600.2 13841.4 14133.2 12621.9 13230.7 13262.9 13310.9 13328.3 12240.6 12406.2 12537.1 12747.1 12801.2 10262.1 10276.8 10478.1 10587.3 10866.9 10347.5 10537.4 10596.9 10638.3 10640.1 08:27:08 INFO - PROCESS | 12126 | -------- Summary: end -------- 08:27:08 INFO - PROCESS | 12126 | 08:27:09 INFO - TEST-INFO | 12126: exit 0 08:27:09 INFO - TEST-OK | dromaeo_css | took 1110049ms 08:27:09 INFO - TEST-START | kraken 08:27:09 INFO - operating with platform_type : linux_ 08:27:09 INFO - Initialising browser for kraken test... 08:27:09 INFO - TEST-INFO | started process 12358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGXwRwc/profile http://localhost:45969/getInfo.html) 08:27:12 INFO - PROCESS | 12358 | 08:27:12 INFO - PROCESS | 12358 | (process:12426): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:12 INFO - PROCESS | 12358 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:27:13 INFO - PROCESS | 12358 | __metrics Screen width/height:1600/1200 08:27:13 INFO - PROCESS | 12358 | colorDepth:24 08:27:13 INFO - PROCESS | 12358 | Browser inner width/height: 1024/697 08:27:13 INFO - PROCESS | 12358 | __metrics 08:27:14 ERROR - PROCESS | 12358 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:27:14 INFO - TEST-INFO | 12358: exit 0 08:27:14 INFO - Browser initialized. 08:27:14 INFO - Running cycle 1/1 for kraken test... 08:27:14 INFO - TEST-INFO | started process 12477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGXwRwc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:16 INFO - PROCESS | 12477 | 08:27:16 INFO - PROCESS | 12477 | (process:12535): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:26 INFO - PROCESS | 12477 | RSS: Main: 163663872 08:27:26 INFO - PROCESS | 12477 | 08:27:29 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45969/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:30 INFO - PROCESS | 12477 | RSS: Main: 168493056 08:27:30 INFO - PROCESS | 12477 | 08:27:32 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45969/tests/kraken/driver.html?testName=audio-dft) 08:27:33 INFO - PROCESS | 12477 | RSS: Main: 171483136 08:27:33 INFO - PROCESS | 12477 | 08:27:36 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45969/tests/kraken/driver.html?testName=audio-fft) 08:27:36 INFO - PROCESS | 12477 | RSS: Main: 162709504 08:27:36 INFO - PROCESS | 12477 | 08:27:39 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45969/tests/kraken/driver.html?testName=audio-oscillator) 08:27:39 INFO - PROCESS | 12477 | RSS: Main: 163098624 08:27:39 INFO - PROCESS | 12477 | 08:27:42 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:42 INFO - PROCESS | 12477 | RSS: Main: 163549184 08:27:42 INFO - PROCESS | 12477 | 08:27:45 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45969/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:46 INFO - PROCESS | 12477 | RSS: Main: 164020224 08:27:46 INFO - PROCESS | 12477 | 08:27:49 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45969/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:50 INFO - PROCESS | 12477 | RSS: Main: 166166528 08:27:50 INFO - PROCESS | 12477 | 08:27:53 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45969/tests/kraken/driver.html?testName=json-parse-financial) 08:27:53 INFO - PROCESS | 12477 | RSS: Main: 166678528 08:27:53 INFO - PROCESS | 12477 | 08:27:55 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:56 INFO - PROCESS | 12477 | RSS: Main: 166318080 08:27:56 INFO - PROCESS | 12477 | 08:27:57 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:58 INFO - PROCESS | 12477 | RSS: Main: 166371328 08:27:58 INFO - PROCESS | 12477 | 08:28:00 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:01 INFO - PROCESS | 12477 | RSS: Main: 166653952 08:28:01 INFO - PROCESS | 12477 | 08:28:03 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:04 INFO - PROCESS | 12477 | RSS: Main: 167129088 08:28:04 INFO - PROCESS | 12477 | 08:28:07 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:07 INFO - PROCESS | 12477 | RSS: Main: 167047168 08:28:07 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | Cycle 1(1): loaded http://localhost:45969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45969/tests/kraken/driver.html?testName=ai-astar) 08:28:09 INFO - PROCESS | 12477 | RSS: Main: 168476672 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | __start_tp_report 08:28:09 INFO - PROCESS | 12477 | _x_x_mozilla_page_load 08:28:09 INFO - PROCESS | 12477 | _x_x_mozilla_page_load_details 08:28:09 INFO - PROCESS | 12477 | |i|pagename|runs| 08:28:09 INFO - PROCESS | 12477 | |0;ai-astar;112;106;112;111;113;126;111;111;111;112 08:28:09 INFO - PROCESS | 12477 | |1;audio-beat-detection;166;129;157;182;137;163;165;131;184;131 08:28:09 INFO - PROCESS | 12477 | |2;audio-dft;162;162;162;162;164;164;173;164;166;163 08:28:09 INFO - PROCESS | 12477 | |3;audio-fft;73;74;78;149;74;73;76;75;174;72 08:28:09 INFO - PROCESS | 12477 | |4;audio-oscillator;92;93;144;92;94;93;150;93;93;146 08:28:09 INFO - PROCESS | 12477 | |5;imaging-gaussian-blur;117;117;117;117;118;119;118;117;118;118 08:28:09 INFO - PROCESS | 12477 | |6;imaging-darkroom;147;148;146;146;147;148;146;146;146;147 08:28:09 INFO - PROCESS | 12477 | |7;imaging-desaturate;96;104;96;100;96;96;95;96;95;95 08:28:09 INFO - PROCESS | 12477 | |8;json-parse-financial;61;59;58;58;57;58;62;72;57;59 08:28:09 INFO - PROCESS | 12477 | |9;json-stringify-tinderbox;60;60;60;61;60;60;61;60;61;60 08:28:09 INFO - PROCESS | 12477 | |10;stanford-crypto-aes;79;78;78;78;78;78;78;78;78;79 08:28:09 INFO - PROCESS | 12477 | |11;stanford-crypto-ccm;127;137;128;127;125;131;136;130;159;134 08:28:09 INFO - PROCESS | 12477 | |12;stanford-crypto-pbkdf2;167;166;170;167;167;176;173;165;168;174 08:28:09 INFO - PROCESS | 12477 | |13;stanford-crypto-sha256-iterative;73;72;73;73;73;67;70;68;71;71 08:28:09 INFO - PROCESS | 12477 | __end_tp_report 08:28:09 INFO - PROCESS | 12477 | __start_cc_report 08:28:09 INFO - PROCESS | 12477 | _x_x_mozilla_cycle_collect,882 08:28:09 INFO - PROCESS | 12477 | __end_cc_report 08:28:09 INFO - PROCESS | 12477 | __startTimestamp1460993289819__endTimestamp 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | ------- Summary: start ------- 08:28:09 INFO - PROCESS | 12477 | Number of tests: 14 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:5.10 (4.6%) stddev-sans-first:5.41 08:28:09 INFO - PROCESS | 12477 | Values: 112.0 106.0 112.0 111.0 113.0 126.0 111.0 111.0 111.0 112.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:164.00 stddev:21.10 (12.9%) stddev-sans-first:21.97 08:28:09 INFO - PROCESS | 12477 | Values: 166.0 129.0 157.0 182.0 137.0 163.0 165.0 131.0 184.0 131.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.36 (2.0%) stddev-sans-first:3.47 08:28:09 INFO - PROCESS | 12477 | Values: 162.0 162.0 162.0 162.0 164.0 164.0 173.0 164.0 166.0 163.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.00 stddev:37.24 (50.3%) stddev-sans-first:38.88 08:28:09 INFO - PROCESS | 12477 | Values: 73.0 74.0 78.0 149.0 74.0 73.0 76.0 75.0 174.0 72.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:26.04 (28.0%) stddev-sans-first:26.88 08:28:09 INFO - PROCESS | 12477 | Values: 92.0 93.0 144.0 92.0 94.0 93.0 150.0 93.0 93.0 146.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 08:28:09 INFO - PROCESS | 12477 | Values: 117.0 117.0 117.0 117.0 118.0 119.0 118.0 117.0 118.0 118.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:28:09 INFO - PROCESS | 12477 | Values: 147.0 148.0 146.0 146.0 147.0 148.0 146.0 146.0 146.0 147.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:2.88 (3.0%) stddev-sans-first:3.04 08:28:09 INFO - PROCESS | 12477 | Values: 96.0 104.0 96.0 100.0 96.0 96.0 95.0 96.0 95.0 95.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:4.48 (7.6%) stddev-sans-first:4.74 08:28:09 INFO - PROCESS | 12477 | Values: 61.0 59.0 58.0 58.0 57.0 58.0 62.0 72.0 57.0 59.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 08:28:09 INFO - PROCESS | 12477 | Values: 60.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 61.0 60.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 08:28:09 INFO - PROCESS | 12477 | Values: 79.0 78.0 78.0 78.0 78.0 78.0 78.0 78.0 78.0 79.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:132.50 stddev:9.86 (7.4%) stddev-sans-first:10.18 08:28:09 INFO - PROCESS | 12477 | Values: 127.0 137.0 128.0 127.0 125.0 131.0 136.0 130.0 159.0 134.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:3.77 (2.2%) stddev-sans-first:3.91 08:28:09 INFO - PROCESS | 12477 | Values: 167.0 166.0 170.0 167.0 167.0 176.0 173.0 165.0 168.0 174.0 08:28:09 INFO - PROCESS | 12477 | 08:28:09 INFO - PROCESS | 12477 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:72.50 stddev:2.18 (3.0%) stddev-sans-first:2.20 08:28:09 INFO - PROCESS | 12477 | Values: 73.0 72.0 73.0 73.0 73.0 67.0 70.0 68.0 71.0 71.0 08:28:09 INFO - PROCESS | 12477 | -------- Summary: end -------- 08:28:09 INFO - PROCESS | 12477 | 08:28:10 INFO - TEST-INFO | 12477: exit 0 08:28:10 INFO - TEST-OK | kraken | took 61625ms 08:28:10 INFO - SUITE-END | took 1171s 08:28:10 INFO - Completed test suite (00:19:31) 08:28:10 INFO - javascript benchmark 08:28:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.9062228133157, 3158.9842050789744, 3174.6984036516537, 3213.277012672149, 3215.099772063823, 5410.83767486975, 5472.069748142815, 5484.287042684446, 5496.725163741807, 5527.364353099395, 5432.91850622241, 5498.697571633558, 5517.200005999128, 5539.058360078786, 5591.30108736408, 4953.628477864157, 4963.751812409383, 4966.056449274644, 5080.314157588715, 5088.363954505687, 4994.875128121808, 5017.974910125445, 5054.620903432257, 5068.366454193226, 5108.003939231851, 4893.045856058088, 4929.827456039039, 4979.253112033188, 5007.298978143063, 5032.924506132411, 4870.147724148295, 4909.361782968192, 4911.214205727102, 4911.45973942866, 4949.084419382426, 4843.6851604645935, 4880.194767863299, 4897.0, 4904.558589726942, 4924.4583095859425, 5363.785448582052, 5415.864603384907, 5458.972705136489, 5462.399136095027, 5492.725363731797, 5811.79658711943, 5868.559858010623, 5870.148828419855, 5875.764969401262, 5903.527717782567, 5771.913421298684, 5924.851878703023, 5926.525877929756, 5929.911051334234, 5937.614055086448, 5434.483724046209, 5467.644603100785, 5474.479924407175, 5482.725863706799, 5495.6153069285165, 5996.610220335664, 6016.127661489059, 6017.6389416634265, 6027.578069535178, 6049.153118563405, 5776.855578610484, 5786.305643322744, 5791.044477661223, 5820.941790582125, 5849.561282903799, 5803.912941305884, 5894.410558944157, 5895.528357731371, 5916.674582897896, 5944.8811023780145, 5928.555358348141, 5973.641581505037, 5983.1623572699855, 5984.521238300926, 5985.0, 5686.14707793826, 5796.681182535001, 5824.737886795019, 5842.795502157489, 5890.322612899571, 4483.103379324149, 4497.910041799146, 4503.81984720614, 4507.5943165115295, 4544.7500387479, 3945.270125026879, 3987.282289187974, 4006.639402453735, 4008.7193896427552, 4028.0332720146953, 5646.040173170571, 5648.491635752802, 5674.574406919498, 5713.171590119409, 5722.914156287659, 5870.794522191788, 5884.764609415661, 5894.0, 5909.911351329733, 5919.704014799243, 5545.750441230154, 5549.5837812163445, 5553.028220061473, 5567.749451274703, 5571.693556854412, 4757.524247575215, 4866.46468888422, 4869.732164730903, 4959.429665588431, 4982.302477653131, 6104.969475152685, 6179.134921111048, 6194.907076393858, 6199.969000154971, 6216.4405203531, 5906.232189815297, 5989.221401217814, 6009.36901625323, 6011.338752737282, 6022.728977196124, 6105.603135796159, 6123.069106197319, 6137.41694539018, 6174.043023331391, 6179.412955769195, 5839.912401314069, 5865.120231965068, 5870.735816888165, 5877.882442351214, 5880.911786323123, 5689.804276299552, 5920.0, 5965.492933100735, 5965.761369545169, 5978.940210597838, 5644.0, 5670.234518339971, 5680.829575112753, 5702.37273899879, 5815.9709201453725, 5717.942820571741, 5729.3984131665575, 5748.080307150836, 5748.45389687979, 5754.424557544212, 5615.775368985358, 5658.207850900795, 5658.405867383865, 5677.432256774289, 5692.857678558069, 5815.883682326245, 5900.734466949083, 5910.615809972338, 5928.3775203603, 5936.139259807217, 5569.693666848362, 5604.635698679573, 5628.690422026828, 5636.4927156556105, 5654.378018417889], "value": 5421.986105416872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.4376557918347, 649.4220144071777, 660.5211221864146, 664.8670265946812, 666.7233098264221, 33348.83325583372, 34461.31077378454, 34709.826450867775, 34718.826405868, 34858.12854678634, 34907.301853962905, 35062.66904644061, 35195.0, 35304.64695353046, 35340.469892951565, 8340.08259091501, 8528.78678033048, 8543.700970466034, 8556.18716221958, 8564.0, 8354.832903341929, 8703.216710496054, 8770.122987701243, 8771.03518612952, 8790.560471976407, 8680.305575553972, 8808.515531645757, 8808.735737927873, 8830.735077947671, 8851.114888511162, 8704.30365570756, 8780.990186128613, 8793.824123517526, 8796.516191609458, 8818.86771698425, 8535.231829135346, 8629.395942284043, 8664.39349245553, 8697.0, 8719.346049046348, 32031.0, 36525.63474365249, 36764.0, 36890.81554592236, 36929.26141477182, 3359.932801343984, 3364.7068167828243, 3441.0, 3803.581606023335, 4113.177364527107, 29217.41565168706, 29327.560086598718, 29576.40847183066, 30138.0, 30217.395652086834, 3907.433422153772, 3951.8024098794945, 3982.900427489307, 3991.2217117662067, 4045.8583949561917, 284006.0, 286748.56625716947, 290986.0, 291406.0, 291620.0, 61414.0, 62943.0, 62974.685126574994, 63136.0, 63396.36603633997, 64481.355186448476, 65041.0, 65156.348436515975, 65318.67340663266, 65630.67184664142, 14978.0, 15216.847831521543, 15219.315130819139, 15221.695566088616, 15222.314995825214, 11844.466998985066, 12104.334261615695, 12128.151029427856, 12132.878671213175, 12134.332611706264, 19126.71523800936, 19240.71138932917, 19358.0, 19866.90066549658, 19962.401127965895, 7610.695572177162, 7830.334421574116, 8003.919960800434, 8107.635156417975, 8159.918400816035, 1067.514281002142, 1087.8096333141668, 1114.6098865397207, 1120.8318752187074, 1132.0, 31503.84248078791, 31717.841410792797, 31960.360792784013, 32262.354752904812, 32985.83507082449, 1124.4995976790412, 1141.4235810915434, 1174.9953789510016, 1181.2499063094997, 1199.0767109325946, 14988.47540336083, 15257.0, 15283.943211357551, 17243.310267589408, 18149.909250453664, 466984.0, 470275.0, 470617.0, 472553.0, 473158.0, 56776.432235677115, 57350.426495735344, 57547.13679294814, 57653.0, 57654.4234557649, 1399.5801259622074, 1424.145512692397, 1430.0561629324595, 1448.3120517753982, 1477.047304488599, 32046.19884502906, 32240.677593224707, 32298.83850580732, 32880.01359959205, 32907.341853163285, 50894.745526272134, 51622.48377516177, 52233.7388313056, 52251.47748522618, 52290.0, 412137.0, 413214.0, 413262.0, 416905.0, 417264.0, 28282.15153545397, 28466.288342791595, 28670.569941450478, 28699.28251793722, 28832.711672883004, 45753.54246457493, 45909.31136033029, 46484.0, 46691.53308466872, 47022.29466557936, 38901.0, 39902.80048599738, 40248.0, 40281.597184027785, 41050.79474602608, 39768.403473947335, 39780.60219397769, 40285.59714402819, 41174.79412602918, 41325.38011929884, 36425.635743642226, 36458.27083458369, 37201.25597488089, 37392.81303593465, 37469.250614987, 29661.25846853846, 31578.526322104728, 31696.36607267888, 32255.838720806245, 32532.83733581317, 25531.0, 26637.334066648487, 27633.309167270978, 27749.44501110007, 27795.0], "value": 19434.568984365753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.400511222941, 395.1070580488096, 398.43621275894594, 399.8820347997341, 403.5298876808518, 14247.572572822806, 15254.16102114386, 17828.82171178288, 18531.72202416963, 18558.1648825803, 15870.571648551628, 17589.82410175898, 18325.541861453472, 18350.816491835078, 18399.90800046001, 5072.797088116471, 5164.380274367072, 5339.0, 5346.679199248058, 5347.358317001946, 5213.791448342062, 5226.111561034614, 5297.867553311159, 5309.495597918191, 5311.9468805312035, 5073.974630126844, 5246.816361427351, 5255.5795536357, 5261.289725887013, 5283.762230699608, 5282.4717528246865, 5316.441773613773, 5346.091164502044, 5348.946510534904, 5371.597130215249, 4847.272909063633, 5138.2549530318265, 5172.431032586413, 5215.426303106655, 5230.476952304777, 13296.867031329659, 13448.865511344859, 13450.12574182675, 13524.18854868711, 15163.696726065416, 2262.751097379287, 2279.3731723775927, 2327.8603283803027, 2369.1234243329905, 2504.474060447308, 9837.754056148582, 10114.291999560033, 10135.89864101357, 11043.558257669683, 13808.792868106986, 1929.4308179087202, 1965.557749506364, 2008.4677560446494, 2030.8781473111512, 2042.234162189179, 74445.0, 82894.58552707198, 83292.58353708193, 84071.579642102, 87136.0, 10152.289339746147, 10330.380177189392, 10514.631987880388, 10990.560377584807, 11095.50070246841, 15352.692946141015, 15437.922810385877, 15466.0, 15470.458533951258, 15480.458183963732, 7696.807579810549, 7763.573003484863, 7889.447738658238, 7905.604719764104, 7961.840763184704, 7311.561306321638, 7348.191698913115, 7453.291937265951, 7476.401887848959, 7479.391930734918, 4672.859814205579, 4689.7655117244, 4703.623710103184, 4771.665983381199, 4852.296417019513, 1959.177145598852, 1966.1054220329715, 1974.2695202774778, 1985.4738494299022, 2036.847236457242, 952.7713348796239, 1016.1464369929295, 1045.4459136657583, 1121.7532142928706, 1133.3030186435449, 18150.81849181518, 18528.44414667562, 19106.426807195807, 19239.422817315222, 19591.804081959, 1016.0753714120116, 1030.340582027503, 1037.9636712715019, 1058.9788204235872, 1128.7629597784558, 10250.641227557, 10538.473076346152, 10564.841527377095, 10625.149988000941, 10710.946445267724, 474727.0, 477284.0, 481991.0, 505728.0, 507936.0, 88710.55644721736, 91430.0, 92219.53890230505, 93027.53486232525, 93882.53058734663, 1010.7877345757473, 1018.3126389686931, 1030.8144533983955, 1036.233187441288, 1039.1478987230398, 16337.83662163363, 16395.716003132817, 16649.833501664827, 16672.83327166713, 16921.576960576083, 33811.83094084514, 35239.82380088083, 36779.63220367762, 36832.26335473329, 37162.28377162262, 46280.768596156806, 47591.76204118957, 49010.50989490202, 50817.0, 51686.0, 8507.659693612433, 8518.23335899772, 8698.608562614823, 8750.562471876508, 8972.775680608038, 9454.19639330637, 11831.408429578314, 12929.513105992932, 13099.559048504467, 13261.270630115436, 11770.76458470843, 11780.82328765052, 11794.705132371759, 12077.57728479499, 12152.0, 11382.715432114263, 11696.590619328623, 11746.941265293619, 11822.231554948901, 11912.047036237254, 6664.83337916556, 11202.38386888729, 11694.415279236175, 11771.23486973344, 12017.399130043637, 8351.24838764514, 8659.622747128498, 8829.11708829112, 8907.910920890708, 9050.954745226232, 11303.830442543203, 12132.939335303266, 12250.938745306574, 12261.938690306491, 12426.689332766753], "value": 8850.333293149055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.210718319291, 1530.8163020437546, 1668.9833101668987, 1792.9551761205976, 1836.7336736173256, 7724.0, 8214.671413143475, 8269.37979651527, 8480.575971201439, 8512.063672995973, 8281.461704989171, 8289.792755181123, 8298.751037468886, 8310.293625041879, 8352.958235208831, 2307.884605769709, 2336.5210131923, 2337.181986304788, 2342.8242881783935, 2348.5420343033115, 2278.601244782165, 2289.599320118981, 2310.06442390832, 2310.353101131686, 2314.6759453676414, 2298.5747636687183, 2300.620397634388, 2322.2684854270933, 2350.588646986779, 2359.327591636384, 2265.5015896502828, 2271.931842044741, 2273.30664147435, 2274.942151899375, 2294.4608017115966, 2257.2776711452343, 2257.34536984276, 2261.3894248552965, 2269.296518079384, 2273.158931195468, 8502.0, 8532.0, 8551.273141782956, 8580.82838343236, 8594.312455003585, 5081.237814327844, 5198.610104242197, 5226.947730522684, 5235.738213089368, 5255.343082114736, 3297.258116923697, 3346.9330613387597, 3442.397580423441, 3455.87904423344, 3485.1635607454027, 1126.6901602059418, 1130.1128614038023, 1131.835883796853, 1162.6744511536783, 1169.5321871251483, 11616.0, 11649.941750291278, 11651.475683594173, 11656.242344247597, 11685.357305348287, 4431.0, 4587.977060114678, 4761.595264402565, 4762.309465127606, 4769.236922092448, 9262.073792620818, 9322.114399132071, 9343.018983006823, 9356.157945784911, 9371.953140234255, 5119.129747942859, 5128.640995130305, 5135.871603209875, 5136.43499215086, 5171.5345618893725, 4297.05464797744, 4744.952550474451, 4804.903901921942, 4812.0, 4845.53967373099, 3647.361711700442, 3745.8127093645207, 3818.7899665518107, 3829.3872980323013, 3851.557070936878, 1150.2753265442718, 1162.9709257268637, 1175.3535555444641, 1175.9000484958704, 1178.3165763856941, 962.5091203486132, 976.1312431935582, 982.3467394182788, 992.6873034994098, 1013.4881884648205, 5636.718164091779, 5703.74333155009, 5819.941800582024, 5987.1318658794235, 6008.669523176267, 429.3173853572834, 435.24919513839006, 442.06723812755064, 442.92369542012574, 448.7195502810743, 4014.538328092307, 4046.5548789633117, 4071.796410179479, 4081.10215752534, 4100.507939047274, 10294.536745846455, 10667.986541278566, 10697.41164235959, 10733.731656708645, 10761.085307748772, 10367.896321036844, 10483.161347092215, 10599.947000265103, 10619.84070238947, 10621.84067238992, 7701.422393320411, 7873.606319683993, 8009.0, 8081.434299599089, 8091.676332946617, 5765.3946335634155, 5996.2504686914135, 6007.639541627516, 6105.603135796159, 6206.06908963641, 9678.75803104928, 9736.464494452874, 9750.853737193806, 9839.360441571562, 9847.803043938939, 9757.756056098655, 9758.658446954323, 9972.152367048882, 10019.749506262402, 10070.597176112873, 7991.680332786624, 8187.426880118573, 8254.711085111992, 8257.876131857907, 8276.751697449086, 8213.630386632496, 8235.547044912348, 8304.169583041648, 8320.167983201873, 8321.209485098905, 7432.739854105297, 7473.551586904803, 7519.473636845369, 7524.134724506752, 7609.809754756176, 7147.1780745214965, 7324.157721862054, 7331.083614548182, 7414.036175297177, 7459.216782237787, 6882.242953275236, 6910.896336554855, 6932.544165725254, 6940.1671799382375, 6955.513114081966, 4997.800087996585, 5106.106431374569, 5149.948500514947, 5202.0, 5214.530692237565, 4980.676256043345, 5007.499250075109, 5025.271335656383, 5037.899242015213, 5205.141151709925], "value": 4464.553653062484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.26752939650487, 335.0818756606897, 339.9376947040497, 344.56928838951313, 345.0511094490153, 5888.057910734284, 5963.612365196264, 5978.02461363194, 6118.898598252313, 6122.602030867991, 6019.7893073742425, 6044.969775151129, 6045.425684559971, 6057.242844644419, 6061.0, 4567.611753000999, 4574.885627859297, 4601.792919318638, 4601.93097103542, 4614.838480653178, 4347.956520434786, 4539.273716205408, 4561.657875659323, 4562.498125206224, 4589.747563883985, 4469.508354081048, 4501.662375321847, 4521.841735539257, 4524.696971211018, 4525.502194758574, 4478.798454069559, 4519.751413672247, 4538.977305113486, 4560.156371071329, 4563.794629241692, 3618.3306088373733, 3852.8266228019806, 3870.0, 3925.666318362914, 3951.6443520083044, 5739.684317362543, 5743.16724075011, 5757.992351338499, 5765.827025189251, 5775.306963164405, 5164.767585458663, 5176.482351764831, 5187.48125187482, 5203.713795741232, 5205.479452054802, 6002.159697642333, 6276.717547710318, 6298.4646305064125, 6341.112244285804, 6352.396522330371, 4286.614204721559, 4325.13497300538, 4342.370356298351, 4344.522102568715, 4347.239233134221, 6288.559800813945, 6521.510886683518, 6579.835504112435, 6596.868062638769, 6598.076269322299, 4388.210122178039, 4428.402165707588, 4442.73343599385, 4443.200223959654, 4466.3523789050405, 4532.4334458192725, 4533.957189846288, 4535.843359943194, 4538.115067561794, 4542.863714088583, 5126.282320475137, 5243.9213411798855, 5254.264402983586, 5262.342207224097, 5288.101022826128, 6125.387461253928, 6354.3963323484195, 6374.713137908805, 6415.422611964946, 6438.259600146043, 1506.691128318714, 1527.1219049046842, 1535.3704980957755, 1543.4597890738376, 1544.9073055616475, 1009.4750729620556, 1019.5666841592293, 1029.6447725534679, 1032.8605638238741, 1038.8649475568127, 5977.372375900555, 6021.909671354933, 6091.659834836329, 6150.0, 6154.78458253959, 6521.47828173745, 6535.346465353522, 6550.7707230246715, 6555.4427873631275, 6579.47364210862, 5991.400859913973, 6003.939960600338, 6072.635641861414, 6079.635221886701, 6103.908441373383, 3454.1191996040848, 3504.421770407905, 3509.2279698466295, 3535.292941411728, 3541.6281290464644, 6624.569402988886, 6784.728610855609, 6798.558093723892, 6815.829604259933, 6844.486663500257, 6567.1462709848365, 6613.5370524062855, 6667.699953502104, 6675.499337549703, 6705.731770729116, 6466.191726034246, 6669.7665581704405, 6673.399394054559, 6702.39678428934, 6791.45668346541, 6478.6760661967655, 6491.415772580491, 6492.220933488012, 6520.445762110084, 6531.771388001397, 6320.5259605528845, 6435.967820160869, 6446.67766611677, 6454.451371633464, 6488.513361497812, 6721.092652491851, 6753.459723222229, 6763.086983257394, 6816.7614133505085, 6826.556273842184, 4441.667499749998, 4470.418845550058, 4472.843450479218, 4488.102379524043, 4499.595036446604, 6229.595076320024, 6362.586431881913, 6440.8389790255615, 6556.541042127005, 6671.733130674913, 6356.841078972878, 6413.743450261937, 6445.806625801233, 6471.191101112361, 6508.949680850517, 6238.656873871981, 6384.872302554016, 6420.518461115342, 6427.935720642734, 6446.871062578816, 6279.183706118175, 6290.433860952537, 6315.3053164152825, 6327.746890124527, 6336.112944187726, 6387.616742995435, 6458.515611329263, 6490.253620833664, 6519.934800651933, 6533.901991470037, 6117.868194384053, 6148.3236843948025, 6288.402601752826, 6312.210973628296, 6320.778772742932], "value": 4756.690153836995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.0440467034888, 796.2276591706043, 822.3626689315779, 841.1840514700739, 886.3131073418105, 14230.71538569228, 14264.500742474029, 14281.357338919748, 14314.785278220808, 14519.927400362996, 13019.934900325508, 13057.216567005986, 13117.409716562754, 13119.0, 13195.406206720696, 685.4413652872918, 792.2552800367665, 813.5688085314763, 819.2462934100612, 823.3207603726919, 825.2201669422399, 825.8141918068446, 827.2224109337234, 830.0205757206494, 832.9625166867476, 865.2429124516049, 868.7741187291318, 870.1602953150241, 871.5424402188838, 871.7428358634187, 861.4013260783727, 863.5423225690331, 863.7408777366765, 864.4078806017866, 867.2628265973872, 627.5732501898707, 631.251966419794, 633.4045996763074, 634.1724050114599, 635.3106879036205, 14718.779218311734, 14748.262586870613, 14824.03643763152, 14862.777058344134, 14902.925485372503, 14065.226412547307, 14093.436262549485, 14266.714665706628, 14427.567172984827, 14460.132392056405, 11658.533658653643, 11817.35004574748, 11848.644540663794, 11858.11064170182, 11919.284842909366, 3780.867669631577, 3801.7528860624247, 3828.89053836613, 3840.539135303781, 3900.8829735107993, 51973.48026519724, 52706.20940685893, 52743.73628131835, 52819.20771188435, 52919.20621190685, 11066.612668556723, 11219.382933938548, 11394.316341019565, 11437.71405714847, 11445.08439324852, 20263.0, 20502.282420115225, 20597.691034634492, 20618.27836025762, 20718.689219661715, 8324.750257492286, 8378.874316885129, 8480.321574274043, 8511.57442127891, 8630.611622477003, 4790.520947905182, 4813.542713442217, 4896.853094407174, 4916.754162291871, 4918.360613120343, 3312.585926759155, 3429.53701250333, 3442.535257740173, 3448.5689288838894, 3450.447928331455, 630.8359826445065, 649.5355820588302, 652.6932341799346, 669.7019826177304, 670.4066900792736, 766.7929658992152, 767.1331395523023, 778.3034184404926, 783.8275579372529, 785.2090830127808, 9237.907620923705, 9613.855792163124, 9876.654317098866, 9964.701058968243, 10082.0, 581.8429024163452, 678.9984772460581, 732.6629750314914, 763.8090477380655, 773.9226077392216, 4550.840720574764, 4588.357629931812, 4678.485366609671, 4684.1568517666465, 4699.295105734167, 51623.0, 64671.67664161743, 65216.347836521025, 65462.0, 65568.67215663986, 51042.0, 51347.22979155316, 51559.226611600854, 52198.21702674463, 52568.737156313975, 36968.63031369706, 37226.255474890895, 44112.77943610262, 44654.0, 46427.767861161155, 9004.639814407612, 9486.762830929281, 9572.521373931137, 9591.18474929611, 9594.808103838024, 31621.841890790398, 32031.6796832038, 32617.18457038593, 32812.0, 32952.34095318128, 42517.787411062745, 42913.35629965491, 42917.0, 43130.78434607807, 43435.0, 11812.70468238301, 11959.641210763692, 12265.509379624715, 12321.93839030799, 12460.688482788002, 13397.33013349348, 13758.174509529461, 14349.641258968191, 14372.425102995763, 14418.495352662607, 12737.745245095231, 13052.21686698801, 13600.183988960694, 13841.37713802861, 14133.15201087938, 12621.93689031549, 13230.669233269246, 13262.933685331898, 13310.933445332712, 13328.33358332099, 12240.632781016584, 12406.193597416139, 12537.122401431812, 12747.107702460738, 12801.167924084904, 10262.127719143957, 10276.845847312446, 10478.109360704426, 10587.258891877495, 10866.891331086588, 10347.534360953925, 10537.42044187577, 10596.89403105959, 10638.308509946828, 10640.148788097089], "value": 6807.882083478423, "unit": "score"}], "name": "dromaeo_css", "value": 7160.961040037839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 111.0, 113.0, 126.0, 111.0, 111.0, 111.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 129.0, 157.0, 182.0, 137.0, 163.0, 165.0, 131.0, 184.0, 131.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 164.0, 164.0, 173.0, 164.0, 166.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 78.0, 149.0, 74.0, 73.0, 76.0, 75.0, 174.0, 72.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 144.0, 92.0, 94.0, 93.0, 150.0, 93.0, 93.0, 146.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 96.0, 100.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 58.0, 57.0, 58.0, 62.0, 72.0, 57.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 137.0, 128.0, 127.0, 125.0, 131.0, 136.0, 130.0, 159.0, 134.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 170.0, 167.0, 167.0, 176.0, 173.0, 165.0, 168.0, 174.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 67.0, 70.0, 68.0, 71.0, 71.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1565.6, "alertThreshold": 2.0}]} 08:28:11 INFO - Return code: 0 08:28:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:28:11 ERROR - # TBPL SUCCESS # 08:28:11 INFO - Running post-action listener: _resource_record_post_action 08:28:11 INFO - Running post-run listener: _resource_record_post_run 08:28:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536076288; Read time: 12; Write time: 413868 08:28:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244195328; Read time: 0; Write time: 251608 08:28:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291880960; Read time: 12; Write time: 162260 08:28:12 INFO - Running post-run listener: _upload_blobber_files 08:28:12 INFO - Blob upload gear active. 08:28:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:12 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 08:28:12 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:12 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:13 INFO - (blobuploader) - INFO - Done attempting. 08:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:14 INFO - (blobuploader) - INFO - Done attempting. 08:28:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:14 INFO - Return code: 0 08:28:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5584cbe4d174d64987dff72353e8eb68331b38cd1b953b41cf42c25f528ac6a5849c0ed402c8347ac18f84729cb3778c417fec26ca21bea3a11870c6ea250342", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7f752cb03125cc9e4a26841e203ab6b846ae12c405911e1641fae8911392714099b126b3984c36a7037f28ba44f5d46908732be9b08e2d194613c58e3df147f"} 08:28:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:14 INFO - Contents: 08:28:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5584cbe4d174d64987dff72353e8eb68331b38cd1b953b41cf42c25f528ac6a5849c0ed402c8347ac18f84729cb3778c417fec26ca21bea3a11870c6ea250342", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7f752cb03125cc9e4a26841e203ab6b846ae12c405911e1641fae8911392714099b126b3984c36a7037f28ba44f5d46908732be9b08e2d194613c58e3df147f"} 08:28:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:14 INFO - Copying logs to upload dir... 08:28:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.823866 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-18 08:28:14.087161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 08:28:14.090600) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649 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/Firefox/sha512/5584cbe4d174d64987dff72353e8eb68331b38cd1b953b41cf42c25f528ac6a5849c0ed402c8347ac18f84729cb3778c417fec26ca21bea3a11870c6ea250342", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7f752cb03125cc9e4a26841e203ab6b846ae12c405911e1641fae8911392714099b126b3984c36a7037f28ba44f5d46908732be9b08e2d194613c58e3df147f"} build_url:https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/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/Firefox/sha512/5584cbe4d174d64987dff72353e8eb68331b38cd1b953b41cf42c25f528ac6a5849c0ed402c8347ac18f84729cb3778c417fec26ca21bea3a11870c6ea250342", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7f752cb03125cc9e4a26841e203ab6b846ae12c405911e1641fae8911392714099b126b3984c36a7037f28ba44f5d46908732be9b08e2d194613c58e3df147f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 08:28:14.115984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:28:14.116388) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460991639.519929-25886649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:28:14.202000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 08:28:14.202359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 08:28:14.202709) ========= ========= Total master_lag: 0.18 =========