builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1464792682.95 results: success (0) buildid: 20160601050353 builduid: 1b865cf5cc7d41a7a85f37d3a9881a42 revision: bf4d710c80531aa2c170f076716513e69206b05d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:22.947278) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:22.947846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:22.948159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:22.975324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:22.975707) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:51:23-- 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% 70.7M=0s 2016-06-01 07:51:23 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119539 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.131651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.132012) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018944 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.181573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.181953) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf4d710c80531aa2c170f076716513e69206b05d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf4d710c80531aa2c170f076716513e69206b05d --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=9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:51:23,401 truncating revision to first 12 chars 2016-06-01 07:51:23,401 Setting DEBUG logging. 2016-06-01 07:51:23,401 attempt 1/10 2016-06-01 07:51:23,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf4d710c8053?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:51:23,701 unpacking tar archive at: mozilla-aurora-bf4d710c8053/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.823934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.824273) ========= script_repo_revision: bf4d710c80531aa2c170f076716513e69206b05d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.824688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.824968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:51:23.834018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-01 07:51:23.834389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:24 INFO - MultiFileLogger online at 20160601 07:51:24 in /builds/slave/test 07:51:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:51:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:24 INFO - {'append_to_log': False, 07:51:24 INFO - 'base_work_dir': '/builds/slave/test', 07:51:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:51:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:24 INFO - 'branch': 'Mozilla-Aurora', 07:51:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:24 INFO - 'config_files': ('talos/linux_config.py',), 07:51:24 INFO - 'default_actions': ('clobber', 07:51:24 INFO - 'read-buildbot-config', 07:51:24 INFO - 'download-and-extract', 07:51:24 INFO - 'populate-webroot', 07:51:24 INFO - 'create-virtualenv', 07:51:24 INFO - 'install', 07:51:24 INFO - 'run-tests'), 07:51:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:24 INFO - 'download_minidump_stackwalk': True, 07:51:24 INFO - 'download_symbols': 'ondemand', 07:51:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:24 INFO - 'installer_path': 'installer.exe', 07:51:24 INFO - 'log_level': 'info', 07:51:24 INFO - 'log_name': 'talos', 07:51:24 INFO - 'log_to_console': True, 07:51:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:24 INFO - 'opt_config_files': (), 07:51:24 INFO - 'pip_index': False, 07:51:24 INFO - 'sps_profile': False, 07:51:24 INFO - 'sps_profile_interval': 0, 07:51:24 INFO - 'suite': 'dromaeojs-e10s', 07:51:24 INFO - 'system_bits': '32', 07:51:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:24 INFO - 'title': 'talos-linux64-ix-022', 07:51:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:24 INFO - 'use_talos_json': True, 07:51:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:24 INFO - 'work_dir': 'build'} 07:51:24 INFO - ##### 07:51:24 INFO - ##### Running clobber step. 07:51:24 INFO - ##### 07:51:24 INFO - Running pre-action listener: _resource_record_pre_action 07:51:24 INFO - Running main action method: clobber 07:51:24 INFO - rmtree: /builds/slave/test/build 07:51:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:24 INFO - Running post-action listener: _resource_record_post_action 07:51:24 INFO - ##### 07:51:24 INFO - ##### Running read-buildbot-config step. 07:51:24 INFO - ##### 07:51:24 INFO - Running pre-action listener: _resource_record_pre_action 07:51:24 INFO - Running main action method: read_buildbot_config 07:51:24 INFO - Using buildbot properties: 07:51:24 INFO - { 07:51:24 INFO - "project": "", 07:51:24 INFO - "product": "firefox", 07:51:24 INFO - "script_repo_revision": "production", 07:51:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:51:24 INFO - "repository": "", 07:51:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:51:24 INFO - "buildid": "20160601050353", 07:51:24 INFO - "pgo_build": "True", 07:51:24 INFO - "basedir": "/builds/slave/test", 07:51:24 INFO - "buildnumber": 324, 07:51:24 INFO - "slavename": "talos-linux64-ix-022", 07:51:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:51:24 INFO - "platform": "ubuntu64_hw", 07:51:24 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:51:24 INFO - "branch": "mozilla-aurora", 07:51:24 INFO - "repo_path": "releases/mozilla-aurora", 07:51:24 INFO - "revision": "bf4d710c80531aa2c170f076716513e69206b05d", 07:51:24 INFO - "stage_platform": "linux64-pgo", 07:51:24 INFO - "builduid": "1b865cf5cc7d41a7a85f37d3a9881a42", 07:51:24 INFO - "slavebuilddir": "test" 07:51:24 INFO - } 07:51:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:51:24 INFO - Running post-action listener: _resource_record_post_action 07:51:24 INFO - ##### 07:51:24 INFO - ##### Running download-and-extract step. 07:51:24 INFO - ##### 07:51:24 INFO - Running pre-action listener: _resource_record_pre_action 07:51:24 INFO - Running main action method: download_and_extract 07:51:24 INFO - mkdir: /builds/slave/test/build/tests 07:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:24 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:51:25 INFO - Downloaded 1361 bytes. 07:51:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:25 INFO - Using the following test package requirements: 07:51:25 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:51:25 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:25 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:51:25 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'jsshell-linux-x86_64.zip'], 07:51:25 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:25 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:51:25 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:51:25 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:51:25 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:25 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:25 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:25 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:26 INFO - Downloaded 24173199 bytes. 07:51:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:51:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:51:28 INFO - Return code: 0 07:51:28 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:28 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:29 INFO - Downloaded 24173199 bytes. 07:51:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:51:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:51:30 INFO - Return code: 0 07:51:30 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')]} 07:51:30 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:51:31 INFO - Downloaded 10840145 bytes. 07:51:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:51:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:51:31 INFO - Return code: 0 07:51:31 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')]} 07:51:31 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:51:36 INFO - Downloaded 62797569 bytes. 07:51:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:36 INFO - mkdir: /builds/slave/test/properties 07:51:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:51:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:51:36 INFO - Contents: 07:51:36 INFO - build_url:https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:37 INFO - Running post-action listener: _resource_record_post_action 07:51:37 INFO - Running post-action listener: set_extra_try_arguments 07:51:37 INFO - ##### 07:51:37 INFO - ##### Running populate-webroot step. 07:51:37 INFO - ##### 07:51:37 INFO - Running pre-action listener: _resource_record_pre_action 07:51:37 INFO - Running main action method: populate_webroot 07:51:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:51:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:51:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:51:37 INFO - '--tppagecycles', 07:51:37 INFO - '7'], 07:51:37 INFO - 'tests': ['tsvgm']}}, 07:51:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:51:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:51:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:51:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:51:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['damp', 'tps']}, 07:51:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'tests': ['damp', 'tps']}, 07:51:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['dromaeo_dom']}, 07:51:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:51:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['a11yr', 07:51:37 INFO - 'ts_paint', 07:51:37 INFO - 'tpaint', 07:51:37 INFO - 'sessionrestore', 07:51:37 INFO - 'sessionrestore_no_auto_restore', 07:51:37 INFO - 'tabpaint']}, 07:51:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:51:37 INFO - 'ts_paint', 07:51:37 INFO - 'tpaint', 07:51:37 INFO - 'sessionrestore', 07:51:37 INFO - 'sessionrestore_no_auto_restore', 07:51:37 INFO - 'tabpaint']}, 07:51:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:51:37 INFO - 'ts_paint', 07:51:37 INFO - 'tpaint', 07:51:37 INFO - 'sessionrestore', 07:51:37 INFO - 'sessionrestore_no_auto_restore', 07:51:37 INFO - 'tabpaint']}, 07:51:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:51:37 INFO - 'ts_paint', 07:51:37 INFO - 'tpaint', 07:51:37 INFO - 'sessionrestore', 07:51:37 INFO - 'sessionrestore_no_auto_restore', 07:51:37 INFO - 'tabpaint']}, 07:51:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['a11yr', 07:51:37 INFO - 'ts_paint', 07:51:37 INFO - 'tpaint', 07:51:37 INFO - 'sessionrestore', 07:51:37 INFO - 'sessionrestore_no_auto_restore', 07:51:37 INFO - 'tabpaint']}, 07:51:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['a11yr', 07:51:37 INFO - 'ts_paint', 07:51:37 INFO - 'tpaint', 07:51:37 INFO - 'sessionrestore', 07:51:37 INFO - 'sessionrestore_no_auto_restore', 07:51:37 INFO - 'tabpaint']}, 07:51:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['tsvgx', 07:51:37 INFO - 'tsvgr_opacity', 07:51:37 INFO - 'tart', 07:51:37 INFO - 'tscrollx', 07:51:37 INFO - 'cart']}, 07:51:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:51:37 INFO - 'tsvgr_opacity', 07:51:37 INFO - 'tart', 07:51:37 INFO - 'tscrollx', 07:51:37 INFO - 'cart']}, 07:51:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'talos_options': ['--disable-e10s'], 07:51:37 INFO - 'tests': ['tp5o']}, 07:51:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'tests': ['tp5o']}, 07:51:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'talos_options': ['--disable-e10s', 07:51:37 INFO - '--xperf_path', 07:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:37 INFO - 'tests': ['tp5n']}, 07:51:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:37 INFO - 'talos_options': ['--xperf_path', 07:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:37 INFO - 'tests': ['tp5n']}}, 07:51:37 INFO - 'talos.zip': {'path': '', 07:51:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:51:37 INFO - Running post-action listener: _resource_record_post_action 07:51:37 INFO - ##### 07:51:37 INFO - ##### Running create-virtualenv step. 07:51:37 INFO - ##### 07:51:37 INFO - Running pre-action listener: _resource_record_pre_action 07:51:37 INFO - Running main action method: create_virtualenv 07:51:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:51:37 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 07:51:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:51:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:51:38 INFO - Using real prefix '/usr' 07:51:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:51:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:51:41 INFO - Installing pip.................done. 07:51:41 INFO - Return code: 0 07:51:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:41 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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:41 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 07:51:41 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 07:51:41 INFO - Using env: {'DISPLAY': ':0', 07:51:41 INFO - 'HOME': '/home/cltbld', 07:51:41 INFO - 'LANG': 'en_US.UTF-8', 07:51:41 INFO - 'LANGUAGE': 'en_US:en', 07:51:41 INFO - 'LOGNAME': 'cltbld', 07:51:41 INFO - 'MAIL': '/var/mail/cltbld', 07:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:41 INFO - 'MOZ_NO_REMOTE': '1', 07:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:41 INFO - 'NO_EM_RESTART': '1', 07:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:41 INFO - 'PWD': '/builds/slave/test', 07:51:41 INFO - 'SHELL': '/bin/bash', 07:51:41 INFO - 'SHLVL': '1', 07:51:41 INFO - 'TERM': 'linux', 07:51:41 INFO - 'TMOUT': '86400', 07:51:41 INFO - 'USER': 'cltbld', 07:51:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:41 INFO - '_': '/tools/buildbot/bin/python'} 07:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:41 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 07:51:41 INFO - Cleaning up... 07:51:41 INFO - Return code: 0 07:51:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:41 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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:41 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 07:51:41 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 07:51:41 INFO - Using env: {'DISPLAY': ':0', 07:51:41 INFO - 'HOME': '/home/cltbld', 07:51:41 INFO - 'LANG': 'en_US.UTF-8', 07:51:41 INFO - 'LANGUAGE': 'en_US:en', 07:51:41 INFO - 'LOGNAME': 'cltbld', 07:51:41 INFO - 'MAIL': '/var/mail/cltbld', 07:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:41 INFO - 'MOZ_NO_REMOTE': '1', 07:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:41 INFO - 'NO_EM_RESTART': '1', 07:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:41 INFO - 'PWD': '/builds/slave/test', 07:51:41 INFO - 'SHELL': '/bin/bash', 07:51:41 INFO - 'SHLVL': '1', 07:51:41 INFO - 'TERM': 'linux', 07:51:41 INFO - 'TMOUT': '86400', 07:51:41 INFO - 'USER': 'cltbld', 07:51:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:41 INFO - '_': '/tools/buildbot/bin/python'} 07:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:42 INFO - Downloading/unpacking psutil>=0.7.1 07:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:44 INFO - Installing collected packages: psutil 07:51:44 INFO - Running setup.py install for psutil 07:51:44 INFO - building 'psutil._psutil_linux' extension 07:51:44 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 07:51:45 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 07:51:46 INFO - building 'psutil._psutil_posix' extension 07:51:46 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 07:51:46 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 07:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:46 INFO - Successfully installed psutil 07:51:46 INFO - Cleaning up... 07:51:46 INFO - Return code: 0 07:51:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:51: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')]} 07:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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')]} 07:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:46 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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:46 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 07:51:46 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 07:51:46 INFO - Using env: {'DISPLAY': ':0', 07:51:46 INFO - 'HOME': '/home/cltbld', 07:51:46 INFO - 'LANG': 'en_US.UTF-8', 07:51:46 INFO - 'LANGUAGE': 'en_US:en', 07:51:46 INFO - 'LOGNAME': 'cltbld', 07:51:46 INFO - 'MAIL': '/var/mail/cltbld', 07:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:46 INFO - 'MOZ_NO_REMOTE': '1', 07:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:46 INFO - 'NO_EM_RESTART': '1', 07:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:46 INFO - 'PWD': '/builds/slave/test', 07:51:46 INFO - 'SHELL': '/bin/bash', 07:51:46 INFO - 'SHLVL': '1', 07:51:46 INFO - 'TERM': 'linux', 07:51:46 INFO - 'TMOUT': '86400', 07:51:46 INFO - 'USER': 'cltbld', 07:51:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:46 INFO - '_': '/tools/buildbot/bin/python'} 07:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:51:46 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 07:51:46 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 07:51:46 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 07:51:46 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 07:51:46 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 07:51:46 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 07:51:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:51:48 INFO - Installing collected packages: mozsystemmonitor 07:51:48 INFO - Running setup.py install for mozsystemmonitor 07:51:48 INFO - Successfully installed mozsystemmonitor 07:51:48 INFO - Cleaning up... 07:51:48 INFO - Return code: 0 07:51:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:51:48 INFO - Using env: {'DISPLAY': ':0', 07:51:48 INFO - 'HOME': '/home/cltbld', 07:51:48 INFO - 'LANG': 'en_US.UTF-8', 07:51:48 INFO - 'LANGUAGE': 'en_US:en', 07:51:48 INFO - 'LOGNAME': 'cltbld', 07:51:48 INFO - 'MAIL': '/var/mail/cltbld', 07:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:48 INFO - 'MOZ_NO_REMOTE': '1', 07:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:48 INFO - 'NO_EM_RESTART': '1', 07:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:48 INFO - 'PWD': '/builds/slave/test', 07:51:48 INFO - 'SHELL': '/bin/bash', 07:51:48 INFO - 'SHLVL': '1', 07:51:48 INFO - 'TERM': 'linux', 07:51:48 INFO - 'TMOUT': '86400', 07:51:48 INFO - 'USER': 'cltbld', 07:51:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:48 INFO - '_': '/tools/buildbot/bin/python'} 07:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:51:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:51:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:51 INFO - Downloading docopt-0.6.1.tar.gz 07:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:51:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:51:51 INFO - Running setup.py install for blobuploader 07:51:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:51:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:51:51 INFO - Running setup.py install for requests 07:51:51 INFO - Running setup.py install for docopt 07:51:52 INFO - Successfully installed blobuploader requests docopt 07:51:52 INFO - Cleaning up... 07:51:52 INFO - Return code: 0 07:51:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:52 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')]} 07:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:52 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')]} 07:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:52 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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:52 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 07:51:52 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 07:51:52 INFO - Using env: {'DISPLAY': ':0', 07:51:52 INFO - 'HOME': '/home/cltbld', 07:51:52 INFO - 'LANG': 'en_US.UTF-8', 07:51:52 INFO - 'LANGUAGE': 'en_US:en', 07:51:52 INFO - 'LOGNAME': 'cltbld', 07:51:52 INFO - 'MAIL': '/var/mail/cltbld', 07:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:52 INFO - 'MOZ_NO_REMOTE': '1', 07:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:52 INFO - 'NO_EM_RESTART': '1', 07:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:52 INFO - 'PWD': '/builds/slave/test', 07:51:52 INFO - 'SHELL': '/bin/bash', 07:51:52 INFO - 'SHLVL': '1', 07:51:52 INFO - 'TERM': 'linux', 07:51:52 INFO - 'TMOUT': '86400', 07:51:52 INFO - 'USER': 'cltbld', 07:51:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:52 INFO - '_': '/tools/buildbot/bin/python'} 07:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:52 INFO - Running setup.py (path:/tmp/pip-HVH8Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:52 INFO - Running setup.py (path:/tmp/pip-aVHkM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:52 INFO - Running setup.py (path:/tmp/pip-fS1G6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:52 INFO - Running setup.py (path:/tmp/pip-nS7ggG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:52 INFO - Running setup.py (path:/tmp/pip-vgk0FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:52 INFO - Running setup.py (path:/tmp/pip-bz7doe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:52 INFO - Running setup.py (path:/tmp/pip-PNmB9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:52 INFO - Running setup.py (path:/tmp/pip-nJWl2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:52 INFO - Running setup.py (path:/tmp/pip-yD3WKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:52 INFO - Running setup.py (path:/tmp/pip-DB4R8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:53 INFO - Running setup.py (path:/tmp/pip-BHvbJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:53 INFO - Running setup.py (path:/tmp/pip-5Lj529-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:53 INFO - Running setup.py (path:/tmp/pip-rHPLXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:53 INFO - Running setup.py (path:/tmp/pip-OYt9QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:53 INFO - Running setup.py (path:/tmp/pip-29qgkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:53 INFO - Running setup.py (path:/tmp/pip-XuaqCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:53 INFO - Running setup.py (path:/tmp/pip-V2RPaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:51:53 INFO - Running setup.py install for manifestparser 07:51:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:51:53 INFO - Running setup.py install for mozcrash 07:51:53 INFO - Running setup.py install for mozdebug 07:51:53 INFO - Running setup.py install for mozdevice 07:51:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:51:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:51:53 INFO - Running setup.py install for mozfile 07:51:54 INFO - Running setup.py install for mozhttpd 07:51:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Running setup.py install for mozinfo 07:51:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Running setup.py install for mozInstall 07:51:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Running setup.py install for mozleak 07:51:54 INFO - Running setup.py install for mozlog 07:51:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Running setup.py install for moznetwork 07:51:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Running setup.py install for mozprocess 07:51:54 INFO - Running setup.py install for mozprofile 07:51:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:51:54 INFO - Running setup.py install for mozrunner 07:51:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:51:55 INFO - Running setup.py install for mozscreenshot 07:51:55 INFO - Running setup.py install for moztest 07:51:55 INFO - Running setup.py install for mozversion 07:51:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:51:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:51:55 INFO - Cleaning up... 07:51:55 INFO - Return code: 0 07:51:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:55 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')]} 07:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:55 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')]} 07:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:55 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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:55 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 07:51:55 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 07:51:55 INFO - Using env: {'DISPLAY': ':0', 07:51:55 INFO - 'HOME': '/home/cltbld', 07:51:55 INFO - 'LANG': 'en_US.UTF-8', 07:51:55 INFO - 'LANGUAGE': 'en_US:en', 07:51:55 INFO - 'LOGNAME': 'cltbld', 07:51:55 INFO - 'MAIL': '/var/mail/cltbld', 07:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:55 INFO - 'MOZ_NO_REMOTE': '1', 07:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:55 INFO - 'NO_EM_RESTART': '1', 07:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:55 INFO - 'PWD': '/builds/slave/test', 07:51:55 INFO - 'SHELL': '/bin/bash', 07:51:55 INFO - 'SHLVL': '1', 07:51:55 INFO - 'TERM': 'linux', 07:51:55 INFO - 'TMOUT': '86400', 07:51:55 INFO - 'USER': 'cltbld', 07:51:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:55 INFO - '_': '/tools/buildbot/bin/python'} 07:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:55 INFO - Running setup.py (path:/tmp/pip-7i4NkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:55 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)) 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:55 INFO - Running setup.py (path:/tmp/pip-BGcJ5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:55 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)) 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:55 INFO - Running setup.py (path:/tmp/pip-xRiDSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:55 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)) 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:55 INFO - Running setup.py (path:/tmp/pip-PnOsES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:55 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)) 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:55 INFO - Running setup.py (path:/tmp/pip-fe8gYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:55 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)) 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:55 INFO - Running setup.py (path:/tmp/pip-xpzwgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:55 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)) 07:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:55 INFO - Running setup.py (path:/tmp/pip-f6UUxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:56 INFO - Running setup.py (path:/tmp/pip-h603B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:56 INFO - Running setup.py (path:/tmp/pip-s1uZUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:56 INFO - Running setup.py (path:/tmp/pip-YfaDjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:56 INFO - Running setup.py (path:/tmp/pip-ohNOpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:56 INFO - Running setup.py (path:/tmp/pip-w53FaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:56 INFO - Running setup.py (path:/tmp/pip-3vARa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:56 INFO - Running setup.py (path:/tmp/pip-loa7zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:56 INFO - Running setup.py (path:/tmp/pip-pxg5Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:56 INFO - Running setup.py (path:/tmp/pip-eUrJRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:56 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)) 07:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:56 INFO - Running setup.py (path:/tmp/pip-IZF1Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:56 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)) 07:51:56 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)) 07:51:56 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)) 07:51:56 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)) 07:51:56 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)) 07:51:56 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)) 07:51:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:58 INFO - Downloading blessings-1.6.tar.gz 07:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:51:58 INFO - Installing collected packages: blessings 07:51:58 INFO - Running setup.py install for blessings 07:51:58 INFO - Successfully installed blessings 07:51:58 INFO - Cleaning up... 07:51:58 INFO - Return code: 0 07:51:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:51:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:59 INFO - Reading from file tmpfile_stdout 07:51:59 INFO - Current package versions: 07:51:59 INFO - argparse == 1.2.1 07:51:59 INFO - blessings == 1.6 07:51:59 INFO - blobuploader == 1.2.4 07:51:59 INFO - docopt == 0.6.1 07:51:59 INFO - manifestparser == 1.1 07:51:59 INFO - mozInstall == 1.12 07:51:59 INFO - mozcrash == 0.17 07:51:59 INFO - mozdebug == 0.1 07:51:59 INFO - mozdevice == 0.48 07:51:59 INFO - mozfile == 1.2 07:51:59 INFO - mozhttpd == 0.7 07:51:59 INFO - mozinfo == 0.9 07:51:59 INFO - mozleak == 0.1 07:51:59 INFO - mozlog == 3.1 07:51:59 INFO - moznetwork == 0.27 07:51:59 INFO - mozprocess == 0.22 07:51:59 INFO - mozprofile == 0.28 07:51:59 INFO - mozrunner == 6.11 07:51:59 INFO - mozscreenshot == 0.1 07:51:59 INFO - mozsystemmonitor == 0.0 07:51:59 INFO - moztest == 0.7 07:51:59 INFO - mozversion == 1.4 07:51:59 INFO - psutil == 3.1.1 07:51:59 INFO - requests == 1.2.3 07:51:59 INFO - wsgiref == 0.1.2 07:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51: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')]} 07:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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')]} 07:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:59 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 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51:59 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 07:51:59 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 07:51:59 INFO - Using env: {'DISPLAY': ':0', 07:51:59 INFO - 'HOME': '/home/cltbld', 07:51:59 INFO - 'LANG': 'en_US.UTF-8', 07:51:59 INFO - 'LANGUAGE': 'en_US:en', 07:51:59 INFO - 'LOGNAME': 'cltbld', 07:51:59 INFO - 'MAIL': '/var/mail/cltbld', 07:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:59 INFO - 'MOZ_NO_REMOTE': '1', 07:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:59 INFO - 'NO_EM_RESTART': '1', 07:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:59 INFO - 'PWD': '/builds/slave/test', 07:51:59 INFO - 'SHELL': '/bin/bash', 07:51:59 INFO - 'SHLVL': '1', 07:51:59 INFO - 'TERM': 'linux', 07:51:59 INFO - 'TMOUT': '86400', 07:51:59 INFO - 'USER': 'cltbld', 07:51:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:59 INFO - '_': '/tools/buildbot/bin/python'} 07:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 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)) 07:51:59 INFO - Cleaning up... 07:51:59 INFO - Return code: 0 07:51:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:51: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')]} 07:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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')]} 07:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:51: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', 'jsonschema'] in /builds/slave/test/build 07:51: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 jsonschema 07:51:59 INFO - Using env: {'DISPLAY': ':0', 07:51:59 INFO - 'HOME': '/home/cltbld', 07:51:59 INFO - 'LANG': 'en_US.UTF-8', 07:51:59 INFO - 'LANGUAGE': 'en_US:en', 07:51:59 INFO - 'LOGNAME': 'cltbld', 07:51:59 INFO - 'MAIL': '/var/mail/cltbld', 07:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:59 INFO - 'MOZ_NO_REMOTE': '1', 07:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:59 INFO - 'NO_EM_RESTART': '1', 07:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:59 INFO - 'PWD': '/builds/slave/test', 07:51:59 INFO - 'SHELL': '/bin/bash', 07:51:59 INFO - 'SHLVL': '1', 07:51:59 INFO - 'TERM': 'linux', 07:51:59 INFO - 'TMOUT': '86400', 07:51:59 INFO - 'USER': 'cltbld', 07:51:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:59 INFO - '_': '/tools/buildbot/bin/python'} 07:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:59 INFO - Downloading/unpacking jsonschema 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:52:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:01 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:01 INFO - warning: no files found matching '*.txt' 07:52:01 INFO - no previously-included directories found matching 'build' 07:52:01 INFO - no previously-included directories found matching 'dist' 07:52:01 INFO - no previously-included directories found matching '.git*' 07:52:01 INFO - Installing collected packages: jsonschema, functools32 07:52:01 INFO - Running setup.py install for functools32 07:52:01 INFO - warning: no files found matching '*.txt' 07:52:01 INFO - no previously-included directories found matching 'build' 07:52:01 INFO - no previously-included directories found matching 'dist' 07:52:01 INFO - no previously-included directories found matching '.git*' 07:52:01 INFO - Successfully installed jsonschema functools32 07:52:01 INFO - Cleaning up... 07:52:02 INFO - Return code: 0 07:52:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53bdebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', '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 07:52: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', 'flake8'] in /builds/slave/test/build 07:52: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 flake8 07:52:02 INFO - Using env: {'DISPLAY': ':0', 07:52:02 INFO - 'HOME': '/home/cltbld', 07:52:02 INFO - 'LANG': 'en_US.UTF-8', 07:52:02 INFO - 'LANGUAGE': 'en_US:en', 07:52:02 INFO - 'LOGNAME': 'cltbld', 07:52:02 INFO - 'MAIL': '/var/mail/cltbld', 07:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:02 INFO - 'MOZ_NO_REMOTE': '1', 07:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:02 INFO - 'NO_EM_RESTART': '1', 07:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:02 INFO - 'PWD': '/builds/slave/test', 07:52:02 INFO - 'SHELL': '/bin/bash', 07:52:02 INFO - 'SHLVL': '1', 07:52:02 INFO - 'TERM': 'linux', 07:52:02 INFO - 'TMOUT': '86400', 07:52:02 INFO - 'USER': 'cltbld', 07:52:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:02 INFO - '_': '/tools/buildbot/bin/python'} 07:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:02 INFO - Downloading/unpacking flake8 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:04 INFO - no previously-included directories found matching 'docs/_build' 07:52:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:04 INFO - Running setup.py install for pep8 07:52:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:04 INFO - no previously-included directories found matching 'docs/_build' 07:52:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:52:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:05 INFO - Cleaning up... 07:52:05 INFO - Return code: 0 07:52:05 INFO - Running post-action listener: _resource_record_post_action 07:52:05 INFO - Running post-action listener: _start_resource_monitoring 07:52:05 INFO - Starting resource monitoring. 07:52:05 INFO - ##### 07:52:05 INFO - ##### Running install step. 07:52:05 INFO - ##### 07:52:05 INFO - Running pre-action listener: _resource_record_pre_action 07:52:05 INFO - Running main action method: install 07:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:05 INFO - Reading from file tmpfile_stdout 07:52:05 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:05 INFO - Reading from file tmpfile_stdout 07:52:05 INFO - Output received: 07:52:05 INFO - Usage: mozinstall [options] installer 07:52:05 INFO - Options: 07:52:05 INFO - -h, --help show this help message and exit 07:52:05 INFO - -d DEST, --destination=DEST 07:52:05 INFO - Directory to install application into. [default: 07:52:05 INFO - "/builds/slave/test"] 07:52:05 INFO - --app=APP Application being installed. [default: firefox] 07:52:05 INFO - mkdir: /builds/slave/test/build/application 07:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:52:21 INFO - Reading from file tmpfile_stdout 07:52:21 INFO - Output received: 07:52:21 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:21 INFO - Running post-action listener: _resource_record_post_action 07:52:21 INFO - ##### 07:52:21 INFO - ##### Running run-tests step. 07:52:21 INFO - ##### 07:52:21 INFO - Running pre-action listener: _resource_record_pre_action 07:52:21 INFO - Running main action method: run_tests 07:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:21 INFO - Python 2.7.3 07:52:21 INFO - Return code: 0 07:52:21 INFO - grabbing minidump binary from tooltool 07:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:21 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 0x1652410>, '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 0x1653310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16537a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:21 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 07:52:21 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 07:52:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:21 INFO - Return code: 0 07:52:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:52:22 INFO - Return code: 0 07:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 07:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 07:52:22 INFO - Using env: {'DISPLAY': ':0', 07:52:22 INFO - 'HOME': '/home/cltbld', 07:52:22 INFO - 'LANG': 'en_US.UTF-8', 07:52:22 INFO - 'LANGUAGE': 'en_US:en', 07:52:22 INFO - 'LOGNAME': 'cltbld', 07:52:22 INFO - 'MAIL': '/var/mail/cltbld', 07:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:22 INFO - 'MOZ_NO_REMOTE': '1', 07:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:22 INFO - 'NO_EM_RESTART': '1', 07:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:22 INFO - 'PWD': '/builds/slave/test', 07:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:22 INFO - 'SHELL': '/bin/bash', 07:52:22 INFO - 'SHLVL': '1', 07:52:22 INFO - 'TERM': 'linux', 07:52:22 INFO - 'TMOUT': '86400', 07:52:22 INFO - 'USER': 'cltbld', 07:52:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465', 07:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:22 INFO - '_': '/tools/buildbot/bin/python'} 07:52:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 07:52:22 INFO - mozversion application_buildid: 20160601050353 07:52:22 INFO - mozversion application_changeset: bf4d710c80531aa2c170f076716513e69206b05d 07:52:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:52:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:22 INFO - mozversion application_name: Firefox 07:52:22 INFO - mozversion application_remotingname: firefox-dev 07:52:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:52:22 INFO - mozversion application_vendor: Mozilla 07:52:22 INFO - mozversion application_version: 48.0a2 07:52:22 INFO - mozversion platform_buildid: 20160601050353 07:52:22 INFO - mozversion platform_changeset: bf4d710c80531aa2c170f076716513e69206b05d 07:52:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:52:22 INFO - mozversion platform_version: 48.0a2 07:52:22 INFO - using testdate: 1464792742 07:52:22 INFO - actual date: 1464792742 07:52:22 INFO - starting webserver on 'localhost:51122' 07:52:22 INFO - SUITE-START | Running 2 tests 07:52:22 INFO - TEST-START | dromaeo_css 07:52:22 INFO - operating with platform_type : linux_ 07:52:22 INFO - Initialising browser for dromaeo_css test... 07:52:22 INFO - TEST-INFO | started process 3292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfD93PZ/profile http://localhost:51122/getInfo.html) 07:52:28 INFO - PROCESS | 3292 | 07:52:28 INFO - PROCESS | 3292 | (process:3369): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:52:29 INFO - PROCESS | 3292 | __metrics Screen width/height:1600/1200 07:52:29 INFO - PROCESS | 3292 | colorDepth:24 07:52:29 INFO - PROCESS | 3292 | Browser inner width/height: 1024/697 07:52:29 INFO - PROCESS | 3292 | __metrics 07:52:30 ERROR - PROCESS | 3292 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 07:52:31 INFO - TEST-INFO | 3292: exit 0 07:52:31 INFO - Browser initialized. 07:52:31 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:31 INFO - TEST-INFO | started process 3420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfD93PZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:33 INFO - PROCESS | 3420 | 07:52:33 INFO - PROCESS | 3420 | (process:3488): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:52:43 INFO - PROCESS | 3420 | RSS: Main: 152027136 07:52:43 INFO - PROCESS | 3420 | 07:53:32 INFO - PROCESS | 3420 | 1464792812909 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] 07:55:40 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51122/tests/dromaeo/cssquery-ext.html) 07:55:41 INFO - PROCESS | 3420 | RSS: Main: 156151808 07:55:41 INFO - PROCESS | 3420 | 07:58:43 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-ext.html (next: http://localhost:51122/tests/dromaeo/cssquery-jquery.html) 07:58:43 INFO - PROCESS | 3420 | RSS: Main: 153739264 07:58:43 INFO - PROCESS | 3420 | 08:01:45 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51122/tests/dromaeo/cssquery-mootools.html) 08:01:46 INFO - PROCESS | 3420 | RSS: Main: 153341952 08:01:46 INFO - PROCESS | 3420 | 08:04:47 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51122/tests/dromaeo/cssquery-prototype.html) 08:04:48 INFO - PROCESS | 3420 | RSS: Main: 153264128 08:04:48 INFO - PROCESS | 3420 | 08:07:50 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51122/tests/dromaeo/cssquery-yui.html) 08:07:51 INFO - PROCESS | 3420 | RSS: Main: 154603520 08:07:51 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-yui.html (next: http://localhost:51122/tests/dromaeo/cssquery-dojo.html) 08:10:53 INFO - PROCESS | 3420 | RSS: Main: 156209152 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | __start_tp_report 08:10:53 INFO - PROCESS | 3420 | _x_x_mozilla_page_load 08:10:53 INFO - PROCESS | 3420 | _x_x_mozilla_page_load_details 08:10:53 INFO - PROCESS | 3420 | |i|pagename|runs| 08:10:53 INFO - PROCESS | 3420 | |0;dojo.html;3332.6833950774676;3336.6496517865626;3359.2105855124055;3369;3414.9658503414958;5596.83209503715;5603.663780173188;5642.887142257153;5656.773729050833;5699;5595.4124816894255;5666.914996275049;5701.600887937846;5711.885762284762;5729.828105156842;5090.720010399426;5124.103281925667;5147.1764517677175;5163.535281824635;5185.144451165553;5030.396352437712;5092.9236061459105;5115.641905066628;5276.709780962045;5301.575873930076;5067.771950262247;5109.591232701375;5124.692518448886;5128.358955130609;5191.974040129794;5130.743462826844;5178.40448348441;5184.040952423795;5190.532852043297;5226.55574276187;4866.805327786884;5014.423341315759;5064.417591976933;5097.46476619957;5149.922751158736;5524.4199359067525;5550.888982220374;5565.749541270612;5568.888622227573;5617.410171931929;6022.457978781887;6056.454919057262;6056.666883321415;6060.090986352038;6062.818115456499;6025.126356678301;6103.664298463583;6109.5112391008615;6117.602355846856;6151.138840562325;5631.8592035199445;5632;5637.49262566371;5643.097104463307;5680.573956953203;6094.085887116968;6111.297200821962;6122;6139.693015349215;6149.723262453201;5854.092615644497;5896.174535564938;5920.644761314335;5960.0761881908375;6018.21763170785;6004.939950600526;6015.248093988252;6025.728842202111;6026.367231440723;6030.819075427744;5931.762729490858;5936.703164841827;5964.642121472725;5965.791197308074;5976.223090998143;5852.122181672783;6053.4551890330085;6091.878162436727;6124.6860923983895;6127.0673618518995;4532.886677833015;4542.341360502709;4564.292534657134;4587.747673877902;4600.125976064537;4032.1330913853076;4089.141280331104;4114.485689288839;4119.588041195856;4145.689073319513;5643.181738647955;5808.3901190375245;5813.854653633693;5815.709214539256;5847;6114.996965385541;6127.295361033449;6129.465243576896;6130.233720784902;6141.46463384154;5640.32316122068;5812.244408226988;5823.79616713413;5834.591578589458;5836.795712150054;5132.101882170605;5210.348706411699;5211.5830733541225;5215.478452154754;5245.239440281138;6224.097505861625;6231.594946328474;6247.156633854463;6258.311585725566;6279.215098112736;5899.410058994066;6033.668148251801;6047.9395206047375;6066.484348830222;6092.817215483543;6256.749730010931;6266.561340706106;6285.1515045470105;6288.559800814082;6291.622502649856;5919.49800432896;5967.8209653710455;5992.101184822312;6008.008678567988;6036.366181550874;5939.881202376015;6049.062395328731;6095.1466794647895;6121.969390153021;6123.510119190543;5884;5911.586188966731;5955.5235581154275;5963.582549221513;5968.910466342922;5857;5907.556933229939;5908.995470770065;5910.202122713551;5918.763249469973;5657.830265092054;5803.912941305968;5814.854628634318;5860.765569377178;5913.85215369602;5876.500497457764;5926.407359264212;5935.495482884004;5940.108983652487;5953.761849526144;5745;5788.710564471844;5817.331006934257;5824.3593204748295;5826.126081087701 08:10:53 INFO - PROCESS | 3420 | |1;ext.html;592.4904582059428;640.3756337570868;644.7066584703961;649.9317571654975;678.7183318922647;39351.60648393515;40323.395149072785;40352.59647403532;40360;40459.39310910335;43387.78306108473;43911.78044109775;43961.56038439614;44050.118997620026;44094.11811763763;8771.824563508742;8908.821823563525;8918.821623567525;8940.10598940104;8943.910560894405;8705.564721763918;8739.781505462352;8779.78050548735;8787.47275163489;8796.956015219916;8992.325575581825;9066.954665226665;9067.863982040275;9085.772855678595;9095.090490950919;8940.105989401072;8959.5968181432;8960.596773145191;8975.102489751005;8978.730638080868;8979.551022448917;9050.728478145666;9076.546172691338;9079.636814527412;9082.636694532212;43176.352354714705;43212.783936080436;43471.13057738859;43541.78229108866;43641.34537981933;3386.6782655647676;3755.2489502099415;3824.2160357126722;3862.6523612874694;4301.612854843079;28325.57511637327;28887.133385998455;28901.277468063257;28913.710862891312;29144.417111657862;4240.448741663564;4300.956990430118;4312.22379971605;4348.826046958118;4382.671299652538;196680;197876;199206;199324;199435;37318.25363492715;37720.811395942845;37735.43396849049;37836.62163378331;37933.43099853504;70540;70669.29330706627;71000.64499677469;71012;71042;17648.735268970977;17694.82305176932;17802.37691680785;17810;17856.107194640215;12748.043896707599;12928.547500837614;12953.481860725466;12958.80561791574;12963.351832408342;20664.793352066587;21082.78917210808;21083.84038877846;21117.577648446946;21207.257745978815;7528.548287102682;7537.989071910036;7579.5073320235115;7652.579108149105;7828.608569571498;1104.1056744037355;1155.2664058323026;1169.222467059396;1183.514758948844;1244.9791171239679;32236.84210526325;32890;33229.66770332314;33596;34138.82930585381;1189.8631657359342;1258.182181581979;1267.752788206291;1286.2598642226096;1302.990182608486;17348.826511734973;17365.913170434065;17436.389726359772;17580.912095439442;17860.821391786176;514693;542270;557042;568143;569256;57779.71110144423;58550.70724646435;58637.41362586405;59101.70449147813;59127.11309330363;1552.7437972734372;1563.1324614838645;1566.8198157211611;1575.8266590675016;1611.556821873994;30566.84716576403;32634.83682581572;33924.49113263352;34013.82993085019;34610.6883164134;55575;55603;56471;56485.435145648014;56512.71743641255;462597;469406;469470;469617;469762;31052.22369440782;31067.84466077655;31398.529022065144;31454.213644659067;31682.207944801565;50775;51063.234051488515;51384.229236560735;52005.21992170196;52288.7385563085;42119.947001325214;42204.57795422006;42392;42405.57594424016;44043.55956440394;41969.160616788104;42000.369994449495;42185;42709.78645106754;43486;40170.59829401786;40267.79866100768;40592.594074058885;45274.32088518609;45710.54289457196;34345.82827085849;35224.716292556324;35760.821195894896;35962.38169282441;36403;28724;28765;29073.12780616585;29109.417811643227;29246.561301580918 08:10:53 INFO - PROCESS | 3420 | |2;jquery.html;419.85095291171655;420.76437195170695;422.30530776872047;430.27713441418405;431.20227578978887;14787.260636968136;18483.44549663509;19196.904015479937;19304.131314090864;19395.515112122186;19852.801471985276;20141.697874531856;20345.186192552315;20626.587468250626;20643.174273029097;5449.972750136244;5712;5729.570282228829;5962.761489540413;5972.25346831646;5674.546036317105;5705.77176912923;5706.258186435757;5727.513161381287;5730.68481233532;5666.433356664342;5979.372165922581;5993.910091348612;6000.979833428328;6018.42824931633;5776;5910.202122713443;5960.880782384372;5963.344032156459;5968.67172305523;5793.826185214451;5815.912761308584;5818.0981947798155;5823.301203855564;5823.970880145572;13476.932615336958;13535.864641353657;13562.254076025913;13635.727285454235;13693.246871422069;2350.471143992605;2388.617821148608;2444.608862581996;2484.5900426429616;2510.259473455335;9887.703368898945;10054.64808731691;10077.042680945298;10346.12057975073;10403.479826008745;1948.756405449319;2034.0541648133542;2042;2049.1803278688644;2158.2554018863466;63542;74917.62541187313;76458.61770691167;79248.20751792466;83171.5841420795;11337.319760814213;11574.189806713617;11607.245529040585;11794.469248883821;11926.821097683369;16353.427630032891;16474.42339518111;16527.752083718755;16578.58553536147;16610.916945415196;8730.301575873915;8755.212030917248;8798;8804.207621314112;8812.339074569305;8530.78673033179;8561.22948934599;8616.224539791448;8650.740477785677;8652.567371631394;4968.22992436173;5081.18701007837;5119.897602047939;5123.103456895028;5167.9224811627855;2074.5332300232326;2097.4127244371603;2122.225387733466;2157.3959291398432;2161.297578287063;988.3081842710131;1055.6991257491577;1072.989270107289;1093.4532733633184;1110.8611423572054;19019.71470427917;19485.707714384294;19664.41006769799;19710.310139145062;20277.797222027886;1014.8680671512803;1027.3014350241758;1066.5467176449977;1083.366230755017;1125.3360517294836;10883;10972.177086718528;11142.164337674707;11189.776204475866;11228;198811;198812;199124;199814;200946;94483;99221;100360;100938;101346;1056.0548309263168;1069.1072954083272;1078.4014871746099;1084.2139448899643;1101.3226865477673;17170.656586867943;17321.13394330253;17368.826311737226;17496.300147993938;17787.46637600874;38035.239295214495;39436.2112757749;39578.802105989285;39950.40074398944;40057.599424006556;54724;56507.43492565022;56550.43449565616;57011.144832826714;57142.7142864283;8813.559322033745;8864.778380540538;8889.155530224618;8997.865032024394;9006.864897026418;12955.287459189834;13728.382222799799;13730.794038089636;13769.105008174436;13900.096493727875;11720.179587428798;11738.119641026786;11783.587574434854;11993.513783210678;12084.939575302418;11482.827757583476;11500.654980350602;11741.882581174079;11902.464389102339;12067.81898271509;12074.335911524951;12138.33239171854;12337.876621234032;12363.443645036175;12465.563705270271;9098.727038188865;9227.76930576741;9489.715308540755;12389.380530973596;12794.488220471078;12087.274763514217;12303.446344914679;12388.504459821866;12607.306598137191;13089.149205301625 08:10:53 INFO - PROCESS | 3420 | |3;mootools.html;1593.482118311549;1608.7184742670038;1813.782346118466;1892.924283028679;1910;7609.0869095708595;8328.50028998259;8416.116307787679;8529.019162796272;8606.139386061392;8151.347892168627;8151.551664658441;8212.712555060574;8214.958925205365;8224.958875205615;2365.7989070928948;2369.1707902234252;2389.2951579284154;2389.5579317826173;2401.639754036891;2363.1492662641435;2383.344580240439;2428.5871401861637;2438.3538362333998;2438.890249938757;2403.1108489858775;2407.903683852644;2427.186892391051;2428.453597940467;2435.476372579895;2407.7953373963232;2420.0319872051145;2445.0708730682404;2445.7798798108165;2451.7548245175517;2390.8685022323766;2402.759724027601;2403.134871446278;2404.326788499223;2413.095089341497;8324.750257492224;8327.916720832774;8375.664973401057;8391.95804020976;8393.244607985249;5219.634625576211;5338.985592737367;5341.732913354317;5366.087765079946;5380.273663055476;3510.929781404383;3517.2262102337445;3524.8061356625376;3700.9074773130887;3721.9627803721887;1107.2802678259116;1149.367847683779;1174.0666170394472;1194.4863708605296;1198.7063169523435;11961.40192990347;12034.458449369798;12045.457954392074;12047.156699031071;12053.216540924812;4659.930101048487;4662.137504561599;4765.404324459442;4824.372831531879;4828.61371090312;10235.7441063974;10272.897271027343;10332.586696532206;10334.224933129895;10344.32761870476;5348.224507446398;5392.811251606254;5395.595330350239;5411.729413529387;5448.073827449343;4231.661467082626;4716.056788642285;4784.736839473862;4809.687370320918;4981.078500477423;4140.275451795924;4142.937855932163;4197.4753155855515;4225.471816022997;4305.9569404306185;1290.4386591832583;1323.4375390459015;1342.5703774792169;1347.723716638087;1358.1240100135358;983.5868935047155;1045.4406892312577;1066.6160182334354;1077.5905156040653;1079.4980334144504;5917.615355001911;5953.523718102541;6073.423024812636;6074.848128796815;6203.4416902479;486.48189677992826;491.2778216022441;501.65135231014096;504.70222568684653;509.77569869257405;4118.238125946709;4130.731502452331;4198.391233271159;4222.387753775747;4224.471941007374;10316.484175791331;10609.204309676805;10696.732581685521;10760.139188865029;10776.622818201482;10483.318584291997;10540.63107791239;10547.156227501782;10594.099501542301;10619.84070238947;7788.14330423653;7986.720464783704;8068.596570171468;8249.917500824915;8326.750197494084;6021.397860214119;6035.245594300713;6129.84675383119;6158.969205153946;6284.340144284784;9348.626054957998;9395.530223488662;9435.198008169382;9462.526873656152;9517.381370210915;9547.283953703361;9605.711828645151;9687.564059617474;9714.417134971924;9805;6992.1958974718555;7634.312911837961;7774.494657847222;7951.204879512003;8010.479318844256;8514.78713032179;8527.445716028438;8547.102554231717;8564.100769419121;8591.012033616214;7610.277023682741;7711.845763084819;7734.187910269566;7775.57234352116;7886.329661978567;7685.423593230418;7691.730789422567;7699.615019248903;7772.300492955661;7789.805254868674;7056.788296351117;7078.964605176941;7081.362677359062;7118.359347658528;7121.038659780863;5056.241563765465;5226.137687281708;5308.495692909168;5337.973310133424;5375.865603359947;5217.165253559412;5266.710330931835;5275.630705850707;5318.282031925641;5400.351957764936 08:10:53 INFO - PROCESS | 3420 | |4;prototype.html;359.89203239028285;365.19110170971294;365.6836836136741;367.72053239537945;374.69836781390967;6756.831079223022;6783.050372947785;6826.317368263171;6848.5548439351405;6870.725170993167;6709.899351509719;6723.562968407063;6744.494162937787;6745.3591908768585;6759.594424334531;4774.976125119379;4911.214205727084;4997.675151115184;5010.974945125269;5013.047520971004;4966.453690094087;4967.925481117786;4996.000799840029;5005.849824505271;5010.248462730583;4962.950370496285;4979;4979.825706100287;4996;5066.341375621182;5054.797808087672;5064.3922729272535;5071.239314102877;5071.290019397287;5077.695338279678;4458.77706114693;4459.754713490756;4465.352523884051;4471.82112715491;4473.060657261979;6355.046742988542;6491.67541622917;6515.576487528343;6520.18497687789;6539.378759017885;5882.411758824126;5898.498627616657;5914.792982245601;5921.407859214087;5922.437368449991;7066.470014748915;7088.822779430556;7120.964395178043;7130.429565634737;7133.571985680824;4859.878503037417;4873.244647079709;4876.049170411771;4878.121938051149;4878.902421951541;7234.746783862593;7338.15611204713;7402.888956665654;7405.666744996488;7406.777796666109;4845.878853028632;4846.5638092571835;4851.830185943546;4852.660313778072;4854.854354369375;4846.830360937351;4871.683340582851;4892.2661600760175;4904.362432883702;4907.70553766768;5757.798477053283;5766.682832444256;5767.538596912321;5769.278840144982;5774.04728219839;7102.041224434738;7107.751228707074;7109.537880037781;7111.830891578118;7122.074130363019;1757.8242175782575;1783.0817129178483;1786.5444311700694;1786.7409225662466;1789.7852257729155;1083.918706097046;1150.3328069719544;1154.4170194052117;1165.3823473559028;1171.297221666993;6877.552959057645;6901.62041087745;6939.7224111036;6946;6947.409470194989;7216.747413840595;7365.3739432147795;7373.705051797868;7384.26157384268;7400.296971787671;6922.653867306614;6924.757633482905;7049.647517624098;7051.717931282691;7056.682449289794;3971.8808435746973;4033.9394909076386;4038.1721747042375;4043.6158564936286;4044.8584299549375;7789.571573563395;7790.649420776079;7810.0237470316215;7816.06207255133;7838.843223135619;7255.637218139177;7439.590822504706;7572.962135189288;7573.848523029508;7614.8096297593;7740.8838867417035;7777.261160189773;7823.804404889809;7828.138904720477;7834.138244793068;7434.702611895464;7446.069241344832;7452.366548843409;7475.700971961278;7489.251074892685;7319.158296795937;7349.081364829396;7358.558486490828;7359.77920662381;7364.3372096511575;7657.1959944205055;7775.339096176662;7795.259450352434;7811.140774514685;7816.64825082884;4815.807367705393;4838.298446725134;4865.1242776300605;4876.707397556158;4884.48712885142;7379.3358597726465;7403.666834992546;7424.368928641126;7450.96274518624;7459.589722565311;7127.322904324288;7174.210836808052;7217.159624295771;7219.205887352492;7232.493725439169;6978.337057979484;7180.497365184387;7181.748638797617;7182.3894968928225;7193.964030179815;7028.683709232994;7042.753503627348;7063.328983746535;7077.256888026889;7089.255628158969;7246.094238220223;7259.419246460165;7260.382867456326;7260.4554658399775;7275.527090739297;6848.520603557703;6964.477664175309;7007.929920700728;7022.54353467023;7031.753888613874 08:10:53 INFO - PROCESS | 3420 | |5;yui.html;819.3895547816877;875.1817051057266;926.3746970794712;937.9906200937988;940.2055263302509;13744.862551374483;13818.447262109516;17160.914195429006;17246.482605521855;17368.56578585536;15558.144302063381;15586.688266234669;15728.685426291468;15732.134732589731;15857.444989425372;893.4103491695482;898.1333013641835;908.4231512989267;911.9088091190894;912.2154946745793;905.7237542549519;914;915.1031988651126;920.3235621817959;930.5998420679106;954.6992697300362;960.6925783749203;961.3799099580766;963.3016063354047;971.3880255439063;949.8575213717928;956.956936937836;959.3764053365298;960.3757557587554;961.8749562556858;704.4646068987555;704.68993642797;705.3510770091528;707.1478867964091;714.949953503255;15913.761293580606;16029;16070.5982350441;16094.356225750957;16102.5974350641;14360;14419.639509012253;14488;14509.129452232793;14586.34361453737;11912.702182445422;12072.215306005082;12123.878761212363;12259;12427.13010089294;3999.8200080996426;4042.171354872244;4067.89830254246;4070.7761073140964;4185.351270553069;59206.11190832141;59327;59494.40505594932;59733.402665973656;60232.69883650597;10839.891601084046;10906.5092070857;11204;11293.71765705864;11554.248973816675;20501.897490512452;20554.97225138737;20645.58708825845;20720.792792071887;20763;8620.741377758677;8683.088275731083;8782.912170878337;8853.15894989975;9063.41087829289;5040.722760248222;5102.821401250939;5151.8196863109615;5230.764615592308;5238.449962753933;3451.8964431067106;3480.6693364130365;3483.7110269200557;3483.8083905385447;3501.6148223695373;633.2274624957545;650.8080116365684;657.2179106862914;663.8738639658546;666.8999650052434;706.7702996526046;804.3846457460048;805.79049447143;807.8182408958055;832.1304237072274;9408.341416100808;10256.28206025586;10279.640212592523;10302.896971030345;10325.793484130276;723.7105157936762;738.7525179065074;752.6688257166829;785.1363500149789;789.2305002622512;4692.554207350365;4706.411698537683;4727.7399743013775;4731.668783185213;4860.854174374775;63279.36720632735;66541;66642.66678666575;66704;67344;58518.707406462694;59381.70309148427;59735.40264597299;60033;60588.69705651532;53102.734486327325;53815;54371.72814135904;54913.176302355496;54978.45021549813;10131.392116473035;10211.948940255252;10441.738956526147;10567.46771718112;10603.310784798963;39111.80444097761;39679.60320396875;40005.599944001355;40553.797231013654;41067.383989240785;47197.7640111811;48618.75690621524;53402;53624.19563706625;54053.45946540484;12742.171758835646;12798.16811907223;13014.21914685122;13086.803697944348;13144.27706476153;14297;14306.284685765879;14347.85652143507;14362.640933976734;14385.280735962951;13319.800202996768;13368.598942031755;13390.531331403354;13415.32923353848;13424;12979.221246725227;12998.155119917175;13071;13227.66930826737;13815.447382104603;12992.285424301754;13132.606021819362;13385.933070334586;13427.07691083731;13517.391717372939;11185.944070279596;11439.428028598702;11516.769664606829;11592.942035289769;11628.418579070843;11304.547818087512;11657.358845263252;11733.413329333669;11814.173007889709;12046.337451440255 08:10:53 INFO - PROCESS | 3420 | __end_tp_report 08:10:53 INFO - PROCESS | 3420 | __start_cc_report 08:10:53 INFO - PROCESS | 3420 | _x_x_mozilla_cycle_collect,325 08:10:53 INFO - PROCESS | 3420 | __end_cc_report 08:10:53 INFO - PROCESS | 3420 | __startTimestamp1464793853884__endTimestamp 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | ------- Summary: start ------- 08:10:53 INFO - PROCESS | 3420 | Number of tests: 6 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | [#0] dojo.html Cycles:165 Average:5615.99 Median:5847.00 stddev:634.41 (10.9%) stddev-sans-first:610.55 08:10:53 INFO - PROCESS | 3420 | Values: 3332.7 3336.6 3359.2 3369.0 3415.0 5596.8 5603.7 5642.9 5656.8 5699.0 5595.4 5666.9 5701.6 5711.9 5729.8 5090.7 5124.1 5147.2 5163.5 5185.1 5030.4 5092.9 5115.6 5276.7 5301.6 5067.8 5109.6 5124.7 5128.4 5192.0 5130.7 5178.4 5184.0 5190.5 5226.6 4866.8 5014.4 5064.4 5097.5 5149.9 5524.4 5550.9 5565.7 5568.9 5617.4 6022.5 6056.5 6056.7 6060.1 6062.8 6025.1 6103.7 6109.5 6117.6 6151.1 5631.9 5632.0 5637.5 5643.1 5680.6 6094.1 6111.3 6122.0 6139.7 6149.7 5854.1 5896.2 5920.6 5960.1 6018.2 6004.9 6015.2 6025.7 6026.4 6030.8 5931.8 5936.7 5964.6 5965.8 5976.2 5852.1 6053.5 6091.9 6124.7 6127.1 4532.9 4542.3 4564.3 4587.7 4600.1 4032.1 4089.1 4114.5 4119.6 4145.7 5643.2 5808.4 5813.9 5815.7 5847.0 6115.0 6127.3 6129.5 6130.2 6141.5 5640.3 5812.2 5823.8 5834.6 5836.8 5132.1 5210.3 5211.6 5215.5 5245.2 6224.1 6231.6 6247.2 6258.3 6279.2 5899.4 6033.7 6047.9 6066.5 6092.8 6256.7 6266.6 6285.2 6288.6 6291.6 5919.5 5967.8 5992.1 6008.0 6036.4 5939.9 6049.1 6095.1 6122.0 6123.5 5884.0 5911.6 5955.5 5963.6 5968.9 5857.0 5907.6 5909.0 5910.2 5918.8 5657.8 5803.9 5814.9 5860.8 5913.9 5876.5 5926.4 5935.5 5940.1 5953.8 5745.0 5788.7 5817.3 5824.4 5826.1 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | [#1] ext.html Cycles:180 Average:57560.76 Median:42194.79 stddev:115420.72 (273.5%) stddev-sans-first:115665.25 08:10:53 INFO - PROCESS | 3420 | Values: 592.5 640.4 644.7 649.9 678.7 39351.6 40323.4 40352.6 40360.0 40459.4 43387.8 43911.8 43961.6 44050.1 44094.1 8771.8 8908.8 8918.8 8940.1 8943.9 8705.6 8739.8 8779.8 8787.5 8797.0 8992.3 9067.0 9067.9 9085.8 9095.1 8940.1 8959.6 8960.6 8975.1 8978.7 8979.6 9050.7 9076.5 9079.6 9082.6 43176.4 43212.8 43471.1 43541.8 43641.3 3386.7 3755.2 3824.2 3862.7 4301.6 28325.6 28887.1 28901.3 28913.7 29144.4 4240.4 4301.0 4312.2 4348.8 4382.7 196680.0 197876.0 199206.0 199324.0 199435.0 37318.3 37720.8 37735.4 37836.6 37933.4 70540.0 70669.3 71000.6 71012.0 71042.0 17648.7 17694.8 17802.4 17810.0 17856.1 12748.0 12928.5 12953.5 12958.8 12963.4 20664.8 21082.8 21083.8 21117.6 21207.3 7528.5 7538.0 7579.5 7652.6 7828.6 1104.1 1155.3 1169.2 1183.5 1245.0 32236.8 32890.0 33229.7 33596.0 34138.8 1189.9 1258.2 1267.8 1286.3 1303.0 17348.8 17365.9 17436.4 17580.9 17860.8 514693.0 542270.0 557042.0 568143.0 569256.0 57779.7 58550.7 58637.4 59101.7 59127.1 1552.7 1563.1 1566.8 1575.8 1611.6 30566.8 32634.8 33924.5 34013.8 34610.7 55575.0 55603.0 56471.0 56485.4 56512.7 462597.0 469406.0 469470.0 469617.0 469762.0 31052.2 31067.8 31398.5 31454.2 31682.2 50775.0 51063.2 51384.2 52005.2 52288.7 42119.9 42204.6 42392.0 42405.6 44043.6 41969.2 42000.4 42185.0 42709.8 43486.0 40170.6 40267.8 40592.6 45274.3 45710.5 34345.8 35224.7 35760.8 35962.4 36403.0 28724.0 28765.0 29073.1 29109.4 29246.6 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | [#2] jquery.html Cycles:180 Average:20888.33 Median:11155.93 stddev:36622.37 (328.3%) stddev-sans-first:36692.86 08:10:53 INFO - PROCESS | 3420 | Values: 419.9 420.8 422.3 430.3 431.2 14787.3 18483.4 19196.9 19304.1 19395.5 19852.8 20141.7 20345.2 20626.6 20643.2 5450.0 5712.0 5729.6 5962.8 5972.3 5674.5 5705.8 5706.3 5727.5 5730.7 5666.4 5979.4 5993.9 6001.0 6018.4 5776.0 5910.2 5960.9 5963.3 5968.7 5793.8 5815.9 5818.1 5823.3 5824.0 13476.9 13535.9 13562.3 13635.7 13693.2 2350.5 2388.6 2444.6 2484.6 2510.3 9887.7 10054.6 10077.0 10346.1 10403.5 1948.8 2034.1 2042.0 2049.2 2158.3 63542.0 74917.6 76458.6 79248.2 83171.6 11337.3 11574.2 11607.2 11794.5 11926.8 16353.4 16474.4 16527.8 16578.6 16610.9 8730.3 8755.2 8798.0 8804.2 8812.3 8530.8 8561.2 8616.2 8650.7 8652.6 4968.2 5081.2 5119.9 5123.1 5167.9 2074.5 2097.4 2122.2 2157.4 2161.3 988.3 1055.7 1073.0 1093.5 1110.9 19019.7 19485.7 19664.4 19710.3 20277.8 1014.9 1027.3 1066.5 1083.4 1125.3 10883.0 10972.2 11142.2 11189.8 11228.0 198811.0 198812.0 199124.0 199814.0 200946.0 94483.0 99221.0 100360.0 100938.0 101346.0 1056.1 1069.1 1078.4 1084.2 1101.3 17170.7 17321.1 17368.8 17496.3 17787.5 38035.2 39436.2 39578.8 39950.4 40057.6 54724.0 56507.4 56550.4 57011.1 57142.7 8813.6 8864.8 8889.2 8997.9 9006.9 12955.3 13728.4 13730.8 13769.1 13900.1 11720.2 11738.1 11783.6 11993.5 12084.9 11482.8 11500.7 11741.9 11902.5 12067.8 12074.3 12138.3 12337.9 12363.4 12465.6 9098.7 9227.8 9489.7 12389.4 12794.5 12087.3 12303.4 12388.5 12607.3 13089.1 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | [#3] mootools.html Cycles:180 Average:5752.53 Median:2741.36 stddev:3157.49 (115.2%) stddev-sans-first:3150.87 08:10:53 INFO - PROCESS | 3420 | Values: 1593.5 1608.7 1813.8 1892.9 1910.0 7609.1 8328.5 8416.1 8529.0 8606.1 8151.3 8151.6 8212.7 8215.0 8225.0 2365.8 2369.2 2389.3 2389.6 2401.6 2363.1 2383.3 2428.6 2438.4 2438.9 2403.1 2407.9 2427.2 2428.5 2435.5 2407.8 2420.0 2445.1 2445.8 2451.8 2390.9 2402.8 2403.1 2404.3 2413.1 8324.8 8327.9 8375.7 8392.0 8393.2 5219.6 5339.0 5341.7 5366.1 5380.3 3510.9 3517.2 3524.8 3700.9 3722.0 1107.3 1149.4 1174.1 1194.5 1198.7 11961.4 12034.5 12045.5 12047.2 12053.2 4659.9 4662.1 4765.4 4824.4 4828.6 10235.7 10272.9 10332.6 10334.2 10344.3 5348.2 5392.8 5395.6 5411.7 5448.1 4231.7 4716.1 4784.7 4809.7 4981.1 4140.3 4142.9 4197.5 4225.5 4306.0 1290.4 1323.4 1342.6 1347.7 1358.1 983.6 1045.4 1066.6 1077.6 1079.5 5917.6 5953.5 6073.4 6074.8 6203.4 486.5 491.3 501.7 504.7 509.8 4118.2 4130.7 4198.4 4222.4 4224.5 10316.5 10609.2 10696.7 10760.1 10776.6 10483.3 10540.6 10547.2 10594.1 10619.8 7788.1 7986.7 8068.6 8249.9 8326.8 6021.4 6035.2 6129.8 6159.0 6284.3 9348.6 9395.5 9435.2 9462.5 9517.4 9547.3 9605.7 9687.6 9714.4 9805.0 6992.2 7634.3 7774.5 7951.2 8010.5 8514.8 8527.4 8547.1 8564.1 8591.0 7610.3 7711.8 7734.2 7775.6 7886.3 7685.4 7691.7 7699.6 7772.3 7789.8 7056.8 7079.0 7081.4 7118.4 7121.0 5056.2 5226.1 5308.5 5338.0 5375.9 5217.2 5266.7 5275.6 5318.3 5400.4 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | [#4] prototype.html Cycles:180 Average:5959.57 Median:6874.14 stddev:1848.03 (26.9%) stddev-sans-first:1804.79 08:10:53 INFO - PROCESS | 3420 | Values: 359.9 365.2 365.7 367.7 374.7 6756.8 6783.1 6826.3 6848.6 6870.7 6709.9 6723.6 6744.5 6745.4 6759.6 4775.0 4911.2 4997.7 5011.0 5013.0 4966.5 4967.9 4996.0 5005.8 5010.2 4963.0 4979.0 4979.8 4996.0 5066.3 5054.8 5064.4 5071.2 5071.3 5077.7 4458.8 4459.8 4465.4 4471.8 4473.1 6355.0 6491.7 6515.6 6520.2 6539.4 5882.4 5898.5 5914.8 5921.4 5922.4 7066.5 7088.8 7121.0 7130.4 7133.6 4859.9 4873.2 4876.0 4878.1 4878.9 7234.7 7338.2 7402.9 7405.7 7406.8 4845.9 4846.6 4851.8 4852.7 4854.9 4846.8 4871.7 4892.3 4904.4 4907.7 5757.8 5766.7 5767.5 5769.3 5774.0 7102.0 7107.8 7109.5 7111.8 7122.1 1757.8 1783.1 1786.5 1786.7 1789.8 1083.9 1150.3 1154.4 1165.4 1171.3 6877.6 6901.6 6939.7 6946.0 6947.4 7216.7 7365.4 7373.7 7384.3 7400.3 6922.7 6924.8 7049.6 7051.7 7056.7 3971.9 4033.9 4038.2 4043.6 4044.9 7789.6 7790.6 7810.0 7816.1 7838.8 7255.6 7439.6 7573.0 7573.8 7614.8 7740.9 7777.3 7823.8 7828.1 7834.1 7434.7 7446.1 7452.4 7475.7 7489.3 7319.2 7349.1 7358.6 7359.8 7364.3 7657.2 7775.3 7795.3 7811.1 7816.6 4815.8 4838.3 4865.1 4876.7 4884.5 7379.3 7403.7 7424.4 7451.0 7459.6 7127.3 7174.2 7217.2 7219.2 7232.5 6978.3 7180.5 7181.7 7182.4 7194.0 7028.7 7042.8 7063.3 7077.3 7089.3 7246.1 7259.4 7260.4 7260.5 7275.5 6848.5 6964.5 7007.9 7022.5 7031.8 08:10:53 INFO - PROCESS | 3420 | 08:10:53 INFO - PROCESS | 3420 | [#5] yui.html Cycles:180 Average:16160.16 Median:4069.34 stddev:18678.20 (459.0%) stddev-sans-first:18695.06 08:10:53 INFO - PROCESS | 3420 | Values: 819.4 875.2 926.4 938.0 940.2 13744.9 13818.4 17160.9 17246.5 17368.6 15558.1 15586.7 15728.7 15732.1 15857.4 893.4 898.1 908.4 911.9 912.2 905.7 914.0 915.1 920.3 930.6 954.7 960.7 961.4 963.3 971.4 949.9 957.0 959.4 960.4 961.9 704.5 704.7 705.4 707.1 714.9 15913.8 16029.0 16070.6 16094.4 16102.6 14360.0 14419.6 14488.0 14509.1 14586.3 11912.7 12072.2 12123.9 12259.0 12427.1 3999.8 4042.2 4067.9 4070.8 4185.4 59206.1 59327.0 59494.4 59733.4 60232.7 10839.9 10906.5 11204.0 11293.7 11554.2 20501.9 20555.0 20645.6 20720.8 20763.0 8620.7 8683.1 8782.9 8853.2 9063.4 5040.7 5102.8 5151.8 5230.8 5238.4 3451.9 3480.7 3483.7 3483.8 3501.6 633.2 650.8 657.2 663.9 666.9 706.8 804.4 805.8 807.8 832.1 9408.3 10256.3 10279.6 10302.9 10325.8 723.7 738.8 752.7 785.1 789.2 4692.6 4706.4 4727.7 4731.7 4860.9 63279.4 66541.0 66642.7 66704.0 67344.0 58518.7 59381.7 59735.4 60033.0 60588.7 53102.7 53815.0 54371.7 54913.2 54978.5 10131.4 10211.9 10441.7 10567.5 10603.3 39111.8 39679.6 40005.6 40553.8 41067.4 47197.8 48618.8 53402.0 53624.2 54053.5 12742.2 12798.2 13014.2 13086.8 13144.3 14297.0 14306.3 14347.9 14362.6 14385.3 13319.8 13368.6 13390.5 13415.3 13424.0 12979.2 12998.2 13071.0 13227.7 13815.4 12992.3 13132.6 13385.9 13427.1 13517.4 11185.9 11439.4 11516.8 11592.9 11628.4 11304.5 11657.4 11733.4 11814.2 12046.3 08:10:53 INFO - PROCESS | 3420 | -------- Summary: end -------- 08:10:53 INFO - PROCESS | 3420 | 08:10:54 INFO - TEST-INFO | 3420: exit 0 08:10:54 INFO - TEST-OK | dromaeo_css | took 1112220ms 08:10:54 INFO - TEST-START | kraken 08:10:54 INFO - operating with platform_type : linux_ 08:10:54 INFO - Initialising browser for kraken test... 08:10:54 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc87oJ2/profile http://localhost:51122/getInfo.html) 08:10:58 INFO - PROCESS | 3663 | 08:10:58 INFO - PROCESS | 3663 | (process:3744): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:10:59 INFO - PROCESS | 3663 | __metrics Screen width/height:1600/1200 08:10:59 INFO - PROCESS | 3663 | colorDepth:24 08:10:59 INFO - PROCESS | 3663 | Browser inner width/height: 1024/697 08:10:59 INFO - PROCESS | 3663 | __metrics 08:10:59 ERROR - PROCESS | 3663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 08:11:00 INFO - TEST-INFO | 3663: exit 0 08:11:00 INFO - Browser initialized. 08:11:00 INFO - Running cycle 1/1 for kraken test... 08:11:00 INFO - TEST-INFO | started process 3795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc87oJ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:02 INFO - PROCESS | 3795 | 08:11:02 INFO - PROCESS | 3795 | (process:3868): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:11:12 INFO - PROCESS | 3795 | RSS: Main: 152027136 08:11:12 INFO - PROCESS | 3795 | 08:11:14 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:15 INFO - PROCESS | 3795 | RSS: Main: 156659712 08:11:15 INFO - PROCESS | 3795 | 08:11:18 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-dft) 08:11:19 INFO - PROCESS | 3795 | RSS: Main: 157216768 08:11:19 INFO - PROCESS | 3795 | 08:11:21 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-fft) 08:11:22 INFO - PROCESS | 3795 | RSS: Main: 157442048 08:11:22 INFO - PROCESS | 3795 | 08:11:24 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-oscillator) 08:11:25 INFO - PROCESS | 3795 | RSS: Main: 157179904 08:11:25 INFO - PROCESS | 3795 | 08:11:27 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:28 INFO - PROCESS | 3795 | RSS: Main: 157224960 08:11:28 INFO - PROCESS | 3795 | 08:11:31 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51122/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:31 INFO - PROCESS | 3795 | RSS: Main: 157114368 08:11:31 INFO - PROCESS | 3795 | 08:11:35 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51122/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:35 INFO - PROCESS | 3795 | RSS: Main: 157167616 08:11:35 INFO - PROCESS | 3795 | 08:11:38 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51122/tests/kraken/driver.html?testName=json-parse-financial) 08:11:39 INFO - PROCESS | 3795 | RSS: Main: 157192192 08:11:39 INFO - PROCESS | 3795 | 08:11:40 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:41 INFO - PROCESS | 3795 | RSS: Main: 157970432 08:11:41 INFO - PROCESS | 3795 | 08:11:42 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:11:43 INFO - PROCESS | 3795 | RSS: Main: 157175808 08:11:43 INFO - PROCESS | 3795 | 08:11:45 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:46 INFO - PROCESS | 3795 | RSS: Main: 157351936 08:11:46 INFO - PROCESS | 3795 | 08:11:48 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:49 INFO - PROCESS | 3795 | RSS: Main: 157708288 08:11:49 INFO - PROCESS | 3795 | 08:11:51 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:11:52 INFO - PROCESS | 3795 | RSS: Main: 157691904 08:11:52 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51122/tests/kraken/driver.html?testName=ai-astar) 08:11:54 INFO - PROCESS | 3795 | RSS: Main: 159764480 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | __start_tp_report 08:11:54 INFO - PROCESS | 3795 | _x_x_mozilla_page_load 08:11:54 INFO - PROCESS | 3795 | _x_x_mozilla_page_load_details 08:11:54 INFO - PROCESS | 3795 | |i|pagename|runs| 08:11:54 INFO - PROCESS | 3795 | |0;ai-astar;112;109;104;109;111;110;100;110;111;110 08:11:54 INFO - PROCESS | 3795 | |1;audio-beat-detection;163;129;161;178;128;158;167;139;179;133 08:11:54 INFO - PROCESS | 3795 | |2;audio-dft;163;165;163;162;161;161;160;163;162;161 08:11:54 INFO - PROCESS | 3795 | |3;audio-fft;73;77;76;161;75;76;76;76;168;76 08:11:54 INFO - PROCESS | 3795 | |4;audio-oscillator;92;92;152;93;92;94;138;92;93;148 08:11:54 INFO - PROCESS | 3795 | |5;imaging-gaussian-blur;117;118;116;117;119;118;117;117;118;117 08:11:54 INFO - PROCESS | 3795 | |6;imaging-darkroom;146;147;148;147;146;147;147;147;147;148 08:11:54 INFO - PROCESS | 3795 | |7;imaging-desaturate;96;96;95;95;95;95;95;100;96;95 08:11:54 INFO - PROCESS | 3795 | |8;json-parse-financial;56;54;55;55;57;56;56;81;54;60 08:11:54 INFO - PROCESS | 3795 | |9;json-stringify-tinderbox;58;59;58;58;58;59;58;57;58;59 08:11:54 INFO - PROCESS | 3795 | |10;stanford-crypto-aes;73;81;73;72;73;73;74;73;75;73 08:11:54 INFO - PROCESS | 3795 | |11;stanford-crypto-ccm;115;126;117;116;112;109;119;113;128;124 08:11:54 INFO - PROCESS | 3795 | |12;stanford-crypto-pbkdf2;158;165;159;164;160;155;157;155;155;163 08:11:54 INFO - PROCESS | 3795 | |13;stanford-crypto-sha256-iterative;65;67;66;67;66;66;63;66;68;65 08:11:54 INFO - PROCESS | 3795 | __end_tp_report 08:11:54 INFO - PROCESS | 3795 | __start_cc_report 08:11:54 INFO - PROCESS | 3795 | _x_x_mozilla_cycle_collect,868 08:11:54 INFO - PROCESS | 3795 | __end_cc_report 08:11:54 INFO - PROCESS | 3795 | __startTimestamp1464793914470__endTimestamp 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | ------- Summary: start ------- 08:11:54 INFO - PROCESS | 3795 | Number of tests: 14 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.72 (3.4%) stddev-sans-first:3.73 08:11:54 INFO - PROCESS | 3795 | Values: 112.0 109.0 104.0 109.0 111.0 110.0 100.0 110.0 111.0 110.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:162.00 stddev:19.67 (12.1%) stddev-sans-first:20.56 08:11:54 INFO - PROCESS | 3795 | Values: 163.0 129.0 161.0 178.0 128.0 158.0 167.0 139.0 179.0 133.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.45 (0.9%) stddev-sans-first:1.50 08:11:54 INFO - PROCESS | 3795 | Values: 163.0 165.0 163.0 162.0 161.0 161.0 160.0 163.0 162.0 161.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:37.52 (49.4%) stddev-sans-first:39.07 08:11:54 INFO - PROCESS | 3795 | Values: 73.0 77.0 76.0 161.0 75.0 76.0 76.0 76.0 168.0 76.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.00 stddev:26.04 (28.3%) stddev-sans-first:26.92 08:11:54 INFO - PROCESS | 3795 | Values: 92.0 92.0 152.0 93.0 92.0 94.0 138.0 92.0 93.0 148.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 08:11:54 INFO - PROCESS | 3795 | Values: 117.0 118.0 116.0 117.0 119.0 118.0 117.0 117.0 118.0 117.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 08:11:54 INFO - PROCESS | 3795 | Values: 146.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 08:11:54 INFO - PROCESS | 3795 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 100.0 96.0 95.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:56.00 stddev:8.13 (14.5%) stddev-sans-first:8.57 08:11:54 INFO - PROCESS | 3795 | Values: 56.0 54.0 55.0 55.0 57.0 56.0 56.0 81.0 54.0 60.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 08:11:54 INFO - PROCESS | 3795 | Values: 58.0 59.0 58.0 58.0 58.0 59.0 58.0 57.0 58.0 59.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:2.58 (3.5%) stddev-sans-first:2.71 08:11:54 INFO - PROCESS | 3795 | Values: 73.0 81.0 73.0 72.0 73.0 73.0 74.0 73.0 75.0 73.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.00 stddev:6.30 (5.3%) stddev-sans-first:6.59 08:11:54 INFO - PROCESS | 3795 | Values: 115.0 126.0 117.0 116.0 112.0 109.0 119.0 113.0 128.0 124.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:3.81 (2.4%) stddev-sans-first:4.02 08:11:54 INFO - PROCESS | 3795 | Values: 158.0 165.0 159.0 164.0 160.0 155.0 157.0 155.0 155.0 163.0 08:11:54 INFO - PROCESS | 3795 | 08:11:54 INFO - PROCESS | 3795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.41 08:11:54 INFO - PROCESS | 3795 | Values: 65.0 67.0 66.0 67.0 66.0 66.0 63.0 66.0 68.0 65.0 08:11:54 INFO - PROCESS | 3795 | -------- Summary: end -------- 08:11:54 INFO - PROCESS | 3795 | 08:11:55 INFO - TEST-INFO | 3795: exit 0 08:11:55 INFO - TEST-OK | kraken | took 60836ms 08:11:55 INFO - SUITE-END | took 1173s 08:11:55 INFO - Completed test suite (00:19:33) 08:11:55 INFO - javascript benchmark 08:11:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.6833950774676, 3336.6496517865626, 3359.2105855124055, 3369.0, 3414.9658503414958, 5596.83209503715, 5603.663780173188, 5642.887142257153, 5656.773729050833, 5699.0, 5595.4124816894255, 5666.914996275049, 5701.600887937846, 5711.885762284762, 5729.828105156842, 5090.720010399426, 5124.103281925667, 5147.1764517677175, 5163.535281824635, 5185.144451165553, 5030.396352437712, 5092.9236061459105, 5115.641905066628, 5276.709780962045, 5301.575873930076, 5067.771950262247, 5109.591232701375, 5124.692518448886, 5128.358955130609, 5191.974040129794, 5130.743462826844, 5178.40448348441, 5184.040952423795, 5190.532852043297, 5226.55574276187, 4866.805327786884, 5014.423341315759, 5064.417591976933, 5097.46476619957, 5149.922751158736, 5524.4199359067525, 5550.888982220374, 5565.749541270612, 5568.888622227573, 5617.410171931929, 6022.457978781887, 6056.454919057262, 6056.666883321415, 6060.090986352038, 6062.818115456499, 6025.126356678301, 6103.664298463583, 6109.5112391008615, 6117.602355846856, 6151.138840562325, 5631.8592035199445, 5632.0, 5637.49262566371, 5643.097104463307, 5680.573956953203, 6094.085887116968, 6111.297200821962, 6122.0, 6139.693015349215, 6149.723262453201, 5854.092615644497, 5896.174535564938, 5920.644761314335, 5960.0761881908375, 6018.21763170785, 6004.939950600526, 6015.248093988252, 6025.728842202111, 6026.367231440723, 6030.819075427744, 5931.762729490858, 5936.703164841827, 5964.642121472725, 5965.791197308074, 5976.223090998143, 5852.122181672783, 6053.4551890330085, 6091.878162436727, 6124.6860923983895, 6127.0673618518995, 4532.886677833015, 4542.341360502709, 4564.292534657134, 4587.747673877902, 4600.125976064537, 4032.1330913853076, 4089.141280331104, 4114.485689288839, 4119.588041195856, 4145.689073319513, 5643.181738647955, 5808.3901190375245, 5813.854653633693, 5815.709214539256, 5847.0, 6114.996965385541, 6127.295361033449, 6129.465243576896, 6130.233720784902, 6141.46463384154, 5640.32316122068, 5812.244408226988, 5823.79616713413, 5834.591578589458, 5836.795712150054, 5132.101882170605, 5210.348706411699, 5211.5830733541225, 5215.478452154754, 5245.239440281138, 6224.097505861625, 6231.594946328474, 6247.156633854463, 6258.311585725566, 6279.215098112736, 5899.410058994066, 6033.668148251801, 6047.9395206047375, 6066.484348830222, 6092.817215483543, 6256.749730010931, 6266.561340706106, 6285.1515045470105, 6288.559800814082, 6291.622502649856, 5919.49800432896, 5967.8209653710455, 5992.101184822312, 6008.008678567988, 6036.366181550874, 5939.881202376015, 6049.062395328731, 6095.1466794647895, 6121.969390153021, 6123.510119190543, 5884.0, 5911.586188966731, 5955.5235581154275, 5963.582549221513, 5968.910466342922, 5857.0, 5907.556933229939, 5908.995470770065, 5910.202122713551, 5918.763249469973, 5657.830265092054, 5803.912941305968, 5814.854628634318, 5860.765569377178, 5913.85215369602, 5876.500497457764, 5926.407359264212, 5935.495482884004, 5940.108983652487, 5953.761849526144, 5745.0, 5788.710564471844, 5817.331006934257, 5824.3593204748295, 5826.126081087701], "value": 5573.863171663659, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4904582059428, 640.3756337570868, 644.7066584703961, 649.9317571654975, 678.7183318922647, 39351.60648393515, 40323.395149072785, 40352.59647403532, 40360.0, 40459.39310910335, 43387.78306108473, 43911.78044109775, 43961.56038439614, 44050.118997620026, 44094.11811763763, 8771.824563508742, 8908.821823563525, 8918.821623567525, 8940.10598940104, 8943.910560894405, 8705.564721763918, 8739.781505462352, 8779.78050548735, 8787.47275163489, 8796.956015219916, 8992.325575581825, 9066.954665226665, 9067.863982040275, 9085.772855678595, 9095.090490950919, 8940.105989401072, 8959.5968181432, 8960.596773145191, 8975.102489751005, 8978.730638080868, 8979.551022448917, 9050.728478145666, 9076.546172691338, 9079.636814527412, 9082.636694532212, 43176.352354714705, 43212.783936080436, 43471.13057738859, 43541.78229108866, 43641.34537981933, 3386.6782655647676, 3755.2489502099415, 3824.2160357126722, 3862.6523612874694, 4301.612854843079, 28325.57511637327, 28887.133385998455, 28901.277468063257, 28913.710862891312, 29144.417111657862, 4240.448741663564, 4300.956990430118, 4312.22379971605, 4348.826046958118, 4382.671299652538, 196680.0, 197876.0, 199206.0, 199324.0, 199435.0, 37318.25363492715, 37720.811395942845, 37735.43396849049, 37836.62163378331, 37933.43099853504, 70540.0, 70669.29330706627, 71000.64499677469, 71012.0, 71042.0, 17648.735268970977, 17694.82305176932, 17802.37691680785, 17810.0, 17856.107194640215, 12748.043896707599, 12928.547500837614, 12953.481860725466, 12958.80561791574, 12963.351832408342, 20664.793352066587, 21082.78917210808, 21083.84038877846, 21117.577648446946, 21207.257745978815, 7528.548287102682, 7537.989071910036, 7579.5073320235115, 7652.579108149105, 7828.608569571498, 1104.1056744037355, 1155.2664058323026, 1169.222467059396, 1183.514758948844, 1244.9791171239679, 32236.84210526325, 32890.0, 33229.66770332314, 33596.0, 34138.82930585381, 1189.8631657359342, 1258.182181581979, 1267.752788206291, 1286.2598642226096, 1302.990182608486, 17348.826511734973, 17365.913170434065, 17436.389726359772, 17580.912095439442, 17860.821391786176, 514693.0, 542270.0, 557042.0, 568143.0, 569256.0, 57779.71110144423, 58550.70724646435, 58637.41362586405, 59101.70449147813, 59127.11309330363, 1552.7437972734372, 1563.1324614838645, 1566.8198157211611, 1575.8266590675016, 1611.556821873994, 30566.84716576403, 32634.83682581572, 33924.49113263352, 34013.82993085019, 34610.6883164134, 55575.0, 55603.0, 56471.0, 56485.435145648014, 56512.71743641255, 462597.0, 469406.0, 469470.0, 469617.0, 469762.0, 31052.22369440782, 31067.84466077655, 31398.529022065144, 31454.213644659067, 31682.207944801565, 50775.0, 51063.234051488515, 51384.229236560735, 52005.21992170196, 52288.7385563085, 42119.947001325214, 42204.57795422006, 42392.0, 42405.57594424016, 44043.55956440394, 41969.160616788104, 42000.369994449495, 42185.0, 42709.78645106754, 43486.0, 40170.59829401786, 40267.79866100768, 40592.594074058885, 45274.32088518609, 45710.54289457196, 34345.82827085849, 35224.716292556324, 35760.821195894896, 35962.38169282441, 36403.0, 28724.0, 28765.0, 29073.12780616585, 29109.417811643227, 29246.561301580918], "value": 20345.4849772831, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.85095291171655, 420.76437195170695, 422.30530776872047, 430.27713441418405, 431.20227578978887, 14787.260636968136, 18483.44549663509, 19196.904015479937, 19304.131314090864, 19395.515112122186, 19852.801471985276, 20141.697874531856, 20345.186192552315, 20626.587468250626, 20643.174273029097, 5449.972750136244, 5712.0, 5729.570282228829, 5962.761489540413, 5972.25346831646, 5674.546036317105, 5705.77176912923, 5706.258186435757, 5727.513161381287, 5730.68481233532, 5666.433356664342, 5979.372165922581, 5993.910091348612, 6000.979833428328, 6018.42824931633, 5776.0, 5910.202122713443, 5960.880782384372, 5963.344032156459, 5968.67172305523, 5793.826185214451, 5815.912761308584, 5818.0981947798155, 5823.301203855564, 5823.970880145572, 13476.932615336958, 13535.864641353657, 13562.254076025913, 13635.727285454235, 13693.246871422069, 2350.471143992605, 2388.617821148608, 2444.608862581996, 2484.5900426429616, 2510.259473455335, 9887.703368898945, 10054.64808731691, 10077.042680945298, 10346.12057975073, 10403.479826008745, 1948.756405449319, 2034.0541648133542, 2042.0, 2049.1803278688644, 2158.2554018863466, 63542.0, 74917.62541187313, 76458.61770691167, 79248.20751792466, 83171.5841420795, 11337.319760814213, 11574.189806713617, 11607.245529040585, 11794.469248883821, 11926.821097683369, 16353.427630032891, 16474.42339518111, 16527.752083718755, 16578.58553536147, 16610.916945415196, 8730.301575873915, 8755.212030917248, 8798.0, 8804.207621314112, 8812.339074569305, 8530.78673033179, 8561.22948934599, 8616.224539791448, 8650.740477785677, 8652.567371631394, 4968.22992436173, 5081.18701007837, 5119.897602047939, 5123.103456895028, 5167.9224811627855, 2074.5332300232326, 2097.4127244371603, 2122.225387733466, 2157.3959291398432, 2161.297578287063, 988.3081842710131, 1055.6991257491577, 1072.989270107289, 1093.4532733633184, 1110.8611423572054, 19019.71470427917, 19485.707714384294, 19664.41006769799, 19710.310139145062, 20277.797222027886, 1014.8680671512803, 1027.3014350241758, 1066.5467176449977, 1083.366230755017, 1125.3360517294836, 10883.0, 10972.177086718528, 11142.164337674707, 11189.776204475866, 11228.0, 198811.0, 198812.0, 199124.0, 199814.0, 200946.0, 94483.0, 99221.0, 100360.0, 100938.0, 101346.0, 1056.0548309263168, 1069.1072954083272, 1078.4014871746099, 1084.2139448899643, 1101.3226865477673, 17170.656586867943, 17321.13394330253, 17368.826311737226, 17496.300147993938, 17787.46637600874, 38035.239295214495, 39436.2112757749, 39578.802105989285, 39950.40074398944, 40057.599424006556, 54724.0, 56507.43492565022, 56550.43449565616, 57011.144832826714, 57142.7142864283, 8813.559322033745, 8864.778380540538, 8889.155530224618, 8997.865032024394, 9006.864897026418, 12955.287459189834, 13728.382222799799, 13730.794038089636, 13769.105008174436, 13900.096493727875, 11720.179587428798, 11738.119641026786, 11783.587574434854, 11993.513783210678, 12084.939575302418, 11482.827757583476, 11500.654980350602, 11741.882581174079, 11902.464389102339, 12067.81898271509, 12074.335911524951, 12138.33239171854, 12337.876621234032, 12363.443645036175, 12465.563705270271, 9098.727038188865, 9227.76930576741, 9489.715308540755, 12389.380530973596, 12794.488220471078, 12087.274763514217, 12303.446344914679, 12388.504459821866, 12607.306598137191, 13089.149205301625], "value": 9193.4263042517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.482118311549, 1608.7184742670038, 1813.782346118466, 1892.924283028679, 1910.0, 7609.0869095708595, 8328.50028998259, 8416.116307787679, 8529.019162796272, 8606.139386061392, 8151.347892168627, 8151.551664658441, 8212.712555060574, 8214.958925205365, 8224.958875205615, 2365.7989070928948, 2369.1707902234252, 2389.2951579284154, 2389.5579317826173, 2401.639754036891, 2363.1492662641435, 2383.344580240439, 2428.5871401861637, 2438.3538362333998, 2438.890249938757, 2403.1108489858775, 2407.903683852644, 2427.186892391051, 2428.453597940467, 2435.476372579895, 2407.7953373963232, 2420.0319872051145, 2445.0708730682404, 2445.7798798108165, 2451.7548245175517, 2390.8685022323766, 2402.759724027601, 2403.134871446278, 2404.326788499223, 2413.095089341497, 8324.750257492224, 8327.916720832774, 8375.664973401057, 8391.95804020976, 8393.244607985249, 5219.634625576211, 5338.985592737367, 5341.732913354317, 5366.087765079946, 5380.273663055476, 3510.929781404383, 3517.2262102337445, 3524.8061356625376, 3700.9074773130887, 3721.9627803721887, 1107.2802678259116, 1149.367847683779, 1174.0666170394472, 1194.4863708605296, 1198.7063169523435, 11961.40192990347, 12034.458449369798, 12045.457954392074, 12047.156699031071, 12053.216540924812, 4659.930101048487, 4662.137504561599, 4765.404324459442, 4824.372831531879, 4828.61371090312, 10235.7441063974, 10272.897271027343, 10332.586696532206, 10334.224933129895, 10344.32761870476, 5348.224507446398, 5392.811251606254, 5395.595330350239, 5411.729413529387, 5448.073827449343, 4231.661467082626, 4716.056788642285, 4784.736839473862, 4809.687370320918, 4981.078500477423, 4140.275451795924, 4142.937855932163, 4197.4753155855515, 4225.471816022997, 4305.9569404306185, 1290.4386591832583, 1323.4375390459015, 1342.5703774792169, 1347.723716638087, 1358.1240100135358, 983.5868935047155, 1045.4406892312577, 1066.6160182334354, 1077.5905156040653, 1079.4980334144504, 5917.615355001911, 5953.523718102541, 6073.423024812636, 6074.848128796815, 6203.4416902479, 486.48189677992826, 491.2778216022441, 501.65135231014096, 504.70222568684653, 509.77569869257405, 4118.238125946709, 4130.731502452331, 4198.391233271159, 4222.387753775747, 4224.471941007374, 10316.484175791331, 10609.204309676805, 10696.732581685521, 10760.139188865029, 10776.622818201482, 10483.318584291997, 10540.63107791239, 10547.156227501782, 10594.099501542301, 10619.84070238947, 7788.14330423653, 7986.720464783704, 8068.596570171468, 8249.917500824915, 8326.750197494084, 6021.397860214119, 6035.245594300713, 6129.84675383119, 6158.969205153946, 6284.340144284784, 9348.626054957998, 9395.530223488662, 9435.198008169382, 9462.526873656152, 9517.381370210915, 9547.283953703361, 9605.711828645151, 9687.564059617474, 9714.417134971924, 9805.0, 6992.1958974718555, 7634.312911837961, 7774.494657847222, 7951.204879512003, 8010.479318844256, 8514.78713032179, 8527.445716028438, 8547.102554231717, 8564.100769419121, 8591.012033616214, 7610.277023682741, 7711.845763084819, 7734.187910269566, 7775.57234352116, 7886.329661978567, 7685.423593230418, 7691.730789422567, 7699.615019248903, 7772.300492955661, 7789.805254868674, 7056.788296351117, 7078.964605176941, 7081.362677359062, 7118.359347658528, 7121.038659780863, 5056.241563765465, 5226.137687281708, 5308.495692909168, 5337.973310133424, 5375.865603359947, 5217.165253559412, 5266.710330931835, 5275.630705850707, 5318.282031925641, 5400.351957764936], "value": 4612.142865254957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.89203239028285, 365.19110170971294, 365.6836836136741, 367.72053239537945, 374.69836781390967, 6756.831079223022, 6783.050372947785, 6826.317368263171, 6848.5548439351405, 6870.725170993167, 6709.899351509719, 6723.562968407063, 6744.494162937787, 6745.3591908768585, 6759.594424334531, 4774.976125119379, 4911.214205727084, 4997.675151115184, 5010.974945125269, 5013.047520971004, 4966.453690094087, 4967.925481117786, 4996.000799840029, 5005.849824505271, 5010.248462730583, 4962.950370496285, 4979.0, 4979.825706100287, 4996.0, 5066.341375621182, 5054.797808087672, 5064.3922729272535, 5071.239314102877, 5071.290019397287, 5077.695338279678, 4458.77706114693, 4459.754713490756, 4465.352523884051, 4471.82112715491, 4473.060657261979, 6355.046742988542, 6491.67541622917, 6515.576487528343, 6520.18497687789, 6539.378759017885, 5882.411758824126, 5898.498627616657, 5914.792982245601, 5921.407859214087, 5922.437368449991, 7066.470014748915, 7088.822779430556, 7120.964395178043, 7130.429565634737, 7133.571985680824, 4859.878503037417, 4873.244647079709, 4876.049170411771, 4878.121938051149, 4878.902421951541, 7234.746783862593, 7338.15611204713, 7402.888956665654, 7405.666744996488, 7406.777796666109, 4845.878853028632, 4846.5638092571835, 4851.830185943546, 4852.660313778072, 4854.854354369375, 4846.830360937351, 4871.683340582851, 4892.2661600760175, 4904.362432883702, 4907.70553766768, 5757.798477053283, 5766.682832444256, 5767.538596912321, 5769.278840144982, 5774.04728219839, 7102.041224434738, 7107.751228707074, 7109.537880037781, 7111.830891578118, 7122.074130363019, 1757.8242175782575, 1783.0817129178483, 1786.5444311700694, 1786.7409225662466, 1789.7852257729155, 1083.918706097046, 1150.3328069719544, 1154.4170194052117, 1165.3823473559028, 1171.297221666993, 6877.552959057645, 6901.62041087745, 6939.7224111036, 6946.0, 6947.409470194989, 7216.747413840595, 7365.3739432147795, 7373.705051797868, 7384.26157384268, 7400.296971787671, 6922.653867306614, 6924.757633482905, 7049.647517624098, 7051.717931282691, 7056.682449289794, 3971.8808435746973, 4033.9394909076386, 4038.1721747042375, 4043.6158564936286, 4044.8584299549375, 7789.571573563395, 7790.649420776079, 7810.0237470316215, 7816.06207255133, 7838.843223135619, 7255.637218139177, 7439.590822504706, 7572.962135189288, 7573.848523029508, 7614.8096297593, 7740.8838867417035, 7777.261160189773, 7823.804404889809, 7828.138904720477, 7834.138244793068, 7434.702611895464, 7446.069241344832, 7452.366548843409, 7475.700971961278, 7489.251074892685, 7319.158296795937, 7349.081364829396, 7358.558486490828, 7359.77920662381, 7364.3372096511575, 7657.1959944205055, 7775.339096176662, 7795.259450352434, 7811.140774514685, 7816.64825082884, 4815.807367705393, 4838.298446725134, 4865.1242776300605, 4876.707397556158, 4884.48712885142, 7379.3358597726465, 7403.666834992546, 7424.368928641126, 7450.96274518624, 7459.589722565311, 7127.322904324288, 7174.210836808052, 7217.159624295771, 7219.205887352492, 7232.493725439169, 6978.337057979484, 7180.497365184387, 7181.748638797617, 7182.3894968928225, 7193.964030179815, 7028.683709232994, 7042.753503627348, 7063.328983746535, 7077.256888026889, 7089.255628158969, 7246.094238220223, 7259.419246460165, 7260.382867456326, 7260.4554658399775, 7275.527090739297, 6848.520603557703, 6964.477664175309, 7007.929920700728, 7022.54353467023, 7031.753888613874], "value": 5351.717626273113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.3895547816877, 875.1817051057266, 926.3746970794712, 937.9906200937988, 940.2055263302509, 13744.862551374483, 13818.447262109516, 17160.914195429006, 17246.482605521855, 17368.56578585536, 15558.144302063381, 15586.688266234669, 15728.685426291468, 15732.134732589731, 15857.444989425372, 893.4103491695482, 898.1333013641835, 908.4231512989267, 911.9088091190894, 912.2154946745793, 905.7237542549519, 914.0, 915.1031988651126, 920.3235621817959, 930.5998420679106, 954.6992697300362, 960.6925783749203, 961.3799099580766, 963.3016063354047, 971.3880255439063, 949.8575213717928, 956.956936937836, 959.3764053365298, 960.3757557587554, 961.8749562556858, 704.4646068987555, 704.68993642797, 705.3510770091528, 707.1478867964091, 714.949953503255, 15913.761293580606, 16029.0, 16070.5982350441, 16094.356225750957, 16102.5974350641, 14360.0, 14419.639509012253, 14488.0, 14509.129452232793, 14586.34361453737, 11912.702182445422, 12072.215306005082, 12123.878761212363, 12259.0, 12427.13010089294, 3999.8200080996426, 4042.171354872244, 4067.89830254246, 4070.7761073140964, 4185.351270553069, 59206.11190832141, 59327.0, 59494.40505594932, 59733.402665973656, 60232.69883650597, 10839.891601084046, 10906.5092070857, 11204.0, 11293.71765705864, 11554.248973816675, 20501.897490512452, 20554.97225138737, 20645.58708825845, 20720.792792071887, 20763.0, 8620.741377758677, 8683.088275731083, 8782.912170878337, 8853.15894989975, 9063.41087829289, 5040.722760248222, 5102.821401250939, 5151.8196863109615, 5230.764615592308, 5238.449962753933, 3451.8964431067106, 3480.6693364130365, 3483.7110269200557, 3483.8083905385447, 3501.6148223695373, 633.2274624957545, 650.8080116365684, 657.2179106862914, 663.8738639658546, 666.8999650052434, 706.7702996526046, 804.3846457460048, 805.79049447143, 807.8182408958055, 832.1304237072274, 9408.341416100808, 10256.28206025586, 10279.640212592523, 10302.896971030345, 10325.793484130276, 723.7105157936762, 738.7525179065074, 752.6688257166829, 785.1363500149789, 789.2305002622512, 4692.554207350365, 4706.411698537683, 4727.7399743013775, 4731.668783185213, 4860.854174374775, 63279.36720632735, 66541.0, 66642.66678666575, 66704.0, 67344.0, 58518.707406462694, 59381.70309148427, 59735.40264597299, 60033.0, 60588.69705651532, 53102.734486327325, 53815.0, 54371.72814135904, 54913.176302355496, 54978.45021549813, 10131.392116473035, 10211.948940255252, 10441.738956526147, 10567.46771718112, 10603.310784798963, 39111.80444097761, 39679.60320396875, 40005.599944001355, 40553.797231013654, 41067.383989240785, 47197.7640111811, 48618.75690621524, 53402.0, 53624.19563706625, 54053.45946540484, 12742.171758835646, 12798.16811907223, 13014.21914685122, 13086.803697944348, 13144.27706476153, 14297.0, 14306.284685765879, 14347.85652143507, 14362.640933976734, 14385.280735962951, 13319.800202996768, 13368.598942031755, 13390.531331403354, 13415.32923353848, 13424.0, 12979.221246725227, 12998.155119917175, 13071.0, 13227.66930826737, 13815.447382104603, 12992.285424301754, 13132.606021819362, 13385.933070334586, 13427.07691083731, 13517.391717372939, 11185.944070279596, 11439.428028598702, 11516.769664606829, 11592.942035289769, 11628.418579070843, 11304.547818087512, 11657.358845263252, 11733.413329333669, 11814.173007889709, 12046.337451440255], "value": 7350.606594885835, "unit": "score"}], "name": "dromaeo_css", "value": 7576.6339638965055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 104.0, 109.0, 111.0, 110.0, 100.0, 110.0, 111.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 161.0, 178.0, 128.0, 158.0, 167.0, 139.0, 179.0, 133.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 162.0, 161.0, 161.0, 160.0, 163.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 76.0, 161.0, 75.0, 76.0, 76.0, 76.0, 168.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 152.0, 93.0, 92.0, 94.0, 138.0, 92.0, 93.0, 148.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 119.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 100.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 55.0, 57.0, 56.0, 56.0, 81.0, 54.0, 60.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 57.0, 58.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 73.0, 72.0, 73.0, 73.0, 74.0, 73.0, 75.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 126.0, 117.0, 116.0, 112.0, 109.0, 119.0, 113.0, 128.0, 124.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 165.0, 159.0, 164.0, 160.0, 155.0, 157.0, 155.0, 155.0, 163.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 63.0, 66.0, 68.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1519.9, "alertThreshold": 2.0}]} 08:11:55 INFO - Return code: 0 08:11:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:11:55 ERROR - # TBPL SUCCESS # 08:11:55 INFO - Running post-action listener: _resource_record_post_action 08:11:55 INFO - Running post-run listener: _resource_record_post_run 08:11:56 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8069120; Write bytes: 387366912; Read time: 2048; Write time: 418464 08:11:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13692928; Read time: 0; Write time: 47460 08:11:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6332416; Write bytes: 373673984; Read time: 1980; Write time: 371004 08:11:56 INFO - Running post-run listener: _upload_blobber_files 08:11:56 INFO - Blob upload gear active. 08:11:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:11:56 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:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:11:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:58 INFO - (blobuploader) - INFO - Done attempting. 08:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:58 INFO - (blobuploader) - INFO - Done attempting. 08:11:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:11:58 INFO - Return code: 0 08:11:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:11:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:11:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bdb28174c60b16f4105afc7208d34551bb9a6c599c1585c90224204ee173096584e5f3a208cbeca5352f9ec4c148ef5f0ce24fc2f67d8f3d36b8834854527b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d90137e55dacd3c1da0c46dd3e7ce788b9f56500af8d068a46d206d04bb5bcea169841f1c67289a1b2f2036177b276ffa0b15dbcfa324f2d29b0acc5c4e6ebc"} 08:11:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:11:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:11:58 INFO - Contents: 08:11:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bdb28174c60b16f4105afc7208d34551bb9a6c599c1585c90224204ee173096584e5f3a208cbeca5352f9ec4c148ef5f0ce24fc2f67d8f3d36b8834854527b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d90137e55dacd3c1da0c46dd3e7ce788b9f56500af8d068a46d206d04bb5bcea169841f1c67289a1b2f2036177b276ffa0b15dbcfa324f2d29b0acc5c4e6ebc"} 08:11:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:11:58 INFO - Copying logs to upload dir... 08:11:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:11:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.988989 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-01 08:11:59.072858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:11:59.076949) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bdb28174c60b16f4105afc7208d34551bb9a6c599c1585c90224204ee173096584e5f3a208cbeca5352f9ec4c148ef5f0ce24fc2f67d8f3d36b8834854527b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d90137e55dacd3c1da0c46dd3e7ce788b9f56500af8d068a46d206d04bb5bcea169841f1c67289a1b2f2036177b276ffa0b15dbcfa324f2d29b0acc5c4e6ebc"} build_url:https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bdb28174c60b16f4105afc7208d34551bb9a6c599c1585c90224204ee173096584e5f3a208cbeca5352f9ec4c148ef5f0ce24fc2f67d8f3d36b8834854527b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d90137e55dacd3c1da0c46dd3e7ce788b9f56500af8d068a46d206d04bb5bcea169841f1c67289a1b2f2036177b276ffa0b15dbcfa324f2d29b0acc5c4e6ebc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:11:59.106592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:11:59.106922) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464792681.705876-948367465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:11:59.156351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:11:59.156705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:11:59.156989) ========= ========= Total master_lag: 0.39 =========