builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1460826368.38 results: success (0) buildid: 20160416073105 builduid: be9a84cc86d3423a957c553fa4961fb8 revision: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.383617) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.384693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.385191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.466894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.467223) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 10:06:09-- 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.8M=0s 2016-04-16 10:06:09 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.597675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.597965) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.652645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.652967) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 --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=e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 10:06:09,635 truncating revision to first 12 chars 2016-04-16 10:06:09,636 Setting DEBUG logging. 2016-04-16 10:06:09,636 attempt 1/10 2016-04-16 10:06:09,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1da1937a9e03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 10:06:09,887 unpacking tar archive at: mozilla-central-1da1937a9e03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.206538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.207011) ========= script_repo_revision: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.207422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.207697) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.219187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-16 10:06:09.219463) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:10 INFO - MultiFileLogger online at 20160416 10:06:10 in /builds/slave/test 10:06:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:06:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:10 INFO - {'append_to_log': False, 10:06:10 INFO - 'base_work_dir': '/builds/slave/test', 10:06:10 INFO - 'blob_upload_branch': 'Firefox', 10:06:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:10 INFO - 'branch': 'Firefox', 10:06:10 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:10 INFO - 'config_files': ('talos/linux_config.py',), 10:06:10 INFO - 'default_actions': ('clobber', 10:06:10 INFO - 'read-buildbot-config', 10:06:10 INFO - 'download-and-extract', 10:06:10 INFO - 'populate-webroot', 10:06:10 INFO - 'create-virtualenv', 10:06:10 INFO - 'install', 10:06:10 INFO - 'run-tests'), 10:06:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:10 INFO - 'download_minidump_stackwalk': True, 10:06:10 INFO - 'download_symbols': 'ondemand', 10:06:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:10 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:10 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:10 INFO - 'installer_path': 'installer.exe', 10:06:10 INFO - 'log_level': 'info', 10:06:10 INFO - 'log_name': 'talos', 10:06:10 INFO - 'log_to_console': True, 10:06:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:10 INFO - 'opt_config_files': (), 10:06:10 INFO - 'pip_index': False, 10:06:10 INFO - 'sps_profile': False, 10:06:10 INFO - 'sps_profile_interval': 0, 10:06:10 INFO - 'suite': 'dromaeojs-e10s', 10:06:10 INFO - 'system_bits': '32', 10:06:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:10 INFO - 'title': 'talos-linux64-ix-006', 10:06:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:10 INFO - 'use_talos_json': True, 10:06:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:10 INFO - 'work_dir': 'build'} 10:06:10 INFO - ##### 10:06:10 INFO - ##### Running clobber step. 10:06:10 INFO - ##### 10:06:10 INFO - Running pre-action listener: _resource_record_pre_action 10:06:10 INFO - Running main action method: clobber 10:06:10 INFO - rmtree: /builds/slave/test/build 10:06:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:11 INFO - Running post-action listener: _resource_record_post_action 10:06:11 INFO - ##### 10:06:11 INFO - ##### Running read-buildbot-config step. 10:06:11 INFO - ##### 10:06:11 INFO - Running pre-action listener: _resource_record_pre_action 10:06:11 INFO - Running main action method: read_buildbot_config 10:06:11 INFO - Using buildbot properties: 10:06:11 INFO - { 10:06:11 INFO - "project": "", 10:06:11 INFO - "product": "firefox", 10:06:11 INFO - "script_repo_revision": "production", 10:06:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:06:11 INFO - "repository": "", 10:06:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:06:11 INFO - "buildid": "20160416073105", 10:06:11 INFO - "pgo_build": "True", 10:06:11 INFO - "basedir": "/builds/slave/test", 10:06:11 INFO - "buildnumber": 182, 10:06:11 INFO - "slavename": "talos-linux64-ix-006", 10:06:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:06:11 INFO - "platform": "ubuntu64_hw", 10:06:11 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:06:11 INFO - "branch": "mozilla-central", 10:06:11 INFO - "repo_path": "mozilla-central", 10:06:11 INFO - "revision": "1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3", 10:06:11 INFO - "stage_platform": "linux64-pgo", 10:06:11 INFO - "builduid": "be9a84cc86d3423a957c553fa4961fb8", 10:06:11 INFO - "slavebuilddir": "test" 10:06:11 INFO - } 10:06:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:06:11 INFO - Running post-action listener: _resource_record_post_action 10:06:11 INFO - ##### 10:06:11 INFO - ##### Running download-and-extract step. 10:06:11 INFO - ##### 10:06:11 INFO - Running pre-action listener: _resource_record_pre_action 10:06:11 INFO - Running main action method: download_and_extract 10:06:11 INFO - mkdir: /builds/slave/test/build/tests 10:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:11 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:06:14 INFO - Downloaded 1361 bytes. 10:06:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:14 INFO - Using the following test package requirements: 10:06:14 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:06:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'jsshell-linux-x86_64.zip'], 10:06:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:06:14 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:06:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06:14 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')]} 10:06:14 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:17 INFO - Downloaded 23775092 bytes. 10:06:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:18 INFO - Return code: 0 10:06:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:18 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:20 INFO - Downloaded 23775092 bytes. 10:06:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:21 INFO - Return code: 0 10:06: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')]} 10:06:21 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:06:23 INFO - Downloaded 10841076 bytes. 10:06:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:06:23 INFO - Return code: 0 10:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:23 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:06:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:06:25 INFO - Downloaded 58235741 bytes. 10:06:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:25 INFO - mkdir: /builds/slave/test/properties 10:06:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:25 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:25 INFO - Contents: 10:06:25 INFO - build_url:https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:26 INFO - Running post-action listener: _resource_record_post_action 10:06:26 INFO - Running post-action listener: set_extra_try_arguments 10:06:26 INFO - ##### 10:06:26 INFO - ##### Running populate-webroot step. 10:06:26 INFO - ##### 10:06:26 INFO - Running pre-action listener: _resource_record_pre_action 10:06:26 INFO - Running main action method: populate_webroot 10:06:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:26 INFO - '--tppagecycles', 10:06:26 INFO - '7'], 10:06:26 INFO - 'tests': ['tsvgm']}}, 10:06:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['damp', 'tps']}, 10:06:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'tests': ['damp', 'tps']}, 10:06:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['dromaeo_dom']}, 10:06:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['a11yr', 10:06:26 INFO - 'ts_paint', 10:06:26 INFO - 'tpaint', 10:06:26 INFO - 'sessionrestore', 10:06:26 INFO - 'sessionrestore_no_auto_restore', 10:06:26 INFO - 'tabpaint']}, 10:06:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:26 INFO - 'ts_paint', 10:06:26 INFO - 'tpaint', 10:06:26 INFO - 'sessionrestore', 10:06:26 INFO - 'sessionrestore_no_auto_restore', 10:06:26 INFO - 'tabpaint']}, 10:06:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:26 INFO - 'ts_paint', 10:06:26 INFO - 'tpaint', 10:06:26 INFO - 'sessionrestore', 10:06:26 INFO - 'sessionrestore_no_auto_restore', 10:06:26 INFO - 'tabpaint']}, 10:06:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:26 INFO - 'ts_paint', 10:06:26 INFO - 'tpaint', 10:06:26 INFO - 'sessionrestore', 10:06:26 INFO - 'sessionrestore_no_auto_restore', 10:06:26 INFO - 'tabpaint']}, 10:06:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['a11yr', 10:06:26 INFO - 'ts_paint', 10:06:26 INFO - 'tpaint', 10:06:26 INFO - 'sessionrestore', 10:06:26 INFO - 'sessionrestore_no_auto_restore', 10:06:26 INFO - 'tabpaint']}, 10:06:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['a11yr', 10:06:26 INFO - 'ts_paint', 10:06:26 INFO - 'tpaint', 10:06:26 INFO - 'sessionrestore', 10:06:26 INFO - 'sessionrestore_no_auto_restore', 10:06:26 INFO - 'tabpaint']}, 10:06:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['tsvgx', 10:06:26 INFO - 'tsvgr_opacity', 10:06:26 INFO - 'tart', 10:06:26 INFO - 'tscrollx', 10:06:26 INFO - 'cart']}, 10:06:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:26 INFO - 'tsvgr_opacity', 10:06:26 INFO - 'tart', 10:06:26 INFO - 'tscrollx', 10:06:26 INFO - 'cart']}, 10:06:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'talos_options': ['--disable-e10s'], 10:06:26 INFO - 'tests': ['tp5o']}, 10:06:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'tests': ['tp5o']}, 10:06:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'talos_options': ['--disable-e10s', 10:06:26 INFO - '--xperf_path', 10:06:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:26 INFO - 'tests': ['tp5n']}, 10:06:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:26 INFO - 'talos_options': ['--xperf_path', 10:06:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:26 INFO - 'tests': ['tp5n']}}, 10:06:26 INFO - 'talos.zip': {'path': '', 10:06:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:26 INFO - Running post-action listener: _resource_record_post_action 10:06:26 INFO - ##### 10:06:26 INFO - ##### Running create-virtualenv step. 10:06:26 INFO - ##### 10:06:26 INFO - Running pre-action listener: _resource_record_pre_action 10:06:26 INFO - Running main action method: create_virtualenv 10:06:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:26 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 10:06:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:26 INFO - Using real prefix '/usr' 10:06:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:28 INFO - Installing pip.................done. 10:06:28 INFO - Return code: 0 10:06:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:28 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:28 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 10:06:28 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 10:06:28 INFO - Using env: {'DISPLAY': ':0', 10:06:28 INFO - 'HOME': '/home/cltbld', 10:06:28 INFO - 'LANG': 'en_US.UTF-8', 10:06:28 INFO - 'LANGUAGE': 'en_US:en', 10:06:28 INFO - 'LOGNAME': 'cltbld', 10:06:28 INFO - 'MAIL': '/var/mail/cltbld', 10:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:28 INFO - 'MOZ_NO_REMOTE': '1', 10:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:28 INFO - 'NO_EM_RESTART': '1', 10:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:28 INFO - 'PWD': '/builds/slave/test', 10:06:28 INFO - 'SHELL': '/bin/bash', 10:06:28 INFO - 'SHLVL': '1', 10:06:28 INFO - 'TERM': 'linux', 10:06:28 INFO - 'TMOUT': '86400', 10:06:28 INFO - 'USER': 'cltbld', 10:06:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:28 INFO - '_': '/tools/buildbot/bin/python'} 10:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:28 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 10:06:28 INFO - Cleaning up... 10:06:28 INFO - Return code: 0 10:06:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:28 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:28 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 10:06:28 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 10:06:28 INFO - Using env: {'DISPLAY': ':0', 10:06:28 INFO - 'HOME': '/home/cltbld', 10:06:28 INFO - 'LANG': 'en_US.UTF-8', 10:06:28 INFO - 'LANGUAGE': 'en_US:en', 10:06:28 INFO - 'LOGNAME': 'cltbld', 10:06:28 INFO - 'MAIL': '/var/mail/cltbld', 10:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:28 INFO - 'MOZ_NO_REMOTE': '1', 10:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:28 INFO - 'NO_EM_RESTART': '1', 10:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:28 INFO - 'PWD': '/builds/slave/test', 10:06:28 INFO - 'SHELL': '/bin/bash', 10:06:28 INFO - 'SHLVL': '1', 10:06:28 INFO - 'TERM': 'linux', 10:06:28 INFO - 'TMOUT': '86400', 10:06:28 INFO - 'USER': 'cltbld', 10:06:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:28 INFO - '_': '/tools/buildbot/bin/python'} 10:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:29 INFO - Downloading/unpacking psutil>=0.7.1 10:06:29 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 10:06:29 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 10:06:29 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 10:06:29 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 10:06:29 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 10:06:29 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 10:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:31 INFO - Installing collected packages: psutil 10:06:31 INFO - Running setup.py install for psutil 10:06:31 INFO - building 'psutil._psutil_linux' extension 10:06:31 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 10:06:31 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 10:06:31 INFO - building 'psutil._psutil_posix' extension 10:06:31 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 10:06:31 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 10:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:31 INFO - Successfully installed psutil 10:06:31 INFO - Cleaning up... 10:06:31 INFO - Return code: 0 10:06:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:31 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:31 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 10:06:31 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 10:06:31 INFO - Using env: {'DISPLAY': ':0', 10:06:31 INFO - 'HOME': '/home/cltbld', 10:06:31 INFO - 'LANG': 'en_US.UTF-8', 10:06:31 INFO - 'LANGUAGE': 'en_US:en', 10:06:31 INFO - 'LOGNAME': 'cltbld', 10:06:31 INFO - 'MAIL': '/var/mail/cltbld', 10:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:31 INFO - 'MOZ_NO_REMOTE': '1', 10:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:31 INFO - 'NO_EM_RESTART': '1', 10:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:31 INFO - 'PWD': '/builds/slave/test', 10:06:31 INFO - 'SHELL': '/bin/bash', 10:06:31 INFO - 'SHLVL': '1', 10:06:31 INFO - 'TERM': 'linux', 10:06:31 INFO - 'TMOUT': '86400', 10:06:31 INFO - 'USER': 'cltbld', 10:06:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:31 INFO - '_': '/tools/buildbot/bin/python'} 10:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:06:31 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 10:06:31 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 10:06:31 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 10:06:31 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 10:06:31 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 10:06:31 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 10:06:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:06:33 INFO - Installing collected packages: mozsystemmonitor 10:06:33 INFO - Running setup.py install for mozsystemmonitor 10:06:33 INFO - Successfully installed mozsystemmonitor 10:06:33 INFO - Cleaning up... 10:06:33 INFO - Return code: 0 10:06:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:33 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')]} 10:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:33 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')]} 10:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:33 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:33 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 10:06:33 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 10:06:33 INFO - Using env: {'DISPLAY': ':0', 10:06:33 INFO - 'HOME': '/home/cltbld', 10:06:33 INFO - 'LANG': 'en_US.UTF-8', 10:06:33 INFO - 'LANGUAGE': 'en_US:en', 10:06:33 INFO - 'LOGNAME': 'cltbld', 10:06:33 INFO - 'MAIL': '/var/mail/cltbld', 10:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:33 INFO - 'MOZ_NO_REMOTE': '1', 10:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:33 INFO - 'NO_EM_RESTART': '1', 10:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:33 INFO - 'PWD': '/builds/slave/test', 10:06:33 INFO - 'SHELL': '/bin/bash', 10:06:33 INFO - 'SHLVL': '1', 10:06:33 INFO - 'TERM': 'linux', 10:06:33 INFO - 'TMOUT': '86400', 10:06:33 INFO - 'USER': 'cltbld', 10:06:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:33 INFO - '_': '/tools/buildbot/bin/python'} 10:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 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 10:06:36 INFO - Downloading docopt-0.6.1.tar.gz 10:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:36 INFO - Running setup.py install for blobuploader 10:06:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:36 INFO - Running setup.py install for requests 10:06:37 INFO - Running setup.py install for docopt 10:06:37 INFO - Successfully installed blobuploader requests docopt 10:06:37 INFO - Cleaning up... 10:06:37 INFO - Return code: 0 10:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:37 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:37 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 10:06:37 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 10:06:37 INFO - Using env: {'DISPLAY': ':0', 10:06:37 INFO - 'HOME': '/home/cltbld', 10:06:37 INFO - 'LANG': 'en_US.UTF-8', 10:06:37 INFO - 'LANGUAGE': 'en_US:en', 10:06:37 INFO - 'LOGNAME': 'cltbld', 10:06:37 INFO - 'MAIL': '/var/mail/cltbld', 10:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:37 INFO - 'MOZ_NO_REMOTE': '1', 10:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:37 INFO - 'NO_EM_RESTART': '1', 10:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:37 INFO - 'PWD': '/builds/slave/test', 10:06:37 INFO - 'SHELL': '/bin/bash', 10:06:37 INFO - 'SHLVL': '1', 10:06:37 INFO - 'TERM': 'linux', 10:06:37 INFO - 'TMOUT': '86400', 10:06:37 INFO - 'USER': 'cltbld', 10:06:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:37 INFO - '_': '/tools/buildbot/bin/python'} 10:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:37 INFO - Running setup.py (path:/tmp/pip-5GW8iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:37 INFO - Running setup.py (path:/tmp/pip-f_u5Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:37 INFO - Running setup.py (path:/tmp/pip-7TttFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:37 INFO - Running setup.py (path:/tmp/pip-zgwcdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:37 INFO - Running setup.py (path:/tmp/pip-4gOxOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:37 INFO - Running setup.py (path:/tmp/pip-3dcHCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:38 INFO - Running setup.py (path:/tmp/pip-MJzWJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:38 INFO - Running setup.py (path:/tmp/pip-_nkl0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:38 INFO - Running setup.py (path:/tmp/pip-yiiaL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:38 INFO - Running setup.py (path:/tmp/pip-MAdK8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:38 INFO - Running setup.py (path:/tmp/pip-Ubxa2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:38 INFO - Running setup.py (path:/tmp/pip-ltBaDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:38 INFO - Running setup.py (path:/tmp/pip-VSv6r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:38 INFO - Running setup.py (path:/tmp/pip-vA6CqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:38 INFO - Running setup.py (path:/tmp/pip-b8xqya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:38 INFO - Running setup.py (path:/tmp/pip-VdtXJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:38 INFO - Running setup.py (path:/tmp/pip-0QvKe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:38 INFO - Running setup.py install for manifestparser 10:06:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:38 INFO - Running setup.py install for mozcrash 10:06:39 INFO - Running setup.py install for mozdebug 10:06:39 INFO - Running setup.py install for mozdevice 10:06:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Running setup.py install for mozfile 10:06:39 INFO - Running setup.py install for mozhttpd 10:06:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Running setup.py install for mozinfo 10:06:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Running setup.py install for mozInstall 10:06:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Running setup.py install for mozleak 10:06:39 INFO - Running setup.py install for mozlog 10:06:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Running setup.py install for moznetwork 10:06:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:39 INFO - Running setup.py install for mozprocess 10:06:40 INFO - Running setup.py install for mozprofile 10:06:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:40 INFO - Running setup.py install for mozrunner 10:06:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:40 INFO - Running setup.py install for mozscreenshot 10:06:40 INFO - Running setup.py install for moztest 10:06:40 INFO - Running setup.py install for mozversion 10:06:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:40 INFO - Cleaning up... 10:06:40 INFO - Return code: 0 10:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:40 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:40 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 10:06:40 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 10:06:40 INFO - Using env: {'DISPLAY': ':0', 10:06:40 INFO - 'HOME': '/home/cltbld', 10:06:40 INFO - 'LANG': 'en_US.UTF-8', 10:06:40 INFO - 'LANGUAGE': 'en_US:en', 10:06:40 INFO - 'LOGNAME': 'cltbld', 10:06:40 INFO - 'MAIL': '/var/mail/cltbld', 10:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:40 INFO - 'MOZ_NO_REMOTE': '1', 10:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:40 INFO - 'NO_EM_RESTART': '1', 10:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:40 INFO - 'PWD': '/builds/slave/test', 10:06:40 INFO - 'SHELL': '/bin/bash', 10:06:40 INFO - 'SHLVL': '1', 10:06:40 INFO - 'TERM': 'linux', 10:06:40 INFO - 'TMOUT': '86400', 10:06:40 INFO - 'USER': 'cltbld', 10:06:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:40 INFO - '_': '/tools/buildbot/bin/python'} 10:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:40 INFO - Running setup.py (path:/tmp/pip-2JLHEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:40 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)) 10:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:40 INFO - Running setup.py (path:/tmp/pip-UNaBvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:40 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)) 10:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:40 INFO - Running setup.py (path:/tmp/pip-GE8xtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:41 INFO - Running setup.py (path:/tmp/pip-zeppwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:41 INFO - Running setup.py (path:/tmp/pip-Kq62u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:41 INFO - Running setup.py (path:/tmp/pip-CTtK4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:41 INFO - Running setup.py (path:/tmp/pip-fEPy_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:41 INFO - Running setup.py (path:/tmp/pip-6tdeZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:41 INFO - Running setup.py (path:/tmp/pip-lh6deZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:41 INFO - Running setup.py (path:/tmp/pip-pCP5Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:41 INFO - Running setup.py (path:/tmp/pip-LKUP2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:41 INFO - Running setup.py (path:/tmp/pip-PsQq5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:41 INFO - Running setup.py (path:/tmp/pip-iz_lGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:41 INFO - Running setup.py (path:/tmp/pip-Ud5kKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:41 INFO - Running setup.py (path:/tmp/pip-KLE2Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:41 INFO - Running setup.py (path:/tmp/pip-DkWQMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:41 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)) 10:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:41 INFO - Running setup.py (path:/tmp/pip-V7OZZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:42 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)) 10:06:42 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)) 10:06:42 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)) 10:06:42 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)) 10:06:42 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)) 10:06:42 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)) 10:06:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:43 INFO - Downloading blessings-1.6.tar.gz 10:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:43 INFO - Installing collected packages: blessings 10:06:43 INFO - Running setup.py install for blessings 10:06:44 INFO - Successfully installed blessings 10:06:44 INFO - Cleaning up... 10:06:44 INFO - Return code: 0 10:06:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:44 INFO - Reading from file tmpfile_stdout 10:06:44 INFO - Current package versions: 10:06:44 INFO - argparse == 1.2.1 10:06:44 INFO - blessings == 1.6 10:06:44 INFO - blobuploader == 1.2.4 10:06:44 INFO - docopt == 0.6.1 10:06:44 INFO - manifestparser == 1.1 10:06:44 INFO - mozInstall == 1.12 10:06:44 INFO - mozcrash == 0.17 10:06:44 INFO - mozdebug == 0.1 10:06:44 INFO - mozdevice == 0.48 10:06:44 INFO - mozfile == 1.2 10:06:44 INFO - mozhttpd == 0.7 10:06:44 INFO - mozinfo == 0.9 10:06:44 INFO - mozleak == 0.1 10:06:44 INFO - mozlog == 3.1 10:06:44 INFO - moznetwork == 0.27 10:06:44 INFO - mozprocess == 0.22 10:06:44 INFO - mozprofile == 0.28 10:06:44 INFO - mozrunner == 6.11 10:06:44 INFO - mozscreenshot == 0.1 10:06:44 INFO - mozsystemmonitor == 0.0 10:06:44 INFO - moztest == 0.7 10:06:44 INFO - mozversion == 1.4 10:06:44 INFO - psutil == 3.1.1 10:06:44 INFO - requests == 1.2.3 10:06:44 INFO - wsgiref == 0.1.2 10:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:44 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:44 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 10:06:44 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 10:06:44 INFO - Using env: {'DISPLAY': ':0', 10:06:44 INFO - 'HOME': '/home/cltbld', 10:06:44 INFO - 'LANG': 'en_US.UTF-8', 10:06:44 INFO - 'LANGUAGE': 'en_US:en', 10:06:44 INFO - 'LOGNAME': 'cltbld', 10:06:44 INFO - 'MAIL': '/var/mail/cltbld', 10:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:44 INFO - 'MOZ_NO_REMOTE': '1', 10:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:44 INFO - 'NO_EM_RESTART': '1', 10:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:44 INFO - 'PWD': '/builds/slave/test', 10:06:44 INFO - 'SHELL': '/bin/bash', 10:06:44 INFO - 'SHLVL': '1', 10:06:44 INFO - 'TERM': 'linux', 10:06:44 INFO - 'TMOUT': '86400', 10:06:44 INFO - 'USER': 'cltbld', 10:06:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:44 INFO - '_': '/tools/buildbot/bin/python'} 10:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 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)) 10:06:44 INFO - Cleaning up... 10:06:44 INFO - Return code: 0 10:06:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:44 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:44 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 10:06:44 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 10:06:44 INFO - Using env: {'DISPLAY': ':0', 10:06:44 INFO - 'HOME': '/home/cltbld', 10:06:44 INFO - 'LANG': 'en_US.UTF-8', 10:06:44 INFO - 'LANGUAGE': 'en_US:en', 10:06:44 INFO - 'LOGNAME': 'cltbld', 10:06:44 INFO - 'MAIL': '/var/mail/cltbld', 10:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:44 INFO - 'MOZ_NO_REMOTE': '1', 10:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:44 INFO - 'NO_EM_RESTART': '1', 10:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:44 INFO - 'PWD': '/builds/slave/test', 10:06:44 INFO - 'SHELL': '/bin/bash', 10:06:44 INFO - 'SHLVL': '1', 10:06:44 INFO - 'TERM': 'linux', 10:06:44 INFO - 'TMOUT': '86400', 10:06:44 INFO - 'USER': 'cltbld', 10:06:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:44 INFO - '_': '/tools/buildbot/bin/python'} 10:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:44 INFO - Downloading/unpacking jsonschema 10:06:44 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 10:06:44 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 10:06:44 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 10:06:44 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 10:06:44 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 10:06:44 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 10:06:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:46 INFO - Downloading/unpacking functools32 (from jsonschema) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:46 INFO - warning: no files found matching '*.txt' 10:06:46 INFO - no previously-included directories found matching 'build' 10:06:46 INFO - no previously-included directories found matching 'dist' 10:06:46 INFO - no previously-included directories found matching '.git*' 10:06:46 INFO - Installing collected packages: jsonschema, functools32 10:06:47 INFO - Running setup.py install for functools32 10:06:47 INFO - warning: no files found matching '*.txt' 10:06:47 INFO - no previously-included directories found matching 'build' 10:06:47 INFO - no previously-included directories found matching 'dist' 10:06:47 INFO - no previously-included directories found matching '.git*' 10:06:47 INFO - Successfully installed jsonschema functools32 10:06:47 INFO - Cleaning up... 10:06:47 INFO - Return code: 0 10:06:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:06:47 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')]} 10:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:47 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')]} 10:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:47 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 0x7f6f95b26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', '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 10:06:47 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 10:06:47 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 10:06:47 INFO - Using env: {'DISPLAY': ':0', 10:06:47 INFO - 'HOME': '/home/cltbld', 10:06:47 INFO - 'LANG': 'en_US.UTF-8', 10:06:47 INFO - 'LANGUAGE': 'en_US:en', 10:06:47 INFO - 'LOGNAME': 'cltbld', 10:06:47 INFO - 'MAIL': '/var/mail/cltbld', 10:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:47 INFO - 'MOZ_NO_REMOTE': '1', 10:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:47 INFO - 'NO_EM_RESTART': '1', 10:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:47 INFO - 'PWD': '/builds/slave/test', 10:06:47 INFO - 'SHELL': '/bin/bash', 10:06:47 INFO - 'SHLVL': '1', 10:06:47 INFO - 'TERM': 'linux', 10:06:47 INFO - 'TMOUT': '86400', 10:06:47 INFO - 'USER': 'cltbld', 10:06:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:47 INFO - '_': '/tools/buildbot/bin/python'} 10:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:47 INFO - Downloading/unpacking flake8 10:06:47 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 10:06:47 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 10:06:47 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 10:06:47 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 10:06:47 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 10:06:47 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 10:06:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:06:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:06:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 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 10:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:49 INFO - no previously-included directories found matching 'docs/_build' 10:06:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:06:50 INFO - Running setup.py install for pep8 10:06:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:50 INFO - no previously-included directories found matching 'docs/_build' 10:06:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:06:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:06:50 INFO - Cleaning up... 10:06:50 INFO - Return code: 0 10:06:50 INFO - Running post-action listener: _resource_record_post_action 10:06:50 INFO - Running post-action listener: _start_resource_monitoring 10:06:50 INFO - Starting resource monitoring. 10:06:50 INFO - ##### 10:06:50 INFO - ##### Running install step. 10:06:50 INFO - ##### 10:06:50 INFO - Running pre-action listener: _resource_record_pre_action 10:06:50 INFO - Running main action method: install 10:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:50 INFO - Reading from file tmpfile_stdout 10:06:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:50 INFO - Reading from file tmpfile_stdout 10:06:50 INFO - Output received: 10:06:50 INFO - Usage: mozinstall [options] installer 10:06:50 INFO - Options: 10:06:50 INFO - -h, --help show this help message and exit 10:06:50 INFO - -d DEST, --destination=DEST 10:06:50 INFO - Directory to install application into. [default: 10:06:50 INFO - "/builds/slave/test"] 10:06:50 INFO - --app=APP Application being installed. [default: firefox] 10:06:50 INFO - mkdir: /builds/slave/test/build/application 10:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:07:07 INFO - Reading from file tmpfile_stdout 10:07:07 INFO - Output received: 10:07:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:07 INFO - Running post-action listener: _resource_record_post_action 10:07:07 INFO - ##### 10:07:07 INFO - ##### Running run-tests step. 10:07:07 INFO - ##### 10:07:07 INFO - Running pre-action listener: _resource_record_pre_action 10:07:07 INFO - Running main action method: run_tests 10:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:07 INFO - Python 2.7.3 10:07:07 INFO - Return code: 0 10:07:07 INFO - grabbing minidump binary from tooltool 10:07:07 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')]} 10:07:07 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 0xdd9410>, '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 0xdda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdda7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:07 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 10:07:07 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 10:07:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:07 INFO - Return code: 0 10:07:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:08 INFO - Return code: 0 10:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 10:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 10:07:08 INFO - Using env: {'DISPLAY': ':0', 10:07:08 INFO - 'HOME': '/home/cltbld', 10:07:08 INFO - 'LANG': 'en_US.UTF-8', 10:07:08 INFO - 'LANGUAGE': 'en_US:en', 10:07:08 INFO - 'LOGNAME': 'cltbld', 10:07:08 INFO - 'MAIL': '/var/mail/cltbld', 10:07:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:08 INFO - 'MOZ_NO_REMOTE': '1', 10:07:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:08 INFO - 'NO_EM_RESTART': '1', 10:07:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:08 INFO - 'PWD': '/builds/slave/test', 10:07:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:08 INFO - 'SHELL': '/bin/bash', 10:07:08 INFO - 'SHLVL': '1', 10:07:08 INFO - 'TERM': 'linux', 10:07:08 INFO - 'TMOUT': '86400', 10:07:08 INFO - 'USER': 'cltbld', 10:07:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032', 10:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:08 INFO - '_': '/tools/buildbot/bin/python'} 10:07:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 10:07:08 INFO - mozversion application_buildid: 20160416073105 10:07:08 INFO - mozversion application_changeset: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 10:07:08 INFO - mozversion application_display_name: Nightly 10:07:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:08 INFO - mozversion application_name: Firefox 10:07:08 INFO - mozversion application_remotingname: firefox 10:07:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:07:08 INFO - mozversion application_vendor: Mozilla 10:07:08 INFO - mozversion application_version: 48.0a1 10:07:08 INFO - mozversion platform_buildid: 20160416073105 10:07:08 INFO - mozversion platform_changeset: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 10:07:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:07:08 INFO - mozversion platform_version: 48.0a1 10:07:08 INFO - using testdate: 1460826428 10:07:08 INFO - actual date: 1460826428 10:07:08 INFO - starting webserver on 'localhost:44838' 10:07:08 INFO - SUITE-START | Running 2 tests 10:07:08 INFO - TEST-START | dromaeo_css 10:07:08 INFO - operating with platform_type : linux_ 10:07:08 INFO - Initialising browser for dromaeo_css test... 10:07:08 INFO - TEST-INFO | started process 23029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBP7NEA/profile http://localhost:44838/getInfo.html) 10:07:11 INFO - PROCESS | 23029 | 10:07:11 INFO - PROCESS | 23029 | (process:23098): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:12 INFO - PROCESS | 23029 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:07:12 INFO - PROCESS | 23029 | __metrics Screen width/height:1600/1200 10:07:12 INFO - PROCESS | 23029 | colorDepth:24 10:07:12 INFO - PROCESS | 23029 | Browser inner width/height: 1024/697 10:07:12 INFO - PROCESS | 23029 | __metrics 10:07:13 ERROR - PROCESS | 23029 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:07:14 INFO - TEST-INFO | 23029: exit 0 10:07:14 INFO - Browser initialized. 10:07:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:14 INFO - TEST-INFO | started process 23149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBP7NEA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:15 INFO - PROCESS | 23149 | 10:07:15 INFO - PROCESS | 23149 | (process:23207): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:25 INFO - PROCESS | 23149 | RSS: Main: 163807232 10:07:25 INFO - PROCESS | 23149 | 10:08:15 INFO - PROCESS | 23149 | 1460826495460 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] 10:10:22 INFO - PROCESS | 23149 | Cycle 1(1): loaded http://localhost:44838/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44838/tests/dromaeo/cssquery-ext.html) 10:10:23 INFO - PROCESS | 23149 | RSS: Main: 166526976 10:10:23 INFO - PROCESS | 23149 | 10:13:25 INFO - PROCESS | 23149 | Cycle 1(1): loaded http://localhost:44838/tests/dromaeo/cssquery-ext.html (next: http://localhost:44838/tests/dromaeo/cssquery-jquery.html) 10:13:26 INFO - PROCESS | 23149 | RSS: Main: 165851136 10:13:26 INFO - PROCESS | 23149 | 10:16:28 INFO - PROCESS | 23149 | Cycle 1(1): loaded http://localhost:44838/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44838/tests/dromaeo/cssquery-mootools.html) 10:16:28 INFO - PROCESS | 23149 | RSS: Main: 166555648 10:16:28 INFO - PROCESS | 23149 | 10:19:30 INFO - PROCESS | 23149 | Cycle 1(1): loaded http://localhost:44838/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44838/tests/dromaeo/cssquery-prototype.html) 10:19:31 INFO - PROCESS | 23149 | RSS: Main: 164024320 10:19:31 INFO - PROCESS | 23149 | 10:22:33 INFO - PROCESS | 23149 | Cycle 1(1): loaded http://localhost:44838/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44838/tests/dromaeo/cssquery-yui.html) 10:22:34 INFO - PROCESS | 23149 | RSS: Main: 165117952 10:22:34 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | Cycle 1(1): loaded http://localhost:44838/tests/dromaeo/cssquery-yui.html (next: http://localhost:44838/tests/dromaeo/cssquery-dojo.html) 10:25:36 INFO - PROCESS | 23149 | RSS: Main: 167481344 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | __start_tp_report 10:25:36 INFO - PROCESS | 23149 | _x_x_mozilla_page_load 10:25:36 INFO - PROCESS | 23149 | _x_x_mozilla_page_load_details 10:25:36 INFO - PROCESS | 23149 | |i|pagename|runs| 10:25:36 INFO - PROCESS | 23149 | |0;dojo.html;3070.3398769264604;3111.3777244551097;3126.327839514505;3154.258749193939;3155.8422078896065;5363.731813409328;5366.980273747985;5400.216968539559;5411.621186516935;5417.458254174586;5308;5371.4897084776885;5409.56723462123;5431.592630552715;5455.263539422177;4916.188828843246;4940.308356830046;4983.925241121368;5007.106700246861;5054.6461747677495;713.3333251256089;4865.14859899518;4867.610591152717;4878.951210487903;4907.1412502812045;4817.566419022305;4822.348982887318;4829.9275510867365;4831.347768051321;4884.560389564938;4806.206975848981;4876.804927802884;4920.6309526785635;4934.309196712427;4984.925226121611;4813.566778989908;4843.128236917353;4857.878553036167;4860.1251774680895;4897.4857639948;5288.497592728685;5297.099493086184;5314.9468505314835;5323.334583177103;5399.595030372699;5755.079187330007;5783.884322313572;5785.681787501686;5788.594798364116;5831.591788574801;5729.512991395694;5748.5975981681295;5767.769289228426;5795.652260864362;5819.185314056035;5413.323334583177;5415.675059496442;5416.404195538527;5417.945820541823;5427.213054107172;5802;5915.349311575723;5920.082387229986;5983.910241346383;6009.549283803733;5574.777008919597;5590;5595.63628364155;5602.551795856321;5605.5515558755205;5678.346990096192;5688.345840228344;5691.658500489983;5694.971525142348;5699.230603868425;5605.411431799684;5716.657000579979;5752.3097228332035;5795.88408231833;5829.125631155361;5706.115552089433;5762.394948530344;5769.423057694197;5831.1544826000845;5914.733836977261;4397.538258482878;4406.471223453206;4406.779661017001;4414.492333381702;4415.735055896656;3823.1971286030243;3897.785621790829;3918.2555314490155;3935.2719746846924;3981.442598036277;5544.445555444504;5605.859853503695;5617;5619.241402410704;5648.378678345379;5764.279465066867;5847.298324201123;5854.385289544622;5858;5863.5309175265875;5486.725663716798;5511.807086751945;5592.440755924456;5596.440355964371;5618.91571626426;4981.501849815062;5025.572826309732;5026.045051440215;5026.958689992575;5034.823781167642;6032.577719559588;6044.879102417927;6045.969770151121;6056.364081771439;6070.3019152797115;5760.107183386582;5849.385814489502;5899.292084949833;5922.082077278029;5928.407159284037;6026.487748541423;6035;6045;6048.546359023179;6054.061620448838;5619.606627536034;5729.427057294404;5753.309602847517;5754.223179870832;5762.855928601818;5693.914591281217;5715.971420142872;5786.9131963019745;5815.273090863642;5843.94156058451;5517.613767036269;5537.640053396516;5541.030319694118;5550.888982220414;5572.414896435978;5481;5498.697571633598;5501.4223506532835;5516.062269414289;5655.066913959151;5491.643043202179;5528.585356098389;5552.056150454352;5585.5531557476115;5628.296462942132;5671.943280567141;5691;5696.8006119785605;5701.657900525982;5718.113692377522;5504.201890725903;5558.416366281483;5590.580706446952;5608.990381731328;5630.408807075198 10:25:36 INFO - PROCESS | 23149 | |1;ext.html;608.4189598933019;643.6170478565252;661.1042038038455;663.4692246203036;681.696644992978;35805.64194358056;36768.632313676855;36854.44718329227;36865.078373040684;36946.261074778486;39546;40109.59616413426;40590.7970460148;40626;40667.99999999993;8448.32413406926;8643.567821608895;8668.783280417976;8672.479651220947;8682;8433.536155511445;8539.658413663446;8551.187637174458;8699.347548933823;8761.7809554761;8752.474851508898;8839.77900552488;8847.159519845636;8856.291496680282;8872.20150186483;8713.433626814269;8762.518061506646;8769.342299327576;8787.25308348791;8804.20762131408;8545.658173673046;8691;8699.913000869974;8705.7823554411;8773;38382.424263636065;38768.80615596904;38775.418368724495;38951.61048389536;39010.80494597509;3602.35157671619;3764.7176461765202;3809.942850857239;3822.5986271441375;4217.472815898012;29904;30217.09348719542;30637.38725225483;30740.2314942126;31658.841705791325;3674.65090816372;3772;3860.3823388258024;3874.8256328465286;3897.7271590988644;266682;267445;267474;267884;268454;34790.30419391598;35507.112322191635;35728.821355893575;35811;53505.7324713374;33617.49573756396;33770.32459350799;33833.661663383544;33950.15124621855;33975.830120849234;14453.638659033608;14602;14617.488387906373;14630.853691463162;14641.34113964874;12252.20360676571;12261.632151035483;12366.44351004207;12438.25370477756;12687.809682854764;8334.166583341617;8334.66661333552;8376.246137847624;8410.873836892451;8425.70510032146;3210.967890321067;3267.330197309546;3306.189983454069;3316.2704205074847;3342.9665703343144;1058.0794708603564;1081.7457897394106;1097.4457898761075;1124.9268797528298;1164.714644912002;30359.241018974262;30368;31117.533237001462;33046;35540.64459355425;1095.5289225632896;1142.9198858078219;1149.6836122639531;1155.6764106050318;1235.2650173146963;15183.848161518243;15190;15225.771613425808;15247.23763811805;15322.616934576501;404355;409877;412325;412430;413718;54986.72506637441;56195.43804561984;56445.43554564402;56519.15221271684;56762.43237567654;1341.2958196946681;1416.922069286199;1416.985830141706;1433.7275917575628;1437.3172742947017;28317.433651327272;28404.715952840208;28780.280492987844;29155.416891661625;29453.85273073621;45457.318140228585;45906.311405329616;46303.76848115738;46402.76798615985;46412.767936160104;313670;314217;314534;314990;316646;26724.331891702863;26813.793379298368;27066.864665676545;27225.455490889675;27276.181714548595;45356.31965520454;45967;46825.76587117043;47818;49637.75181124071;35589.64410355863;35907.46138807868;36007.63992360043;36034.63965360418;36330.27339453143;36360.27279454449;38138.42792358172;38457.23085538329;38559.61440385672;38876.416853746654;36984.445233320985;40104.79947600243;41822;42551.7872410636;43300.35049474197;31126.688733113286;33761.66238337585;33959.151021223675;34437.65562344345;34458.655413445544;26715.19854404371;26886.193414197605;26985.1904442867;27188.456230874875;27460.17619471419 10:25:36 INFO - PROCESS | 23149 | |2;jquery.html;376.4409851370714;382.34618801848836;385.22954091816365;391.3112921258584;392.63877232945686;17030.74453883191;17576.209070591824;17958.730619040725;17981.82018179818;18031.72952405715;16704.58238544037;17150.571235719115;17220.483385498454;17377.826221737778;17915.64168716628;5494.478024587658;5643.153526970967;5669.09294512878;5687.516561092312;5709.714514274269;3953.782541960191;5878.382769809173;6059.394060593927;6097.817065488042;6112.69436528174;5122.6158038147105;6014.488768454687;6017.06735456005;6031.276246850384;6034.96982515089;5414.187871819219;5456.508914197721;5457.481539253765;5457.863553411176;5471.206675032118;5037.370328708911;5502.367227768817;5529.198266251411;5530.225768392428;5540.2243685884005;12899;13101.08292419531;13136;13268.867311326956;13841.930790345983;2303.686898467857;2371.6205407134776;2375.643653451979;2444.792192663608;2473.2209354053416;9477.763055923588;9618.807623847553;9840.11438970496;9875.259355548362;9955.601775929026;1845.4371416717895;1872.4195499395096;1880.8119188081218;1916.3867562380044;1985.3944546913185;70040.29959700389;72601;73163;73264.63367683181;74622;10335.534900929477;10426.322289051188;10599.62901298451;10676.145908327315;10766.192535559707;14713.190774507504;14746.63133421673;14797.186154761592;14817;14822.851771482146;7554.735584254525;7727.768166955;7779.533228006338;7890.487118337404;7975.920240797634;7291.671874765649;7376.7786966391095;7427.145878223965;7439.702411903463;7642.777155655069;4479.283314669638;4609.700369475973;4614.508165590611;4688.601468875184;4708.552687494751;1795.2729144696418;1809.0281593063623;1915.3200613782185;1921.7693876734882;1926.5568919148393;905.7192270396198;977.53567055648;993.3989936088707;995.0447570332417;1037.3516552154904;17554.736678949826;18379.72430413545;18719.438416847242;18801.341953031577;18845.717314240297;1004.3672486333563;1024.846273059047;1034.849946757716;1049.192122066005;1059.2267644619317;10193.286469947032;10481.737956551147;10534.104601108991;10537.84193237102;10548.736281592868;402319;403625;404831;406150;433779;85023;85441.14558854456;86338;87091;89265.55367223252;1029.5161274201114;1054.6466933577337;1071.6999240212754;1085.4409978860892;1093.0162853431975;15943.521694349189;16245.268962896935;16285.430009949594;16340.264688088826;16397;34514.482282765275;34530.48204276988;34796;35537.1115722109;36291.274174515835;50104.498955009985;50187.74906125446;50415.74792126162;50526.747366262935;50770.74614626903;8099.757007289791;8346.916530834615;8561.657533698582;8584.442011269248;8792.208701216921;10587.523561439599;12030.578929737418;12050.276983381025;12465.563705270271;12872.420741066488;11093.389863557582;11366.261193022427;11455.312681239153;11497.367644779617;11525;11271.943640281746;11298.435078246219;11317.943410282896;11601.941990289995;11768.705782355168;8767.991680956771;11780.352080635304;11809.763804724029;11909.880901190878;11977.041836652872;7784.260495252942;7786.33816125613;8083.83832323362;8208.958955205186;8253.174682531699;10149.949250253701;10707.785844282915;10961.725956851142;11078.889211108108;11329 10:25:36 INFO - PROCESS | 23149 | |3;mootools.html;1509.622594351412;1514.9318280677371;1682.4279744886735;1794.27331930568;1818.4544636609005;7654.464187506876;8181.754547363581;8262.83474330513;8430.156984301575;8540.743777686665;8333.833323333529;8397.790055248623;8411.747647570583;8424.578771061453;8439.32485401168;2309.538092381522;2353.2940117964627;2371.27676058802;2375.406148462884;2381.4641705616186;2291.1980806717597;2305.2162264829954;2320.5706944215376;2332.6617640442128;2344.296710986706;2280.5552917181158;2302.4243939015246;2321.025169428844;2387.4986252886915;2412.2763171048705;2292.060255295321;2299.4366380236784;2301.7007788987494;2309.9653505197434;2310.3761984264156;2256.638937769949;2258.299927022612;2259.1641092795608;2261.6607508873635;2263.773622637723;8426.452280601803;8477.491350518927;8542.316614670812;8563.143685631449;8591.785205369853;5020.7740651670765;5178.223266510016;5191.532762051434;5199.038177937094;5203.479652034766;3527.876524321662;3529.0824385659657;3545.592256890465;3551.4317709166667;3577.624349443323;1145.5188820695328;1148.6381789736206;1155.1682788392345;1156.5200441816637;1164.5268735050167;11330.999999999918;11333.43332833355;11350.943245283803;11384.772304553862;11386.886131138666;4331.5884990925815;4379.255526560492;4500.797464114123;4510.24100600766;4614.377059097046;8843.336749743796;8899.33255005877;8904.8664270036;8943.195112439911;9011.098890111067;5179.637425380187;5181.171012637959;5185.48145185486;5198.714070726146;5204.9219261711105;4384.539623339567;4811.398575178103;4878.731669758126;4931.408231012301;4947.233178857283;3623.239119784822;3655.2324011957785;3738.2523495301048;3752.493413389212;3760.5675347335405;1146.163300790411;1153.5847095045776;1155.4973586489905;1164.336328292882;1165.6794381545144;898.1916275352105;940.9905900940903;944.976375590602;947.8199142163105;980.9362391444533;5568.6658800472105;5632.577556683265;5639.210510528529;5752.9712351437975;5800.738966746507;835.340081335738;858.1375717403969;934.1219253901311;972.4214092614883;988.560090759605;3783.7162212834146;3816.5229346331707;3851.326017946848;3855.36386496225;3865.072382628205;10136.239782016231;10487.213458990605;10495.107915827088;10558.947205263925;10646.574137034431;10443;10668.466576671135;10758.946205268923;10765.730856728487;10776.461176941122;8027.876097346376;8034.638441270157;8122.147174546706;8218.342532597379;8290.129536398832;5651.8304450866535;5662.943370566406;5734.741936612946;5755.482006619424;5776.826695199151;9816.2147028239;9875.703728888146;9912.702618921443;9932.702018939442;10058.943810899751;9768.902310976799;9844.507774611098;10010.401580642123;10173.898261017592;10202.693919182437;6911.343422374866;6938.757143499954;6974.68613912365;7049.259827718221;7058;8088.514689118671;8124;8140.308073813792;8169.183081691784;8184.7953801155445;7237.674304656198;7593.202713714981;7600.50596711212;7610.543367397974;7621.390288776774;7334.3032411920785;7424.257574242532;7433.219511951167;7466.701331946661;7524.435667324863;6812.93187068123;6824.283450237852;6839;6910;6912.55068420551;4740.336352910526;4878.804847806048;4974.776135073858;5013.774380152829;5018.824341148043;4935.679180853233;5047.823326183566;5080.872978175576;5088.363954505687;5137.691738495702 10:25:36 INFO - PROCESS | 23149 | |4;prototype.html;332.1000089756759;332.39172314664165;332.44979558830147;338.6207447658623;341.47072038340576;5958.255218097738;5996.700164991755;6007.819765407039;6009.549283803722;6027.638341699496;5882.823515294537;5906.645601263916;5911.349751527328;5925.703714814264;5931.110333449974;4285.121550082234;4403.229434848905;4505.391772110772;4507.887302817439;4552.521985191557;4475.597196252336;4498.370228168059;4509.481409637884;4515.458145022585;4536.7504787236685;4459.598636122749;4464.799084041209;4489.887752806173;4516.119356725423;4521.118381915528;4310.482742070956;4460.241758900995;4481.473711551356;4499.302608095718;4514.638828893697;3914.3345631242755;3936.783476908769;3961.742486738353;3968.226195891802;3983.980080099581;5664.745086471119;5690.260266165414;5692.117721753135;5698.287714035746;5718.142278658193;5100.209467532502;5197.506236907526;5214.165733482662;5215.869603259911;5248.895022099537;6132.877342453126;6142.1093941378695;6175.536834737412;6195.49082621539;6205.472534834545;4305.98809279819;4364.781760911942;4376.803043863034;4390.934135987963;4396.780160991938;6435.935640643627;6519.8696026079215;6521.413072823421;6524.543281970264;6525.249596296392;4514.548545145525;4515.254982927846;4521.276595744665;4533.569310915458;4534.433195850519;4508.661850361236;4529.411176547028;4590.770461476913;4598.816047358068;4606.032733126014;5206.193040078794;5215.843524694265;5235.554977826851;5251.947480525146;5257.921131183035;6163.630182189083;6220.502359811204;6236.594621349598;6251.562390632703;6314.778982735582;1561.4769052367585;1566.1229711361445;1577.6608029273762;1588.5313832419463;1589.8092228932371;988.2637435110745;1012.3470361616716;1017.8269694151863;1020.7703266764919;1067.3649178738792;5916.171735956969;5985.431384018511;5995.670238136857;6008.639481631116;6042.274927008699;6257.186565746424;6349.936500635027;6361.141245931833;6361.522885783585;6366.204224471941;5981.192539007266;5983.700814959322;6006.5495087868585;6007.609505382136;6015.578909476295;3401.1837159081642;3402.66917161745;3425.9657403426145;3437.553118094682;3440.8107554084263;6450.290468048511;6625.503087268474;6871.244163142051;6889.689963951634;6904.4821638377325;6711.966440167866;6724.462043036546;6725.66371681414;6745.392914637706;6752.932470675329;6697.689297192461;6773;6851.931480685129;6861.897071543931;6876.862462750717;6512.544121911421;6515.902261466176;6540;6571.408573228432;6593.966775283232;6377.8616050935225;6430.228372595318;6455.354464553507;6481.384268494486;6487.448566871869;6788.321167883172;6826;6859.828504287433;6869.519133660596;6872.793816185523;4360.302351623725;4378.408914796589;4385.605295523418;4391.604755571886;4409.096135292321;6403.167588213502;6572.112764776694;6579.572327798678;6594.604323740591;6609.570377925419;6273.905891411724;6342.492600592034;6352.745890164341;6356.364363563606;6382.106505089384;6231.264239178347;6267.1539342188225;6331.240251169889;6367.439977205614;6411.8717625646295;6092.39076092405;6212.9068063979985;6236.002239641635;6292.559520833681;6294.402031806971;6338.302786693368;6410.166678331787;6414.679266036586;6427.58220715652;6435.420812126931;6055.455009049207;6201.503879689704;6223.439890409885;6238.033104868752;6248.125262463168 10:25:36 INFO - PROCESS | 23149 | |5;yui.html;672.3578982072122;750.2010358967702;789.6762327445747;796.6388388716101;798.8921495598092;12524.686882827922;12628.747425051493;12745.490180392784;12848.35758212088;12858.549950751725;13096.279704616243;13133.868661313383;13154.736905261889;13164.6708832279;13211;797.0913158998746;815.6003558256441;829.5105887526358;829.8174401631632;842.4945032980194;829.9626516806758;831.0941074229089;831.9209675080857;832.6045128563914;835.3609488741118;864.822711344173;868.3400615532178;868.5917618719192;870.6473878079388;873.6898401067625;859.8538248497708;864.1056506515757;865.709987154304;866.9003064647583;867.9479231246082;630.8517498387876;634.8920683483773;638.1034646321925;638.2946843737695;640.8333833203401;14161.858381416157;14216.573502794829;14233;14275.286235688278;14307.356168972421;12715.936420317932;12729.427175777113;12755.553555625509;12759.489620415265;12971.805422918664;11344.376059316734;11511.827322590168;11518.324607329807;11553.19127661064;11697.23967942081;3699.5005674233903;3767.171222331083;3774.490443790108;3812.0850995761093;3861.7296789224765;51876.74061629705;52139.21791173097;52328;52413;52733.209001865005;10056.094951454405;10165.695029149138;10186.337888037255;10239.18086553074;10350.53422595985;17929.910350448165;18084.095795210185;18146.364877229233;18146.63706725858;18183.909080454512;7878.165912759274;7905.960470197612;7943.086545047278;7948.403869709795;7973.9202607973175;4466.196084704784;4488.775561221926;4504.707194032443;4534.433195850519;4628.3288923105965;3269.54226408303;3378.8986330410125;3413.112590726429;3428.365752335826;3432.553768010143;579.73622001989;588.0972706894896;589.548995018811;591.5622439394817;592.7391947543067;680.9931900681029;720.8846584546552;753.1865585168006;783.9725609603637;788.1409263902259;9211.539423028822;9473.90526094744;9706.417614943126;9707.854382184272;9723.173530250007;666.8966310221923;685.0546246180239;705.6295444891371;729.5185177782638;736.3777607921298;4251.574842515785;4375.124975005012;4395.120975804852;4423.413637288026;4465.397171381886;59345.40654593485;60979.39020609737;61002.38997610056;61071.38928610746;61198;49568.75215623899;50589.49410505922;51062.23406648903;51279.487205128215;51376.74311628418;45261.77369113133;45765.99999999933;47104;47323.5267647326;48103.278450823265;8988.280937525113;9041.954790226007;9156.404833685789;9222.216111630318;9277.907220927704;28962.565561516174;29838.701612983594;29974.85012574923;30521.847390762905;30615;37899.81050094732;42108.157836843704;43093;44184.779076104416;44275.33586996133;11827.704307392383;11919.3444360561;12103.213291136048;12147.878521214674;12424.937875310565;12973.675658108245;13153.276569788371;13216.273104979318;13484.797728033891;13831.100978436369;12258.754824903273;12408.441620127296;12778.488860445477;12842.229466232056;13031.739365212832;11988.820167697317;12237.87762122403;12240.387980601112;12309.076819238771;12360.4437800301;11190;12332.630021099381;12366.62900112998;12445.62663120108;12517.624471265877;10631.255812093388;10932.890671093188;11123.777524449304;11390.943045284721;11477;10838.729031774268;10917.83623245636;10957.50691218913;11011.394373309546;11090.889091108986 10:25:36 INFO - PROCESS | 23149 | __end_tp_report 10:25:36 INFO - PROCESS | 23149 | __start_cc_report 10:25:36 INFO - PROCESS | 23149 | _x_x_mozilla_cycle_collect,344 10:25:36 INFO - PROCESS | 23149 | __end_cc_report 10:25:36 INFO - PROCESS | 23149 | __startTimestamp1460827536363__endTimestamp 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | ------- Summary: start ------- 10:25:36 INFO - PROCESS | 23149 | Number of tests: 6 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | [#0] dojo.html Cycles:165 Average:5342.23 Median:5585.55 stddev:716.33 (12.8%) stddev-sans-first:696.00 10:25:36 INFO - PROCESS | 23149 | Values: 3070.3 3111.4 3126.3 3154.3 3155.8 5363.7 5367.0 5400.2 5411.6 5417.5 5308.0 5371.5 5409.6 5431.6 5455.3 4916.2 4940.3 4983.9 5007.1 5054.6 713.3 4865.1 4867.6 4879.0 4907.1 4817.6 4822.3 4829.9 4831.3 4884.6 4806.2 4876.8 4920.6 4934.3 4984.9 4813.6 4843.1 4857.9 4860.1 4897.5 5288.5 5297.1 5314.9 5323.3 5399.6 5755.1 5783.9 5785.7 5788.6 5831.6 5729.5 5748.6 5767.8 5795.7 5819.2 5413.3 5415.7 5416.4 5417.9 5427.2 5802.0 5915.3 5920.1 5983.9 6009.5 5574.8 5590.0 5595.6 5602.6 5605.6 5678.3 5688.3 5691.7 5695.0 5699.2 5605.4 5716.7 5752.3 5795.9 5829.1 5706.1 5762.4 5769.4 5831.2 5914.7 4397.5 4406.5 4406.8 4414.5 4415.7 3823.2 3897.8 3918.3 3935.3 3981.4 5544.4 5605.9 5617.0 5619.2 5648.4 5764.3 5847.3 5854.4 5858.0 5863.5 5486.7 5511.8 5592.4 5596.4 5618.9 4981.5 5025.6 5026.0 5027.0 5034.8 6032.6 6044.9 6046.0 6056.4 6070.3 5760.1 5849.4 5899.3 5922.1 5928.4 6026.5 6035.0 6045.0 6048.5 6054.1 5619.6 5729.4 5753.3 5754.2 5762.9 5693.9 5716.0 5786.9 5815.3 5843.9 5517.6 5537.6 5541.0 5550.9 5572.4 5481.0 5498.7 5501.4 5516.1 5655.1 5491.6 5528.6 5552.1 5585.6 5628.3 5671.9 5691.0 5696.8 5701.7 5718.1 5504.2 5558.4 5590.6 5609.0 5630.4 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | [#1] ext.html Cycles:180 Average:48180.80 Median:36345.27 stddev:88643.88 (243.9%) stddev-sans-first:88820.58 10:25:36 INFO - PROCESS | 23149 | Values: 608.4 643.6 661.1 663.5 681.7 35805.6 36768.6 36854.4 36865.1 36946.3 39546.0 40109.6 40590.8 40626.0 40668.0 8448.3 8643.6 8668.8 8672.5 8682.0 8433.5 8539.7 8551.2 8699.3 8761.8 8752.5 8839.8 8847.2 8856.3 8872.2 8713.4 8762.5 8769.3 8787.3 8804.2 8545.7 8691.0 8699.9 8705.8 8773.0 38382.4 38768.8 38775.4 38951.6 39010.8 3602.4 3764.7 3809.9 3822.6 4217.5 29904.0 30217.1 30637.4 30740.2 31658.8 3674.7 3772.0 3860.4 3874.8 3897.7 266682.0 267445.0 267474.0 267884.0 268454.0 34790.3 35507.1 35728.8 35811.0 53505.7 33617.5 33770.3 33833.7 33950.2 33975.8 14453.6 14602.0 14617.5 14630.9 14641.3 12252.2 12261.6 12366.4 12438.3 12687.8 8334.2 8334.7 8376.2 8410.9 8425.7 3211.0 3267.3 3306.2 3316.3 3343.0 1058.1 1081.7 1097.4 1124.9 1164.7 30359.2 30368.0 31117.5 33046.0 35540.6 1095.5 1142.9 1149.7 1155.7 1235.3 15183.8 15190.0 15225.8 15247.2 15322.6 404355.0 409877.0 412325.0 412430.0 413718.0 54986.7 56195.4 56445.4 56519.2 56762.4 1341.3 1416.9 1417.0 1433.7 1437.3 28317.4 28404.7 28780.3 29155.4 29453.9 45457.3 45906.3 46303.8 46402.8 46412.8 313670.0 314217.0 314534.0 314990.0 316646.0 26724.3 26813.8 27066.9 27225.5 27276.2 45356.3 45967.0 46825.8 47818.0 49637.8 35589.6 35907.5 36007.6 36034.6 36330.3 36360.3 38138.4 38457.2 38559.6 38876.4 36984.4 40104.8 41822.0 42551.8 43300.4 31126.7 33761.7 33959.2 34437.7 34458.7 26715.2 26886.2 26985.2 27188.5 27460.2 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | [#2] jquery.html Cycles:180 Average:25401.04 Median:34522.48 stddev:67833.82 (196.5%) stddev-sans-first:67998.09 10:25:36 INFO - PROCESS | 23149 | Values: 376.4 382.3 385.2 391.3 392.6 17030.7 17576.2 17958.7 17981.8 18031.7 16704.6 17150.6 17220.5 17377.8 17915.6 5494.5 5643.2 5669.1 5687.5 5709.7 3953.8 5878.4 6059.4 6097.8 6112.7 5122.6 6014.5 6017.1 6031.3 6035.0 5414.2 5456.5 5457.5 5457.9 5471.2 5037.4 5502.4 5529.2 5530.2 5540.2 12899.0 13101.1 13136.0 13268.9 13841.9 2303.7 2371.6 2375.6 2444.8 2473.2 9477.8 9618.8 9840.1 9875.3 9955.6 1845.4 1872.4 1880.8 1916.4 1985.4 70040.3 72601.0 73163.0 73264.6 74622.0 10335.5 10426.3 10599.6 10676.1 10766.2 14713.2 14746.6 14797.2 14817.0 14822.9 7554.7 7727.8 7779.5 7890.5 7975.9 7291.7 7376.8 7427.1 7439.7 7642.8 4479.3 4609.7 4614.5 4688.6 4708.6 1795.3 1809.0 1915.3 1921.8 1926.6 905.7 977.5 993.4 995.0 1037.4 17554.7 18379.7 18719.4 18801.3 18845.7 1004.4 1024.8 1034.8 1049.2 1059.2 10193.3 10481.7 10534.1 10537.8 10548.7 402319.0 403625.0 404831.0 406150.0 433779.0 85023.0 85441.1 86338.0 87091.0 89265.6 1029.5 1054.6 1071.7 1085.4 1093.0 15943.5 16245.3 16285.4 16340.3 16397.0 34514.5 34530.5 34796.0 35537.1 36291.3 50104.5 50187.7 50415.7 50526.7 50770.7 8099.8 8346.9 8561.7 8584.4 8792.2 10587.5 12030.6 12050.3 12465.6 12872.4 11093.4 11366.3 11455.3 11497.4 11525.0 11271.9 11298.4 11317.9 11601.9 11768.7 8768.0 11780.4 11809.8 11909.9 11977.0 7784.3 7786.3 8083.8 8209.0 8253.2 10149.9 10707.8 10961.7 11078.9 11329.0 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | [#3] mootools.html Cycles:180 Average:5585.08 Median:5034.30 stddev:3105.60 (61.7%) stddev-sans-first:3099.21 10:25:36 INFO - PROCESS | 23149 | Values: 1509.6 1514.9 1682.4 1794.3 1818.5 7654.5 8181.8 8262.8 8430.2 8540.7 8333.8 8397.8 8411.7 8424.6 8439.3 2309.5 2353.3 2371.3 2375.4 2381.5 2291.2 2305.2 2320.6 2332.7 2344.3 2280.6 2302.4 2321.0 2387.5 2412.3 2292.1 2299.4 2301.7 2310.0 2310.4 2256.6 2258.3 2259.2 2261.7 2263.8 8426.5 8477.5 8542.3 8563.1 8591.8 5020.8 5178.2 5191.5 5199.0 5203.5 3527.9 3529.1 3545.6 3551.4 3577.6 1145.5 1148.6 1155.2 1156.5 1164.5 11331.0 11333.4 11350.9 11384.8 11386.9 4331.6 4379.3 4500.8 4510.2 4614.4 8843.3 8899.3 8904.9 8943.2 9011.1 5179.6 5181.2 5185.5 5198.7 5204.9 4384.5 4811.4 4878.7 4931.4 4947.2 3623.2 3655.2 3738.3 3752.5 3760.6 1146.2 1153.6 1155.5 1164.3 1165.7 898.2 941.0 945.0 947.8 980.9 5568.7 5632.6 5639.2 5753.0 5800.7 835.3 858.1 934.1 972.4 988.6 3783.7 3816.5 3851.3 3855.4 3865.1 10136.2 10487.2 10495.1 10558.9 10646.6 10443.0 10668.5 10758.9 10765.7 10776.5 8027.9 8034.6 8122.1 8218.3 8290.1 5651.8 5662.9 5734.7 5755.5 5776.8 9816.2 9875.7 9912.7 9932.7 10058.9 9768.9 9844.5 10010.4 10173.9 10202.7 6911.3 6938.8 6974.7 7049.3 7058.0 8088.5 8124.0 8140.3 8169.2 8184.8 7237.7 7593.2 7600.5 7610.5 7621.4 7334.3 7424.3 7433.2 7466.7 7524.4 6812.9 6824.3 6839.0 6910.0 6912.6 4740.3 4878.8 4974.8 5013.8 5018.8 4935.7 5047.8 5080.9 5088.4 5137.7 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | [#4] prototype.html Cycles:180 Average:5263.74 Median:6001.62 stddev:1604.84 (26.7%) stddev-sans-first:1566.08 10:25:36 INFO - PROCESS | 23149 | Values: 332.1 332.4 332.4 338.6 341.5 5958.3 5996.7 6007.8 6009.5 6027.6 5882.8 5906.6 5911.3 5925.7 5931.1 4285.1 4403.2 4505.4 4507.9 4552.5 4475.6 4498.4 4509.5 4515.5 4536.8 4459.6 4464.8 4489.9 4516.1 4521.1 4310.5 4460.2 4481.5 4499.3 4514.6 3914.3 3936.8 3961.7 3968.2 3984.0 5664.7 5690.3 5692.1 5698.3 5718.1 5100.2 5197.5 5214.2 5215.9 5248.9 6132.9 6142.1 6175.5 6195.5 6205.5 4306.0 4364.8 4376.8 4390.9 4396.8 6435.9 6519.9 6521.4 6524.5 6525.2 4514.5 4515.3 4521.3 4533.6 4534.4 4508.7 4529.4 4590.8 4598.8 4606.0 5206.2 5215.8 5235.6 5251.9 5257.9 6163.6 6220.5 6236.6 6251.6 6314.8 1561.5 1566.1 1577.7 1588.5 1589.8 988.3 1012.3 1017.8 1020.8 1067.4 5916.2 5985.4 5995.7 6008.6 6042.3 6257.2 6349.9 6361.1 6361.5 6366.2 5981.2 5983.7 6006.5 6007.6 6015.6 3401.2 3402.7 3426.0 3437.6 3440.8 6450.3 6625.5 6871.2 6889.7 6904.5 6712.0 6724.5 6725.7 6745.4 6752.9 6697.7 6773.0 6851.9 6861.9 6876.9 6512.5 6515.9 6540.0 6571.4 6594.0 6377.9 6430.2 6455.4 6481.4 6487.4 6788.3 6826.0 6859.8 6869.5 6872.8 4360.3 4378.4 4385.6 4391.6 4409.1 6403.2 6572.1 6579.6 6594.6 6609.6 6273.9 6342.5 6352.7 6356.4 6382.1 6231.3 6267.2 6331.2 6367.4 6411.9 6092.4 6212.9 6236.0 6292.6 6294.4 6338.3 6410.2 6414.7 6427.6 6435.4 6055.5 6201.5 6223.4 6238.0 6248.1 10:25:36 INFO - PROCESS | 23149 | 10:25:36 INFO - PROCESS | 23149 | [#5] yui.html Cycles:180 Average:14155.69 Median:24289.95 stddev:16087.73 (66.2%) stddev-sans-first:16101.00 10:25:36 INFO - PROCESS | 23149 | Values: 672.4 750.2 789.7 796.6 798.9 12524.7 12628.7 12745.5 12848.4 12858.5 13096.3 13133.9 13154.7 13164.7 13211.0 797.1 815.6 829.5 829.8 842.5 830.0 831.1 831.9 832.6 835.4 864.8 868.3 868.6 870.6 873.7 859.9 864.1 865.7 866.9 867.9 630.9 634.9 638.1 638.3 640.8 14161.9 14216.6 14233.0 14275.3 14307.4 12715.9 12729.4 12755.6 12759.5 12971.8 11344.4 11511.8 11518.3 11553.2 11697.2 3699.5 3767.2 3774.5 3812.1 3861.7 51876.7 52139.2 52328.0 52413.0 52733.2 10056.1 10165.7 10186.3 10239.2 10350.5 17929.9 18084.1 18146.4 18146.6 18183.9 7878.2 7906.0 7943.1 7948.4 7973.9 4466.2 4488.8 4504.7 4534.4 4628.3 3269.5 3378.9 3413.1 3428.4 3432.6 579.7 588.1 589.5 591.6 592.7 681.0 720.9 753.2 784.0 788.1 9211.5 9473.9 9706.4 9707.9 9723.2 666.9 685.1 705.6 729.5 736.4 4251.6 4375.1 4395.1 4423.4 4465.4 59345.4 60979.4 61002.4 61071.4 61198.0 49568.8 50589.5 51062.2 51279.5 51376.7 45261.8 45766.0 47104.0 47323.5 48103.3 8988.3 9042.0 9156.4 9222.2 9277.9 28962.6 29838.7 29974.9 30521.8 30615.0 37899.8 42108.2 43093.0 44184.8 44275.3 11827.7 11919.3 12103.2 12147.9 12424.9 12973.7 13153.3 13216.3 13484.8 13831.1 12258.8 12408.4 12778.5 12842.2 13031.7 11988.8 12237.9 12240.4 12309.1 12360.4 11190.0 12332.6 12366.6 12445.6 12517.6 10631.3 10932.9 11123.8 11390.9 11477.0 10838.7 10917.8 10957.5 11011.4 11090.9 10:25:36 INFO - PROCESS | 23149 | -------- Summary: end -------- 10:25:36 INFO - PROCESS | 23149 | 10:25:37 INFO - TEST-INFO | 23149: exit 0 10:25:37 INFO - TEST-OK | dromaeo_css | took 1108737ms 10:25:37 INFO - TEST-START | kraken 10:25:37 INFO - operating with platform_type : linux_ 10:25:37 INFO - Initialising browser for kraken test... 10:25:37 INFO - TEST-INFO | started process 23382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0ymSY/profile http://localhost:44838/getInfo.html) 10:25:40 INFO - PROCESS | 23382 | 10:25:40 INFO - PROCESS | 23382 | (process:23450): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:25:40 INFO - PROCESS | 23382 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:25:41 INFO - PROCESS | 23382 | __metrics Screen width/height:1600/1200 10:25:41 INFO - PROCESS | 23382 | colorDepth:24 10:25:41 INFO - PROCESS | 23382 | Browser inner width/height: 1024/697 10:25:41 INFO - PROCESS | 23382 | __metrics 10:25:42 ERROR - PROCESS | 23382 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:25:43 INFO - TEST-INFO | 23382: exit 0 10:25:43 INFO - Browser initialized. 10:25:43 INFO - Running cycle 1/1 for kraken test... 10:25:43 INFO - TEST-INFO | started process 23501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0ymSY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:44 INFO - PROCESS | 23501 | 10:25:44 INFO - PROCESS | 23501 | (process:23561): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:25:54 INFO - PROCESS | 23501 | RSS: Main: 163893248 10:25:54 INFO - PROCESS | 23501 | 10:25:57 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44838/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:58 INFO - PROCESS | 23501 | RSS: Main: 167829504 10:25:58 INFO - PROCESS | 23501 | 10:26:00 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44838/tests/kraken/driver.html?testName=audio-dft) 10:26:01 INFO - PROCESS | 23501 | RSS: Main: 171225088 10:26:01 INFO - PROCESS | 23501 | 10:26:04 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44838/tests/kraken/driver.html?testName=audio-fft) 10:26:05 INFO - PROCESS | 23501 | RSS: Main: 162291712 10:26:05 INFO - PROCESS | 23501 | 10:26:07 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44838/tests/kraken/driver.html?testName=audio-oscillator) 10:26:07 INFO - PROCESS | 23501 | RSS: Main: 162824192 10:26:07 INFO - PROCESS | 23501 | 10:26:10 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44838/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:10 INFO - PROCESS | 23501 | RSS: Main: 163713024 10:26:10 INFO - PROCESS | 23501 | 10:26:13 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44838/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:14 INFO - PROCESS | 23501 | RSS: Main: 163573760 10:26:14 INFO - PROCESS | 23501 | 10:26:17 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44838/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:18 INFO - PROCESS | 23501 | RSS: Main: 162914304 10:26:18 INFO - PROCESS | 23501 | 10:26:21 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44838/tests/kraken/driver.html?testName=json-parse-financial) 10:26:21 INFO - PROCESS | 23501 | RSS: Main: 164278272 10:26:21 INFO - PROCESS | 23501 | 10:26:23 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44838/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:24 INFO - PROCESS | 23501 | RSS: Main: 164302848 10:26:24 INFO - PROCESS | 23501 | 10:26:25 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:26 INFO - PROCESS | 23501 | RSS: Main: 164085760 10:26:26 INFO - PROCESS | 23501 | 10:26:28 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:29 INFO - PROCESS | 23501 | RSS: Main: 164139008 10:26:29 INFO - PROCESS | 23501 | 10:26:31 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:32 INFO - PROCESS | 23501 | RSS: Main: 164917248 10:26:32 INFO - PROCESS | 23501 | 10:26:35 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:35 INFO - PROCESS | 23501 | RSS: Main: 164745216 10:26:35 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | Cycle 1(1): loaded http://localhost:44838/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44838/tests/kraken/driver.html?testName=ai-astar) 10:26:37 INFO - PROCESS | 23501 | RSS: Main: 165834752 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | __start_tp_report 10:26:37 INFO - PROCESS | 23501 | _x_x_mozilla_page_load 10:26:37 INFO - PROCESS | 23501 | _x_x_mozilla_page_load_details 10:26:37 INFO - PROCESS | 23501 | |i|pagename|runs| 10:26:37 INFO - PROCESS | 23501 | |0;ai-astar;113;107;113;110;114;124;112;113;112;115 10:26:37 INFO - PROCESS | 23501 | |1;audio-beat-detection;160;130;160;181;128;156;159;129;192;131 10:26:37 INFO - PROCESS | 23501 | |2;audio-dft;162;163;166;162;162;163;173;163;167;162 10:26:37 INFO - PROCESS | 23501 | |3;audio-fft;76;77;72;152;83;76;78;76;100;78 10:26:37 INFO - PROCESS | 23501 | |4;audio-oscillator;91;93;155;91;93;94;144;92;93;152 10:26:37 INFO - PROCESS | 23501 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;118;118 10:26:37 INFO - PROCESS | 23501 | |6;imaging-darkroom;147;147;146;146;146;147;147;146;147;146 10:26:37 INFO - PROCESS | 23501 | |7;imaging-desaturate;95;96;95;96;95;95;100;95;95;95 10:26:37 INFO - PROCESS | 23501 | |8;json-parse-financial;60;58;61;61;59;60;63;87;57;56 10:26:37 INFO - PROCESS | 23501 | |9;json-stringify-tinderbox;61;61;61;62;62;60;60;63;60;60 10:26:37 INFO - PROCESS | 23501 | |10;stanford-crypto-aes;78;76;77;78;78;80;78;78;78;81 10:26:37 INFO - PROCESS | 23501 | |11;stanford-crypto-ccm;133;125;136;133;126;125;136;126;158;136 10:26:37 INFO - PROCESS | 23501 | |12;stanford-crypto-pbkdf2;175;165;166;166;168;164;171;171;174;168 10:26:37 INFO - PROCESS | 23501 | |13;stanford-crypto-sha256-iterative;72;72;71;71;70;69;68;68;71;67 10:26:37 INFO - PROCESS | 23501 | __end_tp_report 10:26:37 INFO - PROCESS | 23501 | __start_cc_report 10:26:37 INFO - PROCESS | 23501 | _x_x_mozilla_cycle_collect,859 10:26:37 INFO - PROCESS | 23501 | __end_cc_report 10:26:37 INFO - PROCESS | 23501 | __startTimestamp1460827597968__endTimestamp 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | ------- Summary: start ------- 10:26:37 INFO - PROCESS | 23501 | Number of tests: 14 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.37 (3.9%) stddev-sans-first:4.64 10:26:37 INFO - PROCESS | 23501 | Values: 113.0 107.0 113.0 110.0 114.0 124.0 112.0 113.0 112.0 115.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:159.50 stddev:22.76 (14.3%) stddev-sans-first:23.98 10:26:37 INFO - PROCESS | 23501 | Values: 160.0 130.0 160.0 181.0 128.0 156.0 159.0 129.0 192.0 131.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:3.53 (2.2%) stddev-sans-first:3.64 10:26:37 INFO - PROCESS | 23501 | Values: 162.0 163.0 166.0 162.0 162.0 163.0 173.0 163.0 167.0 162.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#3] audio-fft Cycles:10 Average:86.80 Median:76.50 stddev:24.17 (31.6%) stddev-sans-first:25.32 10:26:37 INFO - PROCESS | 23501 | Values: 76.0 77.0 72.0 152.0 83.0 76.0 78.0 76.0 100.0 78.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.50 stddev:28.11 (30.4%) stddev-sans-first:28.98 10:26:37 INFO - PROCESS | 23501 | Values: 91.0 93.0 155.0 91.0 93.0 94.0 144.0 92.0 93.0 152.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:26:37 INFO - PROCESS | 23501 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:26:37 INFO - PROCESS | 23501 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.57 (1.6%) stddev-sans-first:1.64 10:26:37 INFO - PROCESS | 23501 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 100.0 95.0 95.0 95.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:60.50 stddev:8.95 (14.8%) stddev-sans-first:9.46 10:26:37 INFO - PROCESS | 23501 | Values: 60.0 58.0 61.0 61.0 59.0 60.0 63.0 87.0 57.0 56.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:1.05 (1.7%) stddev-sans-first:1.12 10:26:37 INFO - PROCESS | 23501 | Values: 61.0 61.0 61.0 62.0 62.0 60.0 60.0 63.0 60.0 60.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:1.40 (1.8%) stddev-sans-first:1.48 10:26:37 INFO - PROCESS | 23501 | Values: 78.0 76.0 77.0 78.0 78.0 80.0 78.0 78.0 78.0 81.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:134.50 stddev:9.87 (7.3%) stddev-sans-first:10.47 10:26:37 INFO - PROCESS | 23501 | Values: 133.0 125.0 136.0 133.0 126.0 125.0 136.0 126.0 158.0 136.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:3.79 (2.2%) stddev-sans-first:3.30 10:26:37 INFO - PROCESS | 23501 | Values: 175.0 165.0 166.0 166.0 168.0 164.0 171.0 171.0 174.0 168.0 10:26:37 INFO - PROCESS | 23501 | 10:26:37 INFO - PROCESS | 23501 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:71.00 stddev:1.79 (2.5%) stddev-sans-first:1.73 10:26:37 INFO - PROCESS | 23501 | Values: 72.0 72.0 71.0 71.0 70.0 69.0 68.0 68.0 71.0 67.0 10:26:37 INFO - PROCESS | 23501 | -------- Summary: end -------- 10:26:37 INFO - PROCESS | 23501 | 10:26:38 INFO - TEST-INFO | 23501: exit 0 10:26:38 INFO - TEST-OK | kraken | took 61872ms 10:26:38 INFO - SUITE-END | took 1170s 10:26:39 INFO - Completed test suite (00:19:30) 10:26:39 INFO - javascript benchmark 10:26:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.3398769264604, 3111.3777244551097, 3126.327839514505, 3154.258749193939, 3155.8422078896065, 5363.731813409328, 5366.980273747985, 5400.216968539559, 5411.621186516935, 5417.458254174586, 5308.0, 5371.4897084776885, 5409.56723462123, 5431.592630552715, 5455.263539422177, 4916.188828843246, 4940.308356830046, 4983.925241121368, 5007.106700246861, 5054.6461747677495, 713.3333251256089, 4865.14859899518, 4867.610591152717, 4878.951210487903, 4907.1412502812045, 4817.566419022305, 4822.348982887318, 4829.9275510867365, 4831.347768051321, 4884.560389564938, 4806.206975848981, 4876.804927802884, 4920.6309526785635, 4934.309196712427, 4984.925226121611, 4813.566778989908, 4843.128236917353, 4857.878553036167, 4860.1251774680895, 4897.4857639948, 5288.497592728685, 5297.099493086184, 5314.9468505314835, 5323.334583177103, 5399.595030372699, 5755.079187330007, 5783.884322313572, 5785.681787501686, 5788.594798364116, 5831.591788574801, 5729.512991395694, 5748.5975981681295, 5767.769289228426, 5795.652260864362, 5819.185314056035, 5413.323334583177, 5415.675059496442, 5416.404195538527, 5417.945820541823, 5427.213054107172, 5802.0, 5915.349311575723, 5920.082387229986, 5983.910241346383, 6009.549283803733, 5574.777008919597, 5590.0, 5595.63628364155, 5602.551795856321, 5605.5515558755205, 5678.346990096192, 5688.345840228344, 5691.658500489983, 5694.971525142348, 5699.230603868425, 5605.411431799684, 5716.657000579979, 5752.3097228332035, 5795.88408231833, 5829.125631155361, 5706.115552089433, 5762.394948530344, 5769.423057694197, 5831.1544826000845, 5914.733836977261, 4397.538258482878, 4406.471223453206, 4406.779661017001, 4414.492333381702, 4415.735055896656, 3823.1971286030243, 3897.785621790829, 3918.2555314490155, 3935.2719746846924, 3981.442598036277, 5544.445555444504, 5605.859853503695, 5617.0, 5619.241402410704, 5648.378678345379, 5764.279465066867, 5847.298324201123, 5854.385289544622, 5858.0, 5863.5309175265875, 5486.725663716798, 5511.807086751945, 5592.440755924456, 5596.440355964371, 5618.91571626426, 4981.501849815062, 5025.572826309732, 5026.045051440215, 5026.958689992575, 5034.823781167642, 6032.577719559588, 6044.879102417927, 6045.969770151121, 6056.364081771439, 6070.3019152797115, 5760.107183386582, 5849.385814489502, 5899.292084949833, 5922.082077278029, 5928.407159284037, 6026.487748541423, 6035.0, 6045.0, 6048.546359023179, 6054.061620448838, 5619.606627536034, 5729.427057294404, 5753.309602847517, 5754.223179870832, 5762.855928601818, 5693.914591281217, 5715.971420142872, 5786.9131963019745, 5815.273090863642, 5843.94156058451, 5517.613767036269, 5537.640053396516, 5541.030319694118, 5550.888982220414, 5572.414896435978, 5481.0, 5498.697571633598, 5501.4223506532835, 5516.062269414289, 5655.066913959151, 5491.643043202179, 5528.585356098389, 5552.056150454352, 5585.5531557476115, 5628.296462942132, 5671.943280567141, 5691.0, 5696.8006119785605, 5701.657900525982, 5718.113692377522, 5504.201890725903, 5558.416366281483, 5590.580706446952, 5608.990381731328, 5630.408807075198], "value": 5294.934412917153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.4189598933019, 643.6170478565252, 661.1042038038455, 663.4692246203036, 681.696644992978, 35805.64194358056, 36768.632313676855, 36854.44718329227, 36865.078373040684, 36946.261074778486, 39546.0, 40109.59616413426, 40590.7970460148, 40626.0, 40667.99999999993, 8448.32413406926, 8643.567821608895, 8668.783280417976, 8672.479651220947, 8682.0, 8433.536155511445, 8539.658413663446, 8551.187637174458, 8699.347548933823, 8761.7809554761, 8752.474851508898, 8839.77900552488, 8847.159519845636, 8856.291496680282, 8872.20150186483, 8713.433626814269, 8762.518061506646, 8769.342299327576, 8787.25308348791, 8804.20762131408, 8545.658173673046, 8691.0, 8699.913000869974, 8705.7823554411, 8773.0, 38382.424263636065, 38768.80615596904, 38775.418368724495, 38951.61048389536, 39010.80494597509, 3602.35157671619, 3764.7176461765202, 3809.942850857239, 3822.5986271441375, 4217.472815898012, 29904.0, 30217.09348719542, 30637.38725225483, 30740.2314942126, 31658.841705791325, 3674.65090816372, 3772.0, 3860.3823388258024, 3874.8256328465286, 3897.7271590988644, 266682.0, 267445.0, 267474.0, 267884.0, 268454.0, 34790.30419391598, 35507.112322191635, 35728.821355893575, 35811.0, 53505.7324713374, 33617.49573756396, 33770.32459350799, 33833.661663383544, 33950.15124621855, 33975.830120849234, 14453.638659033608, 14602.0, 14617.488387906373, 14630.853691463162, 14641.34113964874, 12252.20360676571, 12261.632151035483, 12366.44351004207, 12438.25370477756, 12687.809682854764, 8334.166583341617, 8334.66661333552, 8376.246137847624, 8410.873836892451, 8425.70510032146, 3210.967890321067, 3267.330197309546, 3306.189983454069, 3316.2704205074847, 3342.9665703343144, 1058.0794708603564, 1081.7457897394106, 1097.4457898761075, 1124.9268797528298, 1164.714644912002, 30359.241018974262, 30368.0, 31117.533237001462, 33046.0, 35540.64459355425, 1095.5289225632896, 1142.9198858078219, 1149.6836122639531, 1155.6764106050318, 1235.2650173146963, 15183.848161518243, 15190.0, 15225.771613425808, 15247.23763811805, 15322.616934576501, 404355.0, 409877.0, 412325.0, 412430.0, 413718.0, 54986.72506637441, 56195.43804561984, 56445.43554564402, 56519.15221271684, 56762.43237567654, 1341.2958196946681, 1416.922069286199, 1416.985830141706, 1433.7275917575628, 1437.3172742947017, 28317.433651327272, 28404.715952840208, 28780.280492987844, 29155.416891661625, 29453.85273073621, 45457.318140228585, 45906.311405329616, 46303.76848115738, 46402.76798615985, 46412.767936160104, 313670.0, 314217.0, 314534.0, 314990.0, 316646.0, 26724.331891702863, 26813.793379298368, 27066.864665676545, 27225.455490889675, 27276.181714548595, 45356.31965520454, 45967.0, 46825.76587117043, 47818.0, 49637.75181124071, 35589.64410355863, 35907.46138807868, 36007.63992360043, 36034.63965360418, 36330.27339453143, 36360.27279454449, 38138.42792358172, 38457.23085538329, 38559.61440385672, 38876.416853746654, 36984.445233320985, 40104.79947600243, 41822.0, 42551.7872410636, 43300.35049474197, 31126.688733113286, 33761.66238337585, 33959.151021223675, 34437.65562344345, 34458.655413445544, 26715.19854404371, 26886.193414197605, 26985.1904442867, 27188.456230874875, 27460.17619471419], "value": 17681.62475498706, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4409851370714, 382.34618801848836, 385.22954091816365, 391.3112921258584, 392.63877232945686, 17030.74453883191, 17576.209070591824, 17958.730619040725, 17981.82018179818, 18031.72952405715, 16704.58238544037, 17150.571235719115, 17220.483385498454, 17377.826221737778, 17915.64168716628, 5494.478024587658, 5643.153526970967, 5669.09294512878, 5687.516561092312, 5709.714514274269, 3953.782541960191, 5878.382769809173, 6059.394060593927, 6097.817065488042, 6112.69436528174, 5122.6158038147105, 6014.488768454687, 6017.06735456005, 6031.276246850384, 6034.96982515089, 5414.187871819219, 5456.508914197721, 5457.481539253765, 5457.863553411176, 5471.206675032118, 5037.370328708911, 5502.367227768817, 5529.198266251411, 5530.225768392428, 5540.2243685884005, 12899.0, 13101.08292419531, 13136.0, 13268.867311326956, 13841.930790345983, 2303.686898467857, 2371.6205407134776, 2375.643653451979, 2444.792192663608, 2473.2209354053416, 9477.763055923588, 9618.807623847553, 9840.11438970496, 9875.259355548362, 9955.601775929026, 1845.4371416717895, 1872.4195499395096, 1880.8119188081218, 1916.3867562380044, 1985.3944546913185, 70040.29959700389, 72601.0, 73163.0, 73264.63367683181, 74622.0, 10335.534900929477, 10426.322289051188, 10599.62901298451, 10676.145908327315, 10766.192535559707, 14713.190774507504, 14746.63133421673, 14797.186154761592, 14817.0, 14822.851771482146, 7554.735584254525, 7727.768166955, 7779.533228006338, 7890.487118337404, 7975.920240797634, 7291.671874765649, 7376.7786966391095, 7427.145878223965, 7439.702411903463, 7642.777155655069, 4479.283314669638, 4609.700369475973, 4614.508165590611, 4688.601468875184, 4708.552687494751, 1795.2729144696418, 1809.0281593063623, 1915.3200613782185, 1921.7693876734882, 1926.5568919148393, 905.7192270396198, 977.53567055648, 993.3989936088707, 995.0447570332417, 1037.3516552154904, 17554.736678949826, 18379.72430413545, 18719.438416847242, 18801.341953031577, 18845.717314240297, 1004.3672486333563, 1024.846273059047, 1034.849946757716, 1049.192122066005, 1059.2267644619317, 10193.286469947032, 10481.737956551147, 10534.104601108991, 10537.84193237102, 10548.736281592868, 402319.0, 403625.0, 404831.0, 406150.0, 433779.0, 85023.0, 85441.14558854456, 86338.0, 87091.0, 89265.55367223252, 1029.5161274201114, 1054.6466933577337, 1071.6999240212754, 1085.4409978860892, 1093.0162853431975, 15943.521694349189, 16245.268962896935, 16285.430009949594, 16340.264688088826, 16397.0, 34514.482282765275, 34530.48204276988, 34796.0, 35537.1115722109, 36291.274174515835, 50104.498955009985, 50187.74906125446, 50415.74792126162, 50526.747366262935, 50770.74614626903, 8099.757007289791, 8346.916530834615, 8561.657533698582, 8584.442011269248, 8792.208701216921, 10587.523561439599, 12030.578929737418, 12050.276983381025, 12465.563705270271, 12872.420741066488, 11093.389863557582, 11366.261193022427, 11455.312681239153, 11497.367644779617, 11525.0, 11271.943640281746, 11298.435078246219, 11317.943410282896, 11601.941990289995, 11768.705782355168, 8767.991680956771, 11780.352080635304, 11809.763804724029, 11909.880901190878, 11977.041836652872, 7784.260495252942, 7786.33816125613, 8083.83832323362, 8208.958955205186, 8253.174682531699, 10149.949250253701, 10707.785844282915, 10961.725956851142, 11078.889211108108, 11329.0], "value": 8676.872502204242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.622594351412, 1514.9318280677371, 1682.4279744886735, 1794.27331930568, 1818.4544636609005, 7654.464187506876, 8181.754547363581, 8262.83474330513, 8430.156984301575, 8540.743777686665, 8333.833323333529, 8397.790055248623, 8411.747647570583, 8424.578771061453, 8439.32485401168, 2309.538092381522, 2353.2940117964627, 2371.27676058802, 2375.406148462884, 2381.4641705616186, 2291.1980806717597, 2305.2162264829954, 2320.5706944215376, 2332.6617640442128, 2344.296710986706, 2280.5552917181158, 2302.4243939015246, 2321.025169428844, 2387.4986252886915, 2412.2763171048705, 2292.060255295321, 2299.4366380236784, 2301.7007788987494, 2309.9653505197434, 2310.3761984264156, 2256.638937769949, 2258.299927022612, 2259.1641092795608, 2261.6607508873635, 2263.773622637723, 8426.452280601803, 8477.491350518927, 8542.316614670812, 8563.143685631449, 8591.785205369853, 5020.7740651670765, 5178.223266510016, 5191.532762051434, 5199.038177937094, 5203.479652034766, 3527.876524321662, 3529.0824385659657, 3545.592256890465, 3551.4317709166667, 3577.624349443323, 1145.5188820695328, 1148.6381789736206, 1155.1682788392345, 1156.5200441816637, 1164.5268735050167, 11330.999999999918, 11333.43332833355, 11350.943245283803, 11384.772304553862, 11386.886131138666, 4331.5884990925815, 4379.255526560492, 4500.797464114123, 4510.24100600766, 4614.377059097046, 8843.336749743796, 8899.33255005877, 8904.8664270036, 8943.195112439911, 9011.098890111067, 5179.637425380187, 5181.171012637959, 5185.48145185486, 5198.714070726146, 5204.9219261711105, 4384.539623339567, 4811.398575178103, 4878.731669758126, 4931.408231012301, 4947.233178857283, 3623.239119784822, 3655.2324011957785, 3738.2523495301048, 3752.493413389212, 3760.5675347335405, 1146.163300790411, 1153.5847095045776, 1155.4973586489905, 1164.336328292882, 1165.6794381545144, 898.1916275352105, 940.9905900940903, 944.976375590602, 947.8199142163105, 980.9362391444533, 5568.6658800472105, 5632.577556683265, 5639.210510528529, 5752.9712351437975, 5800.738966746507, 835.340081335738, 858.1375717403969, 934.1219253901311, 972.4214092614883, 988.560090759605, 3783.7162212834146, 3816.5229346331707, 3851.326017946848, 3855.36386496225, 3865.072382628205, 10136.239782016231, 10487.213458990605, 10495.107915827088, 10558.947205263925, 10646.574137034431, 10443.0, 10668.466576671135, 10758.946205268923, 10765.730856728487, 10776.461176941122, 8027.876097346376, 8034.638441270157, 8122.147174546706, 8218.342532597379, 8290.129536398832, 5651.8304450866535, 5662.943370566406, 5734.741936612946, 5755.482006619424, 5776.826695199151, 9816.2147028239, 9875.703728888146, 9912.702618921443, 9932.702018939442, 10058.943810899751, 9768.902310976799, 9844.507774611098, 10010.401580642123, 10173.898261017592, 10202.693919182437, 6911.343422374866, 6938.757143499954, 6974.68613912365, 7049.259827718221, 7058.0, 8088.514689118671, 8124.0, 8140.308073813792, 8169.183081691784, 8184.7953801155445, 7237.674304656198, 7593.202713714981, 7600.50596711212, 7610.543367397974, 7621.390288776774, 7334.3032411920785, 7424.257574242532, 7433.219511951167, 7466.701331946661, 7524.435667324863, 6812.93187068123, 6824.283450237852, 6839.0, 6910.0, 6912.55068420551, 4740.336352910526, 4878.804847806048, 4974.776135073858, 5013.774380152829, 5018.824341148043, 4935.679180853233, 5047.823326183566, 5080.872978175576, 5088.363954505687, 5137.691738495702], "value": 4508.986790442118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1000089756759, 332.39172314664165, 332.44979558830147, 338.6207447658623, 341.47072038340576, 5958.255218097738, 5996.700164991755, 6007.819765407039, 6009.549283803722, 6027.638341699496, 5882.823515294537, 5906.645601263916, 5911.349751527328, 5925.703714814264, 5931.110333449974, 4285.121550082234, 4403.229434848905, 4505.391772110772, 4507.887302817439, 4552.521985191557, 4475.597196252336, 4498.370228168059, 4509.481409637884, 4515.458145022585, 4536.7504787236685, 4459.598636122749, 4464.799084041209, 4489.887752806173, 4516.119356725423, 4521.118381915528, 4310.482742070956, 4460.241758900995, 4481.473711551356, 4499.302608095718, 4514.638828893697, 3914.3345631242755, 3936.783476908769, 3961.742486738353, 3968.226195891802, 3983.980080099581, 5664.745086471119, 5690.260266165414, 5692.117721753135, 5698.287714035746, 5718.142278658193, 5100.209467532502, 5197.506236907526, 5214.165733482662, 5215.869603259911, 5248.895022099537, 6132.877342453126, 6142.1093941378695, 6175.536834737412, 6195.49082621539, 6205.472534834545, 4305.98809279819, 4364.781760911942, 4376.803043863034, 4390.934135987963, 4396.780160991938, 6435.935640643627, 6519.8696026079215, 6521.413072823421, 6524.543281970264, 6525.249596296392, 4514.548545145525, 4515.254982927846, 4521.276595744665, 4533.569310915458, 4534.433195850519, 4508.661850361236, 4529.411176547028, 4590.770461476913, 4598.816047358068, 4606.032733126014, 5206.193040078794, 5215.843524694265, 5235.554977826851, 5251.947480525146, 5257.921131183035, 6163.630182189083, 6220.502359811204, 6236.594621349598, 6251.562390632703, 6314.778982735582, 1561.4769052367585, 1566.1229711361445, 1577.6608029273762, 1588.5313832419463, 1589.8092228932371, 988.2637435110745, 1012.3470361616716, 1017.8269694151863, 1020.7703266764919, 1067.3649178738792, 5916.171735956969, 5985.431384018511, 5995.670238136857, 6008.639481631116, 6042.274927008699, 6257.186565746424, 6349.936500635027, 6361.141245931833, 6361.522885783585, 6366.204224471941, 5981.192539007266, 5983.700814959322, 6006.5495087868585, 6007.609505382136, 6015.578909476295, 3401.1837159081642, 3402.66917161745, 3425.9657403426145, 3437.553118094682, 3440.8107554084263, 6450.290468048511, 6625.503087268474, 6871.244163142051, 6889.689963951634, 6904.4821638377325, 6711.966440167866, 6724.462043036546, 6725.66371681414, 6745.392914637706, 6752.932470675329, 6697.689297192461, 6773.0, 6851.931480685129, 6861.897071543931, 6876.862462750717, 6512.544121911421, 6515.902261466176, 6540.0, 6571.408573228432, 6593.966775283232, 6377.8616050935225, 6430.228372595318, 6455.354464553507, 6481.384268494486, 6487.448566871869, 6788.321167883172, 6826.0, 6859.828504287433, 6869.519133660596, 6872.793816185523, 4360.302351623725, 4378.408914796589, 4385.605295523418, 4391.604755571886, 4409.096135292321, 6403.167588213502, 6572.112764776694, 6579.572327798678, 6594.604323740591, 6609.570377925419, 6273.905891411724, 6342.492600592034, 6352.745890164341, 6356.364363563606, 6382.106505089384, 6231.264239178347, 6267.1539342188225, 6331.240251169889, 6367.439977205614, 6411.8717625646295, 6092.39076092405, 6212.9068063979985, 6236.002239641635, 6292.559520833681, 6294.402031806971, 6338.302786693368, 6410.166678331787, 6414.679266036586, 6427.58220715652, 6435.420812126931, 6055.455009049207, 6201.503879689704, 6223.439890409885, 6238.033104868752, 6248.125262463168], "value": 4738.926322421222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.3578982072122, 750.2010358967702, 789.6762327445747, 796.6388388716101, 798.8921495598092, 12524.686882827922, 12628.747425051493, 12745.490180392784, 12848.35758212088, 12858.549950751725, 13096.279704616243, 13133.868661313383, 13154.736905261889, 13164.6708832279, 13211.0, 797.0913158998746, 815.6003558256441, 829.5105887526358, 829.8174401631632, 842.4945032980194, 829.9626516806758, 831.0941074229089, 831.9209675080857, 832.6045128563914, 835.3609488741118, 864.822711344173, 868.3400615532178, 868.5917618719192, 870.6473878079388, 873.6898401067625, 859.8538248497708, 864.1056506515757, 865.709987154304, 866.9003064647583, 867.9479231246082, 630.8517498387876, 634.8920683483773, 638.1034646321925, 638.2946843737695, 640.8333833203401, 14161.858381416157, 14216.573502794829, 14233.0, 14275.286235688278, 14307.356168972421, 12715.936420317932, 12729.427175777113, 12755.553555625509, 12759.489620415265, 12971.805422918664, 11344.376059316734, 11511.827322590168, 11518.324607329807, 11553.19127661064, 11697.23967942081, 3699.5005674233903, 3767.171222331083, 3774.490443790108, 3812.0850995761093, 3861.7296789224765, 51876.74061629705, 52139.21791173097, 52328.0, 52413.0, 52733.209001865005, 10056.094951454405, 10165.695029149138, 10186.337888037255, 10239.18086553074, 10350.53422595985, 17929.910350448165, 18084.095795210185, 18146.364877229233, 18146.63706725858, 18183.909080454512, 7878.165912759274, 7905.960470197612, 7943.086545047278, 7948.403869709795, 7973.9202607973175, 4466.196084704784, 4488.775561221926, 4504.707194032443, 4534.433195850519, 4628.3288923105965, 3269.54226408303, 3378.8986330410125, 3413.112590726429, 3428.365752335826, 3432.553768010143, 579.73622001989, 588.0972706894896, 589.548995018811, 591.5622439394817, 592.7391947543067, 680.9931900681029, 720.8846584546552, 753.1865585168006, 783.9725609603637, 788.1409263902259, 9211.539423028822, 9473.90526094744, 9706.417614943126, 9707.854382184272, 9723.173530250007, 666.8966310221923, 685.0546246180239, 705.6295444891371, 729.5185177782638, 736.3777607921298, 4251.574842515785, 4375.124975005012, 4395.120975804852, 4423.413637288026, 4465.397171381886, 59345.40654593485, 60979.39020609737, 61002.38997610056, 61071.38928610746, 61198.0, 49568.75215623899, 50589.49410505922, 51062.23406648903, 51279.487205128215, 51376.74311628418, 45261.77369113133, 45765.99999999933, 47104.0, 47323.5267647326, 48103.278450823265, 8988.280937525113, 9041.954790226007, 9156.404833685789, 9222.216111630318, 9277.907220927704, 28962.565561516174, 29838.701612983594, 29974.85012574923, 30521.847390762905, 30615.0, 37899.81050094732, 42108.157836843704, 43093.0, 44184.779076104416, 44275.33586996133, 11827.704307392383, 11919.3444360561, 12103.213291136048, 12147.878521214674, 12424.937875310565, 12973.675658108245, 13153.276569788371, 13216.273104979318, 13484.797728033891, 13831.100978436369, 12258.754824903273, 12408.441620127296, 12778.488860445477, 12842.229466232056, 13031.739365212832, 11988.820167697317, 12237.87762122403, 12240.387980601112, 12309.076819238771, 12360.4437800301, 11190.0, 12332.630021099381, 12366.62900112998, 12445.62663120108, 12517.624471265877, 10631.255812093388, 10932.890671093188, 11123.777524449304, 11390.943045284721, 11477.0, 10838.729031774268, 10917.83623245636, 10957.50691218913, 11011.394373309546, 11090.889091108986], "value": 6596.997091015539, "unit": "score"}], "name": "dromaeo_css", "value": 6968.638654721134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 110.0, 114.0, 124.0, 112.0, 113.0, 112.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 160.0, 181.0, 128.0, 156.0, 159.0, 129.0, 192.0, 131.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 162.0, 162.0, 163.0, 173.0, 163.0, 167.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 72.0, 152.0, 83.0, 76.0, 78.0, 76.0, 100.0, 78.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 155.0, 91.0, 93.0, 94.0, 144.0, 92.0, 93.0, 152.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 100.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 61.0, 61.0, 59.0, 60.0, 63.0, 87.0, 57.0, 56.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 60.0, 60.0, 63.0, 60.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 78.0, 78.0, 80.0, 78.0, 78.0, 78.0, 81.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 125.0, 136.0, 133.0, 126.0, 125.0, 136.0, 126.0, 158.0, 136.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 165.0, 166.0, 166.0, 168.0, 164.0, 171.0, 171.0, 174.0, 168.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 71.0, 70.0, 69.0, 68.0, 68.0, 71.0, 67.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1560.1000000000001, "alertThreshold": 2.0}]} 10:26:39 INFO - Return code: 0 10:26:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:39 ERROR - # TBPL SUCCESS # 10:26:39 INFO - Running post-action listener: _resource_record_post_action 10:26:39 INFO - Running post-run listener: _resource_record_post_run 10:26:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535822336; Read time: 8; Write time: 443948 10:26:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244211712; Read time: 0; Write time: 246640 10:26:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291610624; Read time: 8; Write time: 197308 10:26:40 INFO - Running post-run listener: _upload_blobber_files 10:26:40 INFO - Blob upload gear active. 10:26:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:40 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 10:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:40 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:41 INFO - (blobuploader) - INFO - Done attempting. 10:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:42 INFO - (blobuploader) - INFO - Done attempting. 10:26:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:42 INFO - Return code: 0 10:26:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca20dcf3922bfcee37456f8be640120e668c4cdfca6bc2a554b10e5563d45ec08e39f5b7a5ab0dbae0cbd4cb6e51be5da6746d92c1cad357b45e3137bd6954a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0f2e7815b5d1ddad1fc6378f0c629e52c585edc2c564108c6246bad45f3cd55206fcbcf668471f5361d545527f0c1f182add1cde7506744fd204c5d17d682"} 10:26:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:42 INFO - Contents: 10:26:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca20dcf3922bfcee37456f8be640120e668c4cdfca6bc2a554b10e5563d45ec08e39f5b7a5ab0dbae0cbd4cb6e51be5da6746d92c1cad357b45e3137bd6954a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0f2e7815b5d1ddad1fc6378f0c629e52c585edc2c564108c6246bad45f3cd55206fcbcf668471f5361d545527f0c1f182add1cde7506744fd204c5d17d682"} 10:26:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:42 INFO - Copying logs to upload dir... 10:26:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.824853 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-16 10:26:42.055376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:26:42.058526) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca20dcf3922bfcee37456f8be640120e668c4cdfca6bc2a554b10e5563d45ec08e39f5b7a5ab0dbae0cbd4cb6e51be5da6746d92c1cad357b45e3137bd6954a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0f2e7815b5d1ddad1fc6378f0c629e52c585edc2c564108c6246bad45f3cd55206fcbcf668471f5361d545527f0c1f182add1cde7506744fd204c5d17d682"} build_url:https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca20dcf3922bfcee37456f8be640120e668c4cdfca6bc2a554b10e5563d45ec08e39f5b7a5ab0dbae0cbd4cb6e51be5da6746d92c1cad357b45e3137bd6954a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0f2e7815b5d1ddad1fc6378f0c629e52c585edc2c564108c6246bad45f3cd55206fcbcf668471f5361d545527f0c1f182add1cde7506744fd204c5d17d682"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:26:42.082972) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:26:42.083318) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460819305.572647-1281814032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:26:42.164993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:26:42.165323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:26:42.165605) ========= ========= Total master_lag: 0.17 =========