builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1461097033.35 results: success (0) buildid: 20160419123832 builduid: a1783ebad6b546558fb0488a272d61ad revision: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.350786) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.351306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.351585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.369442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.369802) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 13:17:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 25.2M=0s 2016-04-19 13:17:14 (25.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.463940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.465973) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020128 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:13.515911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 13:17:13.519388) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 --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=a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 13:17:14,979 truncating revision to first 12 chars 2016-04-19 13:17:14,979 Setting DEBUG logging. 2016-04-19 13:17:14,979 attempt 1/10 2016-04-19 13:17:14,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4ab4fd96f8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 13:17:16,319 unpacking tar archive at: fx-team-f4ab4fd96f8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.658823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 13:17:15.191259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.191589) ========= script_repo_revision: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.191992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.192273) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:15.200572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-19 13:17:15.200948) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:17:16 INFO - MultiFileLogger online at 20160419 13:17:16 in /builds/slave/test 13:17:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:17:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:16 INFO - {'append_to_log': False, 13:17:16 INFO - 'base_work_dir': '/builds/slave/test', 13:17:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:17:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:16 INFO - 'branch': 'Fx-Team-Non-PGO', 13:17:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:16 INFO - 'config_files': ('talos/linux_config.py',), 13:17:16 INFO - 'default_actions': ('clobber', 13:17:16 INFO - 'read-buildbot-config', 13:17:16 INFO - 'download-and-extract', 13:17:16 INFO - 'populate-webroot', 13:17:16 INFO - 'create-virtualenv', 13:17:16 INFO - 'install', 13:17:16 INFO - 'run-tests'), 13:17:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:16 INFO - 'download_minidump_stackwalk': True, 13:17:16 INFO - 'download_symbols': 'ondemand', 13:17:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:16 INFO - 'installer_path': 'installer.exe', 13:17:16 INFO - 'log_level': 'info', 13:17:16 INFO - 'log_name': 'talos', 13:17:16 INFO - 'log_to_console': True, 13:17:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:17:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:17:16 INFO - 'opt_config_files': (), 13:17:16 INFO - 'pip_index': False, 13:17:16 INFO - 'sps_profile': False, 13:17:16 INFO - 'sps_profile_interval': 0, 13:17:16 INFO - 'suite': 'dromaeojs', 13:17:16 INFO - 'system_bits': '32', 13:17:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:16 INFO - 'title': 'talos-linux64-ix-064', 13:17:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:16 INFO - 'use_talos_json': True, 13:17:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:16 INFO - 'work_dir': 'build'} 13:17:16 INFO - ##### 13:17:16 INFO - ##### Running clobber step. 13:17:16 INFO - ##### 13:17:16 INFO - Running pre-action listener: _resource_record_pre_action 13:17:16 INFO - Running main action method: clobber 13:17:16 INFO - rmtree: /builds/slave/test/build 13:17:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:17 INFO - Running post-action listener: _resource_record_post_action 13:17:17 INFO - ##### 13:17:17 INFO - ##### Running read-buildbot-config step. 13:17:17 INFO - ##### 13:17:17 INFO - Running pre-action listener: _resource_record_pre_action 13:17:17 INFO - Running main action method: read_buildbot_config 13:17:17 INFO - Using buildbot properties: 13:17:17 INFO - { 13:17:17 INFO - "project": "", 13:17:17 INFO - "product": "firefox", 13:17:17 INFO - "script_repo_revision": "production", 13:17:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:17:17 INFO - "repository": "", 13:17:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:17:17 INFO - "buildid": "20160419123832", 13:17:17 INFO - "pgo_build": "False", 13:17:17 INFO - "basedir": "/builds/slave/test", 13:17:17 INFO - "buildnumber": 1670, 13:17:17 INFO - "slavename": "talos-linux64-ix-064", 13:17:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:17:17 INFO - "platform": "ubuntu64_hw", 13:17:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:17:17 INFO - "branch": "fx-team", 13:17:17 INFO - "repo_path": "integration/fx-team", 13:17:17 INFO - "revision": "f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35", 13:17:17 INFO - "stage_platform": "linux64", 13:17:17 INFO - "builduid": "a1783ebad6b546558fb0488a272d61ad", 13:17:17 INFO - "slavebuilddir": "test" 13:17:17 INFO - } 13:17:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:17:17 INFO - Running post-action listener: _resource_record_post_action 13:17:17 INFO - ##### 13:17:17 INFO - ##### Running download-and-extract step. 13:17:17 INFO - ##### 13:17:17 INFO - Running pre-action listener: _resource_record_pre_action 13:17:17 INFO - Running main action method: download_and_extract 13:17:17 INFO - mkdir: /builds/slave/test/build/tests 13:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:17 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:18 INFO - Downloaded 1361 bytes. 13:17:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:17:18 INFO - Using the following test package requirements: 13:17:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:17:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:17:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'jsshell-linux-x86_64.zip'], 13:17:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:17:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:17:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:17:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:17:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:17:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:17: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')]} 13:17:18 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:20 INFO - Downloaded 22267191 bytes. 13:17: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'] 13:17: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 13:17:21 INFO - Return code: 0 13:17:21 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 13:17: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')]} 13:17:21 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:27 INFO - Downloaded 22267191 bytes. 13:17:27 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'] 13:17:27 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 13:17:28 INFO - Return code: 0 13:17: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')]} 13:17:28 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:29 INFO - Downloaded 10845952 bytes. 13:17:29 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'] 13:17:29 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 13:17:30 INFO - Return code: 0 13:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:30 INFO - https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYyG7BEEQJiQDOhVZC8BPw/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 13:17:32 INFO - Downloaded 54505764 bytes. 13:17:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:32 INFO - mkdir: /builds/slave/test/properties 13:17:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:32 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:32 INFO - Contents: 13:17:32 INFO - build_url:https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:17:33 INFO - Running post-action listener: _resource_record_post_action 13:17:33 INFO - Running post-action listener: set_extra_try_arguments 13:17:33 INFO - ##### 13:17:33 INFO - ##### Running populate-webroot step. 13:17:33 INFO - ##### 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running main action method: populate_webroot 13:17:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:33 INFO - '--tppagecycles', 13:17:33 INFO - '7'], 13:17:33 INFO - 'tests': ['tsvgm']}}, 13:17:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['damp', 'tps']}, 13:17:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'tests': ['damp', 'tps']}, 13:17:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['dromaeo_dom']}, 13:17:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tsvgx', 13:17:33 INFO - 'tsvgr_opacity', 13:17:33 INFO - 'tart', 13:17:33 INFO - 'tscrollx', 13:17:33 INFO - 'cart']}, 13:17:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:33 INFO - 'tsvgr_opacity', 13:17:33 INFO - 'tart', 13:17:33 INFO - 'tscrollx', 13:17:33 INFO - 'cart']}, 13:17:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tp5o']}, 13:17:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'tests': ['tp5o']}, 13:17:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s', 13:17:33 INFO - '--xperf_path', 13:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:33 INFO - 'tests': ['tp5n']}, 13:17:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--xperf_path', 13:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:33 INFO - 'tests': ['tp5n']}}, 13:17:33 INFO - 'talos.zip': {'path': '', 13:17:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:33 INFO - Running post-action listener: _resource_record_post_action 13:17:33 INFO - ##### 13:17:33 INFO - ##### Running create-virtualenv step. 13:17:33 INFO - ##### 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running main action method: create_virtualenv 13:17:33 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:33 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 13:17:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:33 INFO - Using real prefix '/usr' 13:17:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:35 INFO - Installing pip.................done. 13:17:35 INFO - Return code: 0 13:17:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:17:35 INFO - Using env: {'DISPLAY': ':0', 13:17:35 INFO - 'HOME': '/home/cltbld', 13:17:35 INFO - 'LANG': 'en_US.UTF-8', 13:17:35 INFO - 'LANGUAGE': 'en_US:en', 13:17:35 INFO - 'LOGNAME': 'cltbld', 13:17:35 INFO - 'MAIL': '/var/mail/cltbld', 13:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:35 INFO - 'MOZ_NO_REMOTE': '1', 13:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:35 INFO - 'NO_EM_RESTART': '1', 13:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:35 INFO - 'PWD': '/builds/slave/test', 13:17:35 INFO - 'SHELL': '/bin/bash', 13:17:35 INFO - 'SHLVL': '1', 13:17:35 INFO - 'TERM': 'linux', 13:17:35 INFO - 'TMOUT': '86400', 13:17:35 INFO - 'USER': 'cltbld', 13:17:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:35 INFO - '_': '/tools/buildbot/bin/python'} 13:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:35 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 13:17:35 INFO - Cleaning up... 13:17:36 INFO - Return code: 0 13:17:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:36 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:36 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 13:17:36 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 13:17:36 INFO - Using env: {'DISPLAY': ':0', 13:17:36 INFO - 'HOME': '/home/cltbld', 13:17:36 INFO - 'LANG': 'en_US.UTF-8', 13:17:36 INFO - 'LANGUAGE': 'en_US:en', 13:17:36 INFO - 'LOGNAME': 'cltbld', 13:17:36 INFO - 'MAIL': '/var/mail/cltbld', 13:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:36 INFO - 'MOZ_NO_REMOTE': '1', 13:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:36 INFO - 'NO_EM_RESTART': '1', 13:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:36 INFO - 'PWD': '/builds/slave/test', 13:17:36 INFO - 'SHELL': '/bin/bash', 13:17:36 INFO - 'SHLVL': '1', 13:17:36 INFO - 'TERM': 'linux', 13:17:36 INFO - 'TMOUT': '86400', 13:17:36 INFO - 'USER': 'cltbld', 13:17:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:36 INFO - '_': '/tools/buildbot/bin/python'} 13:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:36 INFO - Downloading/unpacking psutil>=0.7.1 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:38 INFO - Installing collected packages: psutil 13:17:38 INFO - Running setup.py install for psutil 13:17:38 INFO - building 'psutil._psutil_linux' extension 13:17:38 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 13:17:38 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 13:17:38 INFO - building 'psutil._psutil_posix' extension 13:17:38 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 13:17:38 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 13:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:38 INFO - Successfully installed psutil 13:17:38 INFO - Cleaning up... 13:17:38 INFO - Return code: 0 13:17:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:38 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:38 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 13:17:38 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 13:17:38 INFO - Using env: {'DISPLAY': ':0', 13:17:38 INFO - 'HOME': '/home/cltbld', 13:17:38 INFO - 'LANG': 'en_US.UTF-8', 13:17:38 INFO - 'LANGUAGE': 'en_US:en', 13:17:38 INFO - 'LOGNAME': 'cltbld', 13:17:38 INFO - 'MAIL': '/var/mail/cltbld', 13:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:38 INFO - 'MOZ_NO_REMOTE': '1', 13:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:38 INFO - 'NO_EM_RESTART': '1', 13:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:38 INFO - 'PWD': '/builds/slave/test', 13:17:38 INFO - 'SHELL': '/bin/bash', 13:17:38 INFO - 'SHLVL': '1', 13:17:38 INFO - 'TERM': 'linux', 13:17:38 INFO - 'TMOUT': '86400', 13:17:38 INFO - 'USER': 'cltbld', 13:17:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:38 INFO - '_': '/tools/buildbot/bin/python'} 13:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 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 13:17:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:17:40 INFO - Installing collected packages: mozsystemmonitor 13:17:40 INFO - Running setup.py install for mozsystemmonitor 13:17:40 INFO - Successfully installed mozsystemmonitor 13:17:40 INFO - Cleaning up... 13:17:41 INFO - Return code: 0 13:17:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:17:41 INFO - Using env: {'DISPLAY': ':0', 13:17:41 INFO - 'HOME': '/home/cltbld', 13:17:41 INFO - 'LANG': 'en_US.UTF-8', 13:17:41 INFO - 'LANGUAGE': 'en_US:en', 13:17:41 INFO - 'LOGNAME': 'cltbld', 13:17:41 INFO - 'MAIL': '/var/mail/cltbld', 13:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:41 INFO - 'MOZ_NO_REMOTE': '1', 13:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:41 INFO - 'NO_EM_RESTART': '1', 13:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:41 INFO - 'PWD': '/builds/slave/test', 13:17:41 INFO - 'SHELL': '/bin/bash', 13:17:41 INFO - 'SHLVL': '1', 13:17:41 INFO - 'TERM': 'linux', 13:17:41 INFO - 'TMOUT': '86400', 13:17:41 INFO - 'USER': 'cltbld', 13:17:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:41 INFO - '_': '/tools/buildbot/bin/python'} 13:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:41 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 13:17:41 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 13:17:41 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 13:17:41 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 13:17:41 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 13:17:41 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 13:17:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 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 13:17:43 INFO - Downloading docopt-0.6.1.tar.gz 13:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:43 INFO - Running setup.py install for blobuploader 13:17:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:43 INFO - Running setup.py install for requests 13:17:44 INFO - Running setup.py install for docopt 13:17:44 INFO - Successfully installed blobuploader requests docopt 13:17:44 INFO - Cleaning up... 13:17:44 INFO - Return code: 0 13:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:44 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:44 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 13:17:44 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 13:17:44 INFO - Using env: {'DISPLAY': ':0', 13:17:44 INFO - 'HOME': '/home/cltbld', 13:17:44 INFO - 'LANG': 'en_US.UTF-8', 13:17:44 INFO - 'LANGUAGE': 'en_US:en', 13:17:44 INFO - 'LOGNAME': 'cltbld', 13:17:44 INFO - 'MAIL': '/var/mail/cltbld', 13:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:44 INFO - 'MOZ_NO_REMOTE': '1', 13:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:44 INFO - 'NO_EM_RESTART': '1', 13:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:44 INFO - 'PWD': '/builds/slave/test', 13:17:44 INFO - 'SHELL': '/bin/bash', 13:17:44 INFO - 'SHLVL': '1', 13:17:44 INFO - 'TERM': 'linux', 13:17:44 INFO - 'TMOUT': '86400', 13:17:44 INFO - 'USER': 'cltbld', 13:17:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:44 INFO - '_': '/tools/buildbot/bin/python'} 13:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:44 INFO - Running setup.py (path:/tmp/pip-A4FXG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:44 INFO - Running setup.py (path:/tmp/pip-U89f3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:44 INFO - Running setup.py (path:/tmp/pip-wkf9vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:44 INFO - Running setup.py (path:/tmp/pip-7Zt47H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:44 INFO - Running setup.py (path:/tmp/pip-Oa1m6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:45 INFO - Running setup.py (path:/tmp/pip-gG00_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:45 INFO - Running setup.py (path:/tmp/pip-w1v1_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:45 INFO - Running setup.py (path:/tmp/pip-LoTRO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:45 INFO - Running setup.py (path:/tmp/pip-0tMed4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:45 INFO - Running setup.py (path:/tmp/pip-ko4S8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:45 INFO - Running setup.py (path:/tmp/pip-bZVCHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:45 INFO - Running setup.py (path:/tmp/pip-jM8vqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:45 INFO - Running setup.py (path:/tmp/pip-5ky6q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:45 INFO - Running setup.py (path:/tmp/pip-g70PL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:45 INFO - Running setup.py (path:/tmp/pip-zB98mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:45 INFO - Running setup.py (path:/tmp/pip-SmHyiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:45 INFO - Running setup.py (path:/tmp/pip-b7J6d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:45 INFO - Running setup.py install for manifestparser 13:17:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozcrash 13:17:46 INFO - Running setup.py install for mozdebug 13:17:46 INFO - Running setup.py install for mozdevice 13:17:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozfile 13:17:46 INFO - Running setup.py install for mozhttpd 13:17:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozinfo 13:17:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozInstall 13:17:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozleak 13:17:46 INFO - Running setup.py install for mozlog 13:17:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for moznetwork 13:17:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Running setup.py install for mozprocess 13:17:47 INFO - Running setup.py install for mozprofile 13:17:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Running setup.py install for mozrunner 13:17:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Running setup.py install for mozscreenshot 13:17:47 INFO - Running setup.py install for moztest 13:17:47 INFO - Running setup.py install for mozversion 13:17:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:47 INFO - Cleaning up... 13:17:47 INFO - Return code: 0 13:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:47 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 13:17:47 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 13:17:47 INFO - Using env: {'DISPLAY': ':0', 13:17:47 INFO - 'HOME': '/home/cltbld', 13:17:47 INFO - 'LANG': 'en_US.UTF-8', 13:17:47 INFO - 'LANGUAGE': 'en_US:en', 13:17:47 INFO - 'LOGNAME': 'cltbld', 13:17:47 INFO - 'MAIL': '/var/mail/cltbld', 13:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:47 INFO - 'MOZ_NO_REMOTE': '1', 13:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:47 INFO - 'NO_EM_RESTART': '1', 13:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:47 INFO - 'PWD': '/builds/slave/test', 13:17:47 INFO - 'SHELL': '/bin/bash', 13:17:47 INFO - 'SHLVL': '1', 13:17:47 INFO - 'TERM': 'linux', 13:17:47 INFO - 'TMOUT': '86400', 13:17:47 INFO - 'USER': 'cltbld', 13:17:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:47 INFO - '_': '/tools/buildbot/bin/python'} 13:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:47 INFO - Running setup.py (path:/tmp/pip-iyFl9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:47 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)) 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:47 INFO - Running setup.py (path:/tmp/pip-rtlDHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:48 INFO - Running setup.py (path:/tmp/pip-EGWfbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:48 INFO - Running setup.py (path:/tmp/pip-0g6lnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:48 INFO - Running setup.py (path:/tmp/pip-HLffk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:48 INFO - Running setup.py (path:/tmp/pip-p30QVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:48 INFO - Running setup.py (path:/tmp/pip-xfN8g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:48 INFO - Running setup.py (path:/tmp/pip-DqkPrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:48 INFO - Running setup.py (path:/tmp/pip-GrQo2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:48 INFO - Running setup.py (path:/tmp/pip-T0WPnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:48 INFO - Running setup.py (path:/tmp/pip-XlvMMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:48 INFO - Running setup.py (path:/tmp/pip-JaHLBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:48 INFO - Running setup.py (path:/tmp/pip-updc_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:48 INFO - Running setup.py (path:/tmp/pip-Bk5Mgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:48 INFO - Running setup.py (path:/tmp/pip-I3Ljwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:48 INFO - Running setup.py (path:/tmp/pip-LyGIhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:49 INFO - Running setup.py (path:/tmp/pip-fjlndW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:50 INFO - Downloading blessings-1.6.tar.gz 13:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:51 INFO - Installing collected packages: blessings 13:17:51 INFO - Running setup.py install for blessings 13:17:51 INFO - Successfully installed blessings 13:17:51 INFO - Cleaning up... 13:17:51 INFO - Return code: 0 13:17:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:51 INFO - Reading from file tmpfile_stdout 13:17:51 INFO - Current package versions: 13:17:51 INFO - argparse == 1.2.1 13:17:51 INFO - blessings == 1.6 13:17:51 INFO - blobuploader == 1.2.4 13:17:51 INFO - docopt == 0.6.1 13:17:51 INFO - manifestparser == 1.1 13:17:51 INFO - mozInstall == 1.12 13:17:51 INFO - mozcrash == 0.17 13:17:51 INFO - mozdebug == 0.1 13:17:51 INFO - mozdevice == 0.48 13:17:51 INFO - mozfile == 1.2 13:17:51 INFO - mozhttpd == 0.7 13:17:51 INFO - mozinfo == 0.9 13:17:51 INFO - mozleak == 0.1 13:17:51 INFO - mozlog == 3.1 13:17:51 INFO - moznetwork == 0.27 13:17:51 INFO - mozprocess == 0.22 13:17:51 INFO - mozprofile == 0.28 13:17:51 INFO - mozrunner == 6.11 13:17:51 INFO - mozscreenshot == 0.1 13:17:51 INFO - mozsystemmonitor == 0.0 13:17:51 INFO - moztest == 0.7 13:17:51 INFO - mozversion == 1.4 13:17:51 INFO - psutil == 3.1.1 13:17:51 INFO - requests == 1.2.3 13:17:51 INFO - wsgiref == 0.1.2 13:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:51 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 13:17:51 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 13:17:51 INFO - Using env: {'DISPLAY': ':0', 13:17:51 INFO - 'HOME': '/home/cltbld', 13:17:51 INFO - 'LANG': 'en_US.UTF-8', 13:17:51 INFO - 'LANGUAGE': 'en_US:en', 13:17:51 INFO - 'LOGNAME': 'cltbld', 13:17:51 INFO - 'MAIL': '/var/mail/cltbld', 13:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:51 INFO - 'MOZ_NO_REMOTE': '1', 13:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:51 INFO - 'NO_EM_RESTART': '1', 13:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:51 INFO - 'PWD': '/builds/slave/test', 13:17:51 INFO - 'SHELL': '/bin/bash', 13:17:51 INFO - 'SHLVL': '1', 13:17:51 INFO - 'TERM': 'linux', 13:17:51 INFO - 'TMOUT': '86400', 13:17:51 INFO - 'USER': 'cltbld', 13:17:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:51 INFO - '_': '/tools/buildbot/bin/python'} 13:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 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)) 13:17:51 INFO - Cleaning up... 13:17:51 INFO - Return code: 0 13:17:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:51 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:51 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 13:17:51 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 13:17:51 INFO - Using env: {'DISPLAY': ':0', 13:17:51 INFO - 'HOME': '/home/cltbld', 13:17:51 INFO - 'LANG': 'en_US.UTF-8', 13:17:51 INFO - 'LANGUAGE': 'en_US:en', 13:17:51 INFO - 'LOGNAME': 'cltbld', 13:17:51 INFO - 'MAIL': '/var/mail/cltbld', 13:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:51 INFO - 'MOZ_NO_REMOTE': '1', 13:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:51 INFO - 'NO_EM_RESTART': '1', 13:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:51 INFO - 'PWD': '/builds/slave/test', 13:17:51 INFO - 'SHELL': '/bin/bash', 13:17:51 INFO - 'SHLVL': '1', 13:17:51 INFO - 'TERM': 'linux', 13:17:51 INFO - 'TMOUT': '86400', 13:17:51 INFO - 'USER': 'cltbld', 13:17:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:51 INFO - '_': '/tools/buildbot/bin/python'} 13:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:51 INFO - Downloading/unpacking jsonschema 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:53 INFO - Downloading/unpacking functools32 (from jsonschema) 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:54 INFO - warning: no files found matching '*.txt' 13:17:54 INFO - no previously-included directories found matching 'build' 13:17:54 INFO - no previously-included directories found matching 'dist' 13:17:54 INFO - no previously-included directories found matching '.git*' 13:17:54 INFO - Installing collected packages: jsonschema, functools32 13:17:54 INFO - Running setup.py install for functools32 13:17:54 INFO - warning: no files found matching '*.txt' 13:17:54 INFO - no previously-included directories found matching 'build' 13:17:54 INFO - no previously-included directories found matching 'dist' 13:17:54 INFO - no previously-included directories found matching '.git*' 13:17:54 INFO - Successfully installed jsonschema functools32 13:17:54 INFO - Cleaning up... 13:17:54 INFO - Return code: 0 13:17:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:54 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 0x7f4a81a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', '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 13:17:54 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 13:17:54 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 13:17:54 INFO - Using env: {'DISPLAY': ':0', 13:17:54 INFO - 'HOME': '/home/cltbld', 13:17:54 INFO - 'LANG': 'en_US.UTF-8', 13:17:54 INFO - 'LANGUAGE': 'en_US:en', 13:17:54 INFO - 'LOGNAME': 'cltbld', 13:17:54 INFO - 'MAIL': '/var/mail/cltbld', 13:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:54 INFO - 'MOZ_NO_REMOTE': '1', 13:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:54 INFO - 'NO_EM_RESTART': '1', 13:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:54 INFO - 'PWD': '/builds/slave/test', 13:17:54 INFO - 'SHELL': '/bin/bash', 13:17:54 INFO - 'SHLVL': '1', 13:17:54 INFO - 'TERM': 'linux', 13:17:54 INFO - 'TMOUT': '86400', 13:17:54 INFO - 'USER': 'cltbld', 13:17:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:54 INFO - '_': '/tools/buildbot/bin/python'} 13:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:54 INFO - Downloading/unpacking flake8 13:17:54 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 13:17:54 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 13:17:54 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 13:17:54 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 13:17:54 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 13:17:54 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 13:17:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:17:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:17:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:17:56 INFO - no previously-included directories found matching 'docs/_build' 13:17:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:17:57 INFO - Running setup.py install for pep8 13:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:17:57 INFO - no previously-included directories found matching 'docs/_build' 13:17:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:17:57 INFO - Cleaning up... 13:17:57 INFO - Return code: 0 13:17:57 INFO - Running post-action listener: _resource_record_post_action 13:17:57 INFO - Running post-action listener: _start_resource_monitoring 13:17:57 INFO - Starting resource monitoring. 13:17:57 INFO - ##### 13:17:57 INFO - ##### Running install step. 13:17:57 INFO - ##### 13:17:57 INFO - Running pre-action listener: _resource_record_pre_action 13:17:57 INFO - Running main action method: install 13:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:57 INFO - Reading from file tmpfile_stdout 13:17:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:57 INFO - Reading from file tmpfile_stdout 13:17:57 INFO - Output received: 13:17:57 INFO - Usage: mozinstall [options] installer 13:17:57 INFO - Options: 13:17:57 INFO - -h, --help show this help message and exit 13:17:57 INFO - -d DEST, --destination=DEST 13:17:57 INFO - Directory to install application into. [default: 13:17:57 INFO - "/builds/slave/test"] 13:17:57 INFO - --app=APP Application being installed. [default: firefox] 13:17:57 INFO - mkdir: /builds/slave/test/build/application 13:17:57 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'] 13:17:57 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 13:18:13 INFO - Reading from file tmpfile_stdout 13:18:13 INFO - Output received: 13:18:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:18:13 INFO - Running post-action listener: _resource_record_post_action 13:18:13 INFO - ##### 13:18:13 INFO - ##### Running run-tests step. 13:18:13 INFO - ##### 13:18:13 INFO - Running pre-action listener: _resource_record_pre_action 13:18:13 INFO - Running main action method: run_tests 13:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:13 INFO - Python 2.7.3 13:18:13 INFO - Return code: 0 13:18:13 INFO - grabbing minidump binary from tooltool 13:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:13 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 0x1794410>, '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 0x1795310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17957a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:13 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 13:18:13 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 13:18:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:13 INFO - Return code: 0 13:18:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:18:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:18:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:18:14 INFO - Return code: 0 13:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:18:14 INFO - Using env: {'DISPLAY': ':0', 13:18:14 INFO - 'HOME': '/home/cltbld', 13:18:14 INFO - 'LANG': 'en_US.UTF-8', 13:18:14 INFO - 'LANGUAGE': 'en_US:en', 13:18:14 INFO - 'LOGNAME': 'cltbld', 13:18:14 INFO - 'MAIL': '/var/mail/cltbld', 13:18:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:14 INFO - 'MOZ_NO_REMOTE': '1', 13:18:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:14 INFO - 'NO_EM_RESTART': '1', 13:18:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:14 INFO - 'PWD': '/builds/slave/test', 13:18:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:14 INFO - 'SHELL': '/bin/bash', 13:18:14 INFO - 'SHLVL': '1', 13:18:14 INFO - 'TERM': 'linux', 13:18:14 INFO - 'TMOUT': '86400', 13:18:14 INFO - 'USER': 'cltbld', 13:18:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052', 13:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:14 INFO - '_': '/tools/buildbot/bin/python'} 13:18:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:18:14 INFO - mozversion application_buildid: 20160419123832 13:18:14 INFO - mozversion application_changeset: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 13:18:14 INFO - mozversion application_display_name: Nightly 13:18:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:14 INFO - mozversion application_name: Firefox 13:18:14 INFO - mozversion application_remotingname: firefox 13:18:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:18:14 INFO - mozversion application_vendor: Mozilla 13:18:14 INFO - mozversion application_version: 48.0a1 13:18:14 INFO - mozversion platform_buildid: 20160419123832 13:18:14 INFO - mozversion platform_changeset: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 13:18:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:18:14 INFO - mozversion platform_version: 48.0a1 13:18:14 INFO - using testdate: 1461097094 13:18:14 INFO - actual date: 1461097094 13:18:14 INFO - starting webserver on 'localhost:51222' 13:18:14 INFO - SUITE-START | Running 2 tests 13:18:14 INFO - TEST-START | dromaeo_css 13:18:14 INFO - operating with platform_type : linux_ 13:18:14 INFO - Initialising browser for dromaeo_css test... 13:18:14 INFO - TEST-INFO | started process 25254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwRxGBL/profile http://localhost:51222/getInfo.html) 13:18:19 INFO - PROCESS | 25254 | __metrics Screen width/height:1600/1200 13:18:19 INFO - PROCESS | 25254 | colorDepth:24 13:18:19 INFO - PROCESS | 25254 | Browser inner width/height: 1024/697 13:18:19 INFO - PROCESS | 25254 | __metrics 13:18:20 ERROR - PROCESS | 25254 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:18:21 INFO - TEST-INFO | 25254: exit 0 13:18:21 INFO - Browser initialized. 13:18:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:21 INFO - TEST-INFO | started process 25336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwRxGBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:33 INFO - PROCESS | 25336 | RSS: Main: 154562560 13:18:33 INFO - PROCESS | 25336 | 13:19:24 INFO - PROCESS | 25336 | 1461097164378 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] 13:21:36 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51222/tests/dromaeo/cssquery-ext.html) 13:21:37 INFO - PROCESS | 25336 | RSS: Main: 236826624 13:21:37 INFO - PROCESS | 25336 | 13:24:40 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-ext.html (next: http://localhost:51222/tests/dromaeo/cssquery-jquery.html) 13:24:40 INFO - PROCESS | 25336 | RSS: Main: 237412352 13:24:40 INFO - PROCESS | 25336 | 13:27:42 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51222/tests/dromaeo/cssquery-mootools.html) 13:27:43 INFO - PROCESS | 25336 | RSS: Main: 244477952 13:27:43 INFO - PROCESS | 25336 | 13:30:45 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51222/tests/dromaeo/cssquery-prototype.html) 13:30:46 INFO - PROCESS | 25336 | RSS: Main: 232812544 13:30:46 INFO - PROCESS | 25336 | 13:33:49 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51222/tests/dromaeo/cssquery-yui.html) 13:33:49 INFO - PROCESS | 25336 | RSS: Main: 219320320 13:33:49 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-yui.html (next: http://localhost:51222/tests/dromaeo/cssquery-dojo.html) 13:36:52 INFO - PROCESS | 25336 | RSS: Main: 272773120 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | __start_tp_report 13:36:52 INFO - PROCESS | 25336 | _x_x_mozilla_page_load 13:36:52 INFO - PROCESS | 25336 | _x_x_mozilla_page_load_details 13:36:52 INFO - PROCESS | 25336 | |i|pagename|runs| 13:36:52 INFO - PROCESS | 25336 | |0;dojo.html;2570.1390034338497;2650.204938518444;2659.188947371051;2659.228823641144;2682.7585517303437;4551.089782043588;4618.8152473901;4634.1658501469765;4648.0239149778545;4670.416197975257;4590.196715574778;4665.486796452387;4714.481407045222;4743.90512189756;4752.76236188191;4242.681798865082;4273.316269396897;4277.55085716;4330.761808100553;4356.085222103362;4300.204462174492;4328.372386004027;4377.299632058871;4404.361367601696;4409.118176364724;4208.894777630553;4267.829286828523;4333.133373325316;4369.1916995355805;4374.803133858953;4206.558311377292;4230.048239146198;4230.21740977917;4232.492100947875;4233.111046680201;4188.183304255671;4204.1801848639525;4206.558311377292;4212.241796476633;4218.557051509578;4497.280435130363;4525.072360166158;4553.476350219734;4577.359169716243;4579;4969.627277954168;4978.253262010691;4983.401991760976;4988.850334489971;5027.949720502821;4829.613630909554;5004.424491183488;5005.924911126336;5017.6989380636915;5021.322121513585;4637.6289896808175;4675.2052151134385;4738.47876733559;4746.406699162605;4748.121597504472;5106.285120083191;5113.233015047773;5135.281060651511;5160.071187186342;5199.4020687621405;4768.189407800613;4918.311436398907;4936.8765780855765;4943.431505376856;4984.37695288089;4995.825146119869;5041.218611115283;5054.924176137288;5100.030994111107;5114.693118412907;4856.247281671346;4862.635302352338;4870.488598697157;4884.731339776346;4920.188168952154;4776.5701086902345;4842.5157484251295;4881.536254055859;4883.389576302962;4920.163572192664;4249.702520823513;4255.744655320629;4267.210566045292;4313.137372525507;4329.372241025034;3731.384321586908;3732.6080761520193;3742.045778326509;3742.812859357076;3774.7168962327387;4134.462519872397;4223.408722778813;4306.354046892991;4311.396404503372;4328.5022222444195;4897.191963326082;4900.705957642553;4904.411470623548;4946.950530494721;4959.851204463872;4186.895327616834;4192.706510544293;4202.894927626834;4229;4231.069164783743;4318.611324980767;4430.246858034142;4443.666724995638;4474.127545128668;4541;4677.391939047902;4678.649101317346;4687.765611719332;4694.248920172756;4727.3854398927915;4993.750312484434;4998.60011199096;5001.1498045331655;5016.448190699093;5060.569851562511;4510.030343476168;4664.813407463664;4674.859754207379;4727.456342520654;4739.1706451371565;4882.584980276716;4887.584555312838;4903.754812259444;4905.558499735041;4916.8770780730765;4945.876353091057;4967.40391153064;4970.577500912463;4978.47725988766;5019.297298378157;4692.48382677912;4811;4850.684705494132;4879.926801098058;4883.511648835088;4798.808047678193;4809.591184749335;4810.39870016248;4829.251466022772;4874.975625121851;4569.200389931682;4749.311349854321;4764.380630518011;4780.211265141213;4828.782704778364;4837.129316723023;4880.707157570557;4881.8535443936735;4915.803367865388;4929.457759646364;4747.83382581608;4773.307870358848;4777.665563410528;4782.760861956958;4822.059698358787 13:36:52 INFO - PROCESS | 25336 | |1;ext.html;611.7430679114773;615.4092071611253;619.8047615001274;625.1029772276781;629.3517676792904;34077;35507.2898542029;35567.644323556786;35613.82193089034;35736.642633573654;37841.62158378415;38462.80768596153;38788.41817372742;38801.22397552047;38850.8057459713;7553.509021913572;7746.0317460317465;7751.651175697107;7752.844943101163;7753.185915478878;7679.155292917774;7778.261065198825;7790.182030886732;7848.843023139534;7867.763967080997;7884.487508311941;7946.086200087007;7948.960255198745;7952.840943181133;7957.0451545814585;7834;7915;7949.523028618301;7949.523028618301;7968.561729104897;7870.567118808463;7925.564093974829;7955.721549745731;7967.8406431871035;7974.162712915118;37708;38240.04399889997;38248;38269.23461530754;38274.61725382738;3064.9233769155726;3185;3263.689949454798;3338.098713347407;3504.176518518146;28403.738354944635;29107.417851642847;29293.56059659107;29599;29651.40697186066;3285.4250506161325;3340.9498857517156;3361.865525379006;3382.695557399821;3388.0513456232293;197457;199208.00395998074;199470;199753;199986;32895.83552082272;51860.48139518632;52348;52422.47577524252;52492;32196;32417;32426.351472970407;32464.188395290308;32468.350632987207;12048.87951120495;12218.32799196035;12267.938660306641;12320.568780092834;12344.506219751109;10134.493275336205;10232.079112879877;10248.59005639781;10316.793664126675;10337.844932326021;7993.560354180576;8169.223923727236;8211.630476628447;8226.05400378964;8253.95873020631;3175.301433684586;3207.9839600802316;3209.406259841937;3223.2103134732142;3264.3144939562485;868.4224990381325;901.454619954931;950.3157726436955;954.398728800851;1003.1673710820002;26714;28288.858555707502;28687.426251474855;28933.85533072321;28940.565891511644;965.9613615455444;974.1670871404989;976.9023097690316;985.3250523391499;1080.3517889266534;14836.406543738345;14924.17917014553;15147.242637868063;15304.464343747915;15419.383224670888;346764;350176;355214;355682;357454;49186.26220606694;50108;50133.74933125311;50139.49860501421;50185.74907125441;1060.6605886116522;1154.3016475032653;1193.2959553863263;1226.4358395138336;1277.2847205564728;25401.364965876;28147.15558533247;28272.701374901982;28361.29096772597;28574.42851143007;39767.60232397639;39972;40376.79811600923;40390.39414408845;40487;235950;236049;238271;238693;239239;23254.186103486296;25746.613800792627;25856.741432585433;26175.214743557724;26205.86897065579;37016.62983370132;40167;40331.1933761329;40771;41330.173396531296;32944.83527582347;33626.66373336235;34284.48573271453;34551.65448345484;34743.30513389769;33942;34219;34289.828550857084;34667.4799877997;34730.47904281387;31265;32104.67895321017;34363.31273374568;34727.13182170466;36923.446148308336;27242.096422644114;31260.843695782285;31305;31312.64201353415;31321.37357252888;23694.289171324886;23864.522709545363;24203.031878725356;24219.39451513656;24252.1511747088 13:36:52 INFO - PROCESS | 25336 | |2;jquery.html;384.99132273443576;385.52965382233674;387.89526827756487;400.4053979839939;403.7416053725614;15396.384144634216;16114.194290285497;16299.51101466955;16317.673646527062;16330.183490825471;16681.249343779527;16756.162191890387;16894.53905812746;17116.572085697862;17144.82855171448;5151.278820965059;5291.100512912814;5315.574754019669;5324.520793128618;5330.600204984622;3610.368185567528;5554.1391084381985;5953.166556682068;5988.700564971756;5999.160117583542;5860.941390586104;5897.498712609433;5922.230110085704;5935.703214839241;5958.821235362946;5838.386969368219;5991.700414979277;5992.041273396236;6021.548383871227;6033.637981721089;3345.8159801210923;3527.770694904823;3536.876209332661;3537.8054207018604;4884.29177769225;19828.60342793136;20405.693914591295;20606.381808545768;20620.69068963967;20677.5864482711;1985.602879424121;1986.920523179071;2028.6247044296704;2042.8774273543636;2309.56118337517;12454.564090256888;13278.800817987738;13317.733645327136;13733.107348022346;13807;1773.4768243368108;1830.6338732253469;1850.3616252392903;1857.0250618425434;1909.9140538675792;66157;66406.33593664049;67299;67760.6611966937;68470;9526.571304291323;9549.427034377959;10086.44524551142;10167;10178.643747468803;13638.795418068737;13697.726045479034;13723.45106195741;13753.312334383241;13781.51764688231;7127;7183.640817959081;7196.820079498055;7225.819354516179;7293.562386256842;6759.831004224934;6776.220734615484;6779.35596118368;6921.48088893335;6929.757458488929;6210.378962103844;6224.914653591007;6240.563160578807;6263.279722831841;6275.403836635513;1607.9517614471586;1691.112166112776;1765.2083135617358;1774.210476338017;1811.424061066854;799.8960135182389;904.3217586809892;957.9760505987406;989.3766926836047;1032.7934413117407;15268.923655381652;15870.841291587167;16382.672346553003;16479.670406592042;16661.50015499537;916.8578870274985;920.3143657974717;935.1163150822543;941.1999800169801;941.3975055964188;9810.091807274704;9983.550740216708;9984.850227246598;10088.243381746399;10205.234607404474;372725;374969;378602;392862;399889;69819.65090174516;70765.2923470769;72327;72346.63826680939;73208;944.2917811641269;988.2291812386206;1002.0480543483719;1007.7984403119406;1008.0625018732502;15116.319765610793;15762.290696918437;15990.760138597698;15998.520044398687;16144.1927903602;35781.10547236236;35798.105047374025;36372.63627363693;36409.817950910074;36503.63496365002;46560.53439465698;51592.48407515877;51939.740301298254;52049.479505204465;52283;7780.766577002699;7946.125926148235;8052.677892884219;8063.113057563781;8099.14958929304;10720.571177152826;11395;11643.301401915913;11805;11870.703232419259;7929.444938854455;10087.495625218562;10566.780975995127;10633.20250981195;10824.729381765204;10558.577656893638;10705.89294107049;10794.190435717195;10991.670249892515;11132.109431245319;10518.737031573966;10806.405647689138;10929.18031147683;10936.781264374828;11135.33188008722;7412.777616671508;7761.068671759425;7847.450678452682;7867.645955931882;8008.199180081945;9453.527323633929;10739.945041219085;10773.73065673333;10805.906210644343;10814.29707069038 13:36:52 INFO - PROCESS | 25336 | |3;mootools.html;1282.9550965716203;1460.1822979131687;1509.5546813689962;1662.4015354472388;1807.8372946434827;6605.27341992381;7790.18203088676;7975.880361794578;8024.43828931975;8050.154733752959;7759.767206983785;7814.8046298842555;7881;7910.564918929456;7915.643796029178;1877.0427082188046;2185.9562808743817;2222.766609505999;2249.2689875790434;2261.739899911515;2235.3629215673536;2252.977470225301;2253.571821353946;2255.289583781112;2255.9661605075935;2153.720016397866;2187.1142187414043;2192.4299682082615;2193.7696541863115;2193.7915897989665;1762.488878225313;2191.222116148776;2246.4383904023994;2255.751867294596;2260.2541161416693;2128.382768996989;2135.2099723102397;2138.4440045588103;2156.5040040790705;2200.3728937252804;7672.386209103258;7780.961095194544;7803.531788092732;7806.219378062206;7809.687612495493;4499.460064792246;4608.147492713825;4618.330342100377;4633.582977532004;4673.228917228653;2909.912702618925;2910.1124157132067;2981.731644152015;2985.7611391088662;3000.294930691286;904.7285814255697;929.1173385284008;942.4392486470539;943.5093751249381;965.2181732796457;10445.119878421805;10469.84295235572;10474.738131546696;10478.790424191473;10486.842697359545;4005.6795456364002;4124.298869192245;4237.309308589068;4252.170826688828;4272.5727427257025;8933.15135062168;8986.595603197871;8994.325425592975;8996.145366190201;9009.594568244445;4135.234981528427;4622.537746225351;4624.653151013687;4638.6752927294765;4656.32483289921;4159.584041595876;4239.25812982733;4239.703220774516;4269.5516970718245;4277.679174061957;3743.9064023399633;3752.774833509998;3820;3841.8463261469788;3856.845726170922;1252.7619752247044;1254.3038613569374;1261.3630116791146;1266.4237771813803;1272.077743635875;702.8840241360118;732.4104096202501;836.8368168207263;849.9915000849912;870.2298465857635;5187.688738675692;5244.868878278074;5278.129108697099;5284.233786100994;5341.278927344836;861.793169639282;875.6847534887436;904.4934836491586;905.2441211588266;917.8164367126468;3638.6179451157245;3666.3767159582935;3677.742558020913;3697.5932647408763;3702.8148592570265;9439.150476457151;10024.599016039423;10043.045910638477;10106.494675266207;10114.848277275847;9753.609855605697;9903.405795652285;9910.35582687123;9916.157126644172;9921.057499537532;7601.46789724725;7624.237576242443;7666.4633475656165;7692.499987500794;7753.418493613001;5154.561862241601;5260.421353651172;5316.813911513079;5450.5912056595125;5515.090010148441;9239.815203696024;9307.76730581741;9335.486548239913;9458.479783611692;9475.52622368865;8802.86795698078;9184.632614695338;9406.482643454676;9507.524623768646;9642.084002019797;6211.81364559064;6728.889733193968;6832.248452670103;6900.896486552806;7076.363127318566;7649.349805266615;7709.99770029915;7742.922570774445;7749.961250193713;7756.379489640928;6658.400743933069;6840.042394064735;6848;6948.513604047668;6976.511644184859;6867.969804529361;6871.347222013901;6885.139357580302;7017.403520700797;7019.859602808017;6470.094186813756;6470.579412338183;6474.352564743488;6507.186601674791;6553.2136143661155;4679.087577922272;4781.043791241835;4786.329913811999;4799.1601469743355;4824.734639594856;4712.222483290218;4791;4797.856064318076;4804.855854324376;4859.198232291632 13:36:52 INFO - PROCESS | 25336 | |4;prototype.html;318.37598307317654;318.4697478697968;319.2656889154943;322.8159948829167;324.37881457009826;5072.391313042435;5073.949260507394;5116.744162791855;5127.846164615058;5134.306868572741;5031.672941258816;5035.874103147414;5046.697198168113;5046.899062018758;5073.974630126853;3713.8143092845316;3795.804321638675;3962.9801850990702;3979.1842672252264;3985.521737391517;3957.821898014582;3962;3970.1464185200175;3971.62269584389;3972.510308634262;3706.4440333949856;3924.489816323874;3935.3703407454814;3944.704147188958;3947.1118998225456;3820.9044773880737;3940.876850097737;3941.8423263069444;3945.11234972129;3952.6245006724457;3473.9131521711906;3497.265574229415;3503.6861177058604;3509.403401421739;3510.613832478425;4809.831655892027;4831.396075490564;4832.202686556714;4835.371401717754;4836.540528649808;4184.937225941613;4451.421315229032;4452.332150177467;4470.26240670289;4537.977310113428;5193.506616871391;5217.3217481727515;5231.241469986869;5243.161094224905;5248.6091185835785;3712.3132220539287;3715.4612581175847;3719.2189640175598;3728.608496107897;3734.0314450012306;5309.575233981311;5496.642718223303;5552.139418390156;5557.916631250494;5603.187537806995;3795.6773674237998;3811.123441608446;3840.9231815363537;3852.2295540891932;3859.691224702073;3894;3895.182011777502;3901.843926242975;3903.4730311408166;3904.590018048121;4331.631811296075;4430.87012811731;4441.777911104432;4453.977730111329;4488.483824360175;5327.627066105335;5361.115415956324;5365.517103460629;5366.570674346043;5373.838784836461;1387.549046559872;1406.7116241170536;1407.3877863129571;1412.7951447040123;1413.5264686330195;875.785432569012;954.2604481526872;973.7078876337071;984.7587341101475;993.0863605482829;4576.816927322936;4584.060267645124;4595.471520775153;4601.677882548256;4604.102200071021;5391.4338994405025;5403.486668766461;5404.3784964728775;5405.243265942771;5428.782848686008;4437.64498840092;4589.449266088024;4608.769561521911;4613.677042606985;4615.676902616785;2861.31328481163;2881.6109825173753;2893.146521776039;2894.088362165911;2900.5787164289345;5072.923906141411;5074.746262686851;5094.15946368845;5109.846704598868;5114.846554603368;5417.052015897202;5556.111022236503;5575.972120139454;5666.575006874501;5713.942860571424;5161.53546180853;5177.404598471148;5193.272941788077;5196.350456192976;5212.582993360522;5505.174223866452;5511.58663100261;5528.944710552843;5532.114861622121;5550.833474995757;5247.501487358695;5431.5926305526455;5439.129739241703;5462.098753705753;5466.594698332721;5166.199239117943;5166.767495462788;5173.32746742921;5174.223866419917;5176.042432150064;3785.1104990327804;3797.9810100949317;3801.4677945088265;3808.638179372955;3809.828557714854;5405.324334458192;5431.234848674276;5468.972655136698;5494.2033405155225;5495.148252020783;5236.659617124875;5277.577793776565;5314.867128321823;5320.866978325573;5339.225812257123;5104.668196567211;5324.254604355471;5326.414094449685;5327.600429967845;5338.839834804962;5016.488458079286;5231.267622532772;5239.318888544465;5242.764075616683;5246.76389562463;5151.072806894795;5310.468953104813;5352.6448362720275;5357;5369.597280204079;5206.271122042993;5206.427292997843;5212.921806172986;5217.426083130928;5234.2933703951 13:36:52 INFO - PROCESS | 25336 | |5;yui.html;594.7539903901327;610.27124270706;679.5175425447932;690.7824035428839;695.3359541637733;11886.940565297184;11909;12061.758764824699;12084.093692973018;12105.031597472214;11611.535538578468;11688.123390745686;11702.297862128278;11702.707432314175;11762.823557646641;635.16475834278;792.4690457393531;810.9675612975474;811.0510702478085;812.8049268175654;776.4564804636749;798.0981490915258;798.7124635131348;798.7763426240662;799.4044436894493;838.9454685445427;839.1566475691922;840.2185967050641;841.4572600672562;846.5174850335311;654.9901751473732;672.334388954936;828.9295409890136;829.2992421403904;836.0886633569409;498.3247699367341;605.6305653551331;629.7669862150988;630.533405280094;630.59956927351;12081.335526546036;12262;12337.383130843511;12352.25886446807;12433.813492797615;11050.392228427434;11317.83023254652;11349.262297950607;11501.884981150166;11744.354060526668;9208.12522810332;9294.953525232399;9321.114494123047;9497.382670126419;9504.524773761284;3178.570892929448;3223.597050368704;3244.78908870925;3257.153140183569;3270.035339574831;43423.348649770276;43450.56549434528;43555.56444435547;45688.08623827505;45944.3108353375;9469.66856160031;9508.809823803485;10109.34289271195;10119;10378;16897.408590699266;18592.721109183374;18696.158672859754;18710;18724.15741291645;6176.258848938156;6204.720787564571;6291;6294.65379404128;6383;3401.4897765334904;3478.3912815257736;3480.9477857832153;3496.59789124254;3652.6712595866497;2736.206500114984;2828.7736981041467;2833.8583070846375;2835.220314413553;2838.8438635875227;514.9098907691139;515.4896652314256;524.1247117314094;525.0627629681001;531.1183435497056;465.6763549333249;530.9840704778862;537.8843548636984;546.8058839112058;567.9687617181012;6966.860662786716;6985.685644146026;7051.541649792747;7441.218672039358;7689.577073260913;524.0750076115659;556.4546744190716;571.4285714285714;574.3022227993008;584.392232078642;3381.644927282649;3427.537282466835;3464.757466977338;3473.2532505511435;3494.371013217645;48492.75753621209;49886.50113498891;50166.74916625393;50694.239586406235;50694.49305506972;41826.79086604608;42252.57747422548;42395.57604423978;42723.35914961278;43906.56093439089;38737.80631096826;39348.40977385342;39532.604673953465;40156;40228.59771402307;7705.152433232228;7907.327877130509;7948.920510794818;8102.79743006406;8130.593470326578;27658.585121222794;28085.43829123365;28126.85936570304;28286.575701364083;28779.28051798722;35687.64312356843;35707.46438803472;38821.80589097036;39144.80427597958;39231;10768.784624307627;10819.891801081889;10916.945415272872;10957.726056848323;11329.093672506344;11573.710657233636;11724.120690948042;11879.287242765462;12162.391880406121;12243;10168.186545076524;10192.28653994243;10240.897591024292;10391.792164156826;10418.114460270961;9676;9695.22438204956;10003.849942250727;10143;10509.684709458423;10407.427591482541;10591.576336946437;10657.89342106569;11045.72385690332;11056.170787190831;9352.859707104262;9394.624215031323;9448.291378146529;9691.9030809691;9901.504924753877;8605.913940860512;9136.081422901265;9321;9348.906510934803;9375.953120234355 13:36:52 INFO - PROCESS | 25336 | __end_tp_report 13:36:52 INFO - PROCESS | 25336 | __start_cc_report 13:36:52 INFO - PROCESS | 25336 | _x_x_mozilla_cycle_collect,945 13:36:52 INFO - PROCESS | 25336 | __end_cc_report 13:36:52 INFO - PROCESS | 25336 | __startTimestamp1461098212806__endTimestamp 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | ------- Summary: start ------- 13:36:52 INFO - PROCESS | 25336 | Number of tests: 6 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | [#0] dojo.html Cycles:165 Average:4594.04 Median:4739.17 stddev:473.95 (10.0%) stddev-sans-first:448.03 13:36:52 INFO - PROCESS | 25336 | Values: 2570.1 2650.2 2659.2 2659.2 2682.8 4551.1 4618.8 4634.2 4648.0 4670.4 4590.2 4665.5 4714.5 4743.9 4752.8 4242.7 4273.3 4277.6 4330.8 4356.1 4300.2 4328.4 4377.3 4404.4 4409.1 4208.9 4267.8 4333.1 4369.2 4374.8 4206.6 4230.0 4230.2 4232.5 4233.1 4188.2 4204.2 4206.6 4212.2 4218.6 4497.3 4525.1 4553.5 4577.4 4579.0 4969.6 4978.3 4983.4 4988.9 5027.9 4829.6 5004.4 5005.9 5017.7 5021.3 4637.6 4675.2 4738.5 4746.4 4748.1 5106.3 5113.2 5135.3 5160.1 5199.4 4768.2 4918.3 4936.9 4943.4 4984.4 4995.8 5041.2 5054.9 5100.0 5114.7 4856.2 4862.6 4870.5 4884.7 4920.2 4776.6 4842.5 4881.5 4883.4 4920.2 4249.7 4255.7 4267.2 4313.1 4329.4 3731.4 3732.6 3742.0 3742.8 3774.7 4134.5 4223.4 4306.4 4311.4 4328.5 4897.2 4900.7 4904.4 4947.0 4959.9 4186.9 4192.7 4202.9 4229.0 4231.1 4318.6 4430.2 4443.7 4474.1 4541.0 4677.4 4678.6 4687.8 4694.2 4727.4 4993.8 4998.6 5001.1 5016.4 5060.6 4510.0 4664.8 4674.9 4727.5 4739.2 4882.6 4887.6 4903.8 4905.6 4916.9 4945.9 4967.4 4970.6 4978.5 5019.3 4692.5 4811.0 4850.7 4879.9 4883.5 4798.8 4809.6 4810.4 4829.3 4875.0 4569.2 4749.3 4764.4 4780.2 4828.8 4837.1 4880.7 4881.9 4915.8 4929.5 4747.8 4773.3 4777.7 4782.8 4822.1 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | [#1] ext.html Cycles:180 Average:41081.82 Median:34326.57 stddev:71374.34 (207.9%) stddev-sans-first:71509.88 13:36:52 INFO - PROCESS | 25336 | Values: 611.7 615.4 619.8 625.1 629.4 34077.0 35507.3 35567.6 35613.8 35736.6 37841.6 38462.8 38788.4 38801.2 38850.8 7553.5 7746.0 7751.7 7752.8 7753.2 7679.2 7778.3 7790.2 7848.8 7867.8 7884.5 7946.1 7949.0 7952.8 7957.0 7834.0 7915.0 7949.5 7949.5 7968.6 7870.6 7925.6 7955.7 7967.8 7974.2 37708.0 38240.0 38248.0 38269.2 38274.6 3064.9 3185.0 3263.7 3338.1 3504.2 28403.7 29107.4 29293.6 29599.0 29651.4 3285.4 3340.9 3361.9 3382.7 3388.1 197457.0 199208.0 199470.0 199753.0 199986.0 32895.8 51860.5 52348.0 52422.5 52492.0 32196.0 32417.0 32426.4 32464.2 32468.4 12048.9 12218.3 12267.9 12320.6 12344.5 10134.5 10232.1 10248.6 10316.8 10337.8 7993.6 8169.2 8211.6 8226.1 8254.0 3175.3 3208.0 3209.4 3223.2 3264.3 868.4 901.5 950.3 954.4 1003.2 26714.0 28288.9 28687.4 28933.9 28940.6 966.0 974.2 976.9 985.3 1080.4 14836.4 14924.2 15147.2 15304.5 15419.4 346764.0 350176.0 355214.0 355682.0 357454.0 49186.3 50108.0 50133.7 50139.5 50185.7 1060.7 1154.3 1193.3 1226.4 1277.3 25401.4 28147.2 28272.7 28361.3 28574.4 39767.6 39972.0 40376.8 40390.4 40487.0 235950.0 236049.0 238271.0 238693.0 239239.0 23254.2 25746.6 25856.7 26175.2 26205.9 37016.6 40167.0 40331.2 40771.0 41330.2 32944.8 33626.7 34284.5 34551.7 34743.3 33942.0 34219.0 34289.8 34667.5 34730.5 31265.0 32104.7 34363.3 34727.1 36923.4 27242.1 31260.8 31305.0 31312.6 31321.4 23694.3 23864.5 24203.0 24219.4 24252.2 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | [#2] jquery.html Cycles:180 Average:24086.83 Median:36456.73 stddev:63231.50 (173.4%) stddev-sans-first:63383.83 13:36:52 INFO - PROCESS | 25336 | Values: 385.0 385.5 387.9 400.4 403.7 15396.4 16114.2 16299.5 16317.7 16330.2 16681.2 16756.2 16894.5 17116.6 17144.8 5151.3 5291.1 5315.6 5324.5 5330.6 3610.4 5554.1 5953.2 5988.7 5999.2 5860.9 5897.5 5922.2 5935.7 5958.8 5838.4 5991.7 5992.0 6021.5 6033.6 3345.8 3527.8 3536.9 3537.8 4884.3 19828.6 20405.7 20606.4 20620.7 20677.6 1985.6 1986.9 2028.6 2042.9 2309.6 12454.6 13278.8 13317.7 13733.1 13807.0 1773.5 1830.6 1850.4 1857.0 1909.9 66157.0 66406.3 67299.0 67760.7 68470.0 9526.6 9549.4 10086.4 10167.0 10178.6 13638.8 13697.7 13723.5 13753.3 13781.5 7127.0 7183.6 7196.8 7225.8 7293.6 6759.8 6776.2 6779.4 6921.5 6929.8 6210.4 6224.9 6240.6 6263.3 6275.4 1608.0 1691.1 1765.2 1774.2 1811.4 799.9 904.3 958.0 989.4 1032.8 15268.9 15870.8 16382.7 16479.7 16661.5 916.9 920.3 935.1 941.2 941.4 9810.1 9983.6 9984.9 10088.2 10205.2 372725.0 374969.0 378602.0 392862.0 399889.0 69819.7 70765.3 72327.0 72346.6 73208.0 944.3 988.2 1002.0 1007.8 1008.1 15116.3 15762.3 15990.8 15998.5 16144.2 35781.1 35798.1 36372.6 36409.8 36503.6 46560.5 51592.5 51939.7 52049.5 52283.0 7780.8 7946.1 8052.7 8063.1 8099.1 10720.6 11395.0 11643.3 11805.0 11870.7 7929.4 10087.5 10566.8 10633.2 10824.7 10558.6 10705.9 10794.2 10991.7 11132.1 10518.7 10806.4 10929.2 10936.8 11135.3 7412.8 7761.1 7847.5 7867.6 8008.2 9453.5 10739.9 10773.7 10805.9 10814.3 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | [#3] mootools.html Cycles:180 Average:5227.42 Median:5216.28 stddev:2927.01 (56.1%) stddev-sans-first:2920.21 13:36:52 INFO - PROCESS | 25336 | Values: 1283.0 1460.2 1509.6 1662.4 1807.8 6605.3 7790.2 7975.9 8024.4 8050.2 7759.8 7814.8 7881.0 7910.6 7915.6 1877.0 2186.0 2222.8 2249.3 2261.7 2235.4 2253.0 2253.6 2255.3 2256.0 2153.7 2187.1 2192.4 2193.8 2193.8 1762.5 2191.2 2246.4 2255.8 2260.3 2128.4 2135.2 2138.4 2156.5 2200.4 7672.4 7781.0 7803.5 7806.2 7809.7 4499.5 4608.1 4618.3 4633.6 4673.2 2909.9 2910.1 2981.7 2985.8 3000.3 904.7 929.1 942.4 943.5 965.2 10445.1 10469.8 10474.7 10478.8 10486.8 4005.7 4124.3 4237.3 4252.2 4272.6 8933.2 8986.6 8994.3 8996.1 9009.6 4135.2 4622.5 4624.7 4638.7 4656.3 4159.6 4239.3 4239.7 4269.6 4277.7 3743.9 3752.8 3820.0 3841.8 3856.8 1252.8 1254.3 1261.4 1266.4 1272.1 702.9 732.4 836.8 850.0 870.2 5187.7 5244.9 5278.1 5284.2 5341.3 861.8 875.7 904.5 905.2 917.8 3638.6 3666.4 3677.7 3697.6 3702.8 9439.2 10024.6 10043.0 10106.5 10114.8 9753.6 9903.4 9910.4 9916.2 9921.1 7601.5 7624.2 7666.5 7692.5 7753.4 5154.6 5260.4 5316.8 5450.6 5515.1 9239.8 9307.8 9335.5 9458.5 9475.5 8802.9 9184.6 9406.5 9507.5 9642.1 6211.8 6728.9 6832.2 6900.9 7076.4 7649.3 7710.0 7742.9 7750.0 7756.4 6658.4 6840.0 6848.0 6948.5 6976.5 6868.0 6871.3 6885.1 7017.4 7019.9 6470.1 6470.6 6474.4 6507.2 6553.2 4679.1 4781.0 4786.3 4799.2 4824.7 4712.2 4791.0 4797.9 4804.9 4859.2 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | [#4] prototype.html Cycles:180 Average:4394.83 Median:5072.66 stddev:1275.35 (25.1%) stddev-sans-first:1241.68 13:36:52 INFO - PROCESS | 25336 | Values: 318.4 318.5 319.3 322.8 324.4 5072.4 5073.9 5116.7 5127.8 5134.3 5031.7 5035.9 5046.7 5046.9 5074.0 3713.8 3795.8 3963.0 3979.2 3985.5 3957.8 3962.0 3970.1 3971.6 3972.5 3706.4 3924.5 3935.4 3944.7 3947.1 3820.9 3940.9 3941.8 3945.1 3952.6 3473.9 3497.3 3503.7 3509.4 3510.6 4809.8 4831.4 4832.2 4835.4 4836.5 4184.9 4451.4 4452.3 4470.3 4538.0 5193.5 5217.3 5231.2 5243.2 5248.6 3712.3 3715.5 3719.2 3728.6 3734.0 5309.6 5496.6 5552.1 5557.9 5603.2 3795.7 3811.1 3840.9 3852.2 3859.7 3894.0 3895.2 3901.8 3903.5 3904.6 4331.6 4430.9 4441.8 4454.0 4488.5 5327.6 5361.1 5365.5 5366.6 5373.8 1387.5 1406.7 1407.4 1412.8 1413.5 875.8 954.3 973.7 984.8 993.1 4576.8 4584.1 4595.5 4601.7 4604.1 5391.4 5403.5 5404.4 5405.2 5428.8 4437.6 4589.4 4608.8 4613.7 4615.7 2861.3 2881.6 2893.1 2894.1 2900.6 5072.9 5074.7 5094.2 5109.8 5114.8 5417.1 5556.1 5576.0 5666.6 5713.9 5161.5 5177.4 5193.3 5196.4 5212.6 5505.2 5511.6 5528.9 5532.1 5550.8 5247.5 5431.6 5439.1 5462.1 5466.6 5166.2 5166.8 5173.3 5174.2 5176.0 3785.1 3798.0 3801.5 3808.6 3809.8 5405.3 5431.2 5469.0 5494.2 5495.1 5236.7 5277.6 5314.9 5320.9 5339.2 5104.7 5324.3 5326.4 5327.6 5338.8 5016.5 5231.3 5239.3 5242.8 5246.8 5151.1 5310.5 5352.6 5357.0 5369.6 5206.3 5206.4 5212.9 5217.4 5234.3 13:36:52 INFO - PROCESS | 25336 | 13:36:52 INFO - PROCESS | 25336 | [#5] yui.html Cycles:180 Average:12240.20 Median:43436.96 stddev:13711.41 (31.6%) stddev-sans-first:13721.98 13:36:52 INFO - PROCESS | 25336 | Values: 594.8 610.3 679.5 690.8 695.3 11886.9 11909.0 12061.8 12084.1 12105.0 11611.5 11688.1 11702.3 11702.7 11762.8 635.2 792.5 811.0 811.1 812.8 776.5 798.1 798.7 798.8 799.4 838.9 839.2 840.2 841.5 846.5 655.0 672.3 828.9 829.3 836.1 498.3 605.6 629.8 630.5 630.6 12081.3 12262.0 12337.4 12352.3 12433.8 11050.4 11317.8 11349.3 11501.9 11744.4 9208.1 9295.0 9321.1 9497.4 9504.5 3178.6 3223.6 3244.8 3257.2 3270.0 43423.3 43450.6 43555.6 45688.1 45944.3 9469.7 9508.8 10109.3 10119.0 10378.0 16897.4 18592.7 18696.2 18710.0 18724.2 6176.3 6204.7 6291.0 6294.7 6383.0 3401.5 3478.4 3480.9 3496.6 3652.7 2736.2 2828.8 2833.9 2835.2 2838.8 514.9 515.5 524.1 525.1 531.1 465.7 531.0 537.9 546.8 568.0 6966.9 6985.7 7051.5 7441.2 7689.6 524.1 556.5 571.4 574.3 584.4 3381.6 3427.5 3464.8 3473.3 3494.4 48492.8 49886.5 50166.7 50694.2 50694.5 41826.8 42252.6 42395.6 42723.4 43906.6 38737.8 39348.4 39532.6 40156.0 40228.6 7705.2 7907.3 7948.9 8102.8 8130.6 27658.6 28085.4 28126.9 28286.6 28779.3 35687.6 35707.5 38821.8 39144.8 39231.0 10768.8 10819.9 10916.9 10957.7 11329.1 11573.7 11724.1 11879.3 12162.4 12243.0 10168.2 10192.3 10240.9 10391.8 10418.1 9676.0 9695.2 10003.8 10143.0 10509.7 10407.4 10591.6 10657.9 11045.7 11056.2 9352.9 9394.6 9448.3 9691.9 9901.5 8605.9 9136.1 9321.0 9348.9 9376.0 13:36:52 INFO - PROCESS | 25336 | -------- Summary: end -------- 13:36:52 INFO - PROCESS | 25336 | 13:36:53 INFO - TEST-INFO | 25336: exit 0 13:36:53 INFO - TEST-OK | dromaeo_css | took 1118947ms 13:36:53 INFO - TEST-START | kraken 13:36:53 INFO - operating with platform_type : linux_ 13:36:53 INFO - Initialising browser for kraken test... 13:36:53 INFO - TEST-INFO | started process 25510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplcafL3/profile http://localhost:51222/getInfo.html) 13:36:58 INFO - PROCESS | 25510 | __metrics Screen width/height:1600/1200 13:36:58 INFO - PROCESS | 25510 | colorDepth:24 13:36:58 INFO - PROCESS | 25510 | Browser inner width/height: 1024/697 13:36:58 INFO - PROCESS | 25510 | __metrics 13:36:59 ERROR - PROCESS | 25510 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:37:00 INFO - TEST-INFO | 25510: exit 0 13:37:00 INFO - Browser initialized. 13:37:00 INFO - Running cycle 1/1 for kraken test... 13:37:00 INFO - TEST-INFO | started process 25592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplcafL3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:12 INFO - PROCESS | 25592 | RSS: Main: 155308032 13:37:12 INFO - PROCESS | 25592 | 13:37:14 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:15 INFO - PROCESS | 25592 | RSS: Main: 209608704 13:37:15 INFO - PROCESS | 25592 | 13:37:18 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-dft) 13:37:19 INFO - PROCESS | 25592 | RSS: Main: 195555328 13:37:19 INFO - PROCESS | 25592 | 13:37:22 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-fft) 13:37:23 INFO - PROCESS | 25592 | RSS: Main: 266838016 13:37:23 INFO - PROCESS | 25592 | 13:37:25 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-oscillator) 13:37:25 INFO - PROCESS | 25592 | RSS: Main: 176406528 13:37:25 INFO - PROCESS | 25592 | 13:37:28 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:28 INFO - PROCESS | 25592 | RSS: Main: 179163136 13:37:28 INFO - PROCESS | 25592 | 13:37:31 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51222/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:32 INFO - PROCESS | 25592 | RSS: Main: 215740416 13:37:32 INFO - PROCESS | 25592 | 13:37:35 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51222/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:36 INFO - PROCESS | 25592 | RSS: Main: 215867392 13:37:36 INFO - PROCESS | 25592 | 13:37:39 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51222/tests/kraken/driver.html?testName=json-parse-financial) 13:37:39 INFO - PROCESS | 25592 | RSS: Main: 216383488 13:37:39 INFO - PROCESS | 25592 | 13:37:41 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:42 INFO - PROCESS | 25592 | RSS: Main: 201572352 13:37:42 INFO - PROCESS | 25592 | 13:37:44 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:44 INFO - PROCESS | 25592 | RSS: Main: 205672448 13:37:44 INFO - PROCESS | 25592 | 13:37:46 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:47 INFO - PROCESS | 25592 | RSS: Main: 219652096 13:37:47 INFO - PROCESS | 25592 | 13:37:50 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:50 INFO - PROCESS | 25592 | RSS: Main: 225374208 13:37:50 INFO - PROCESS | 25592 | 13:37:53 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:54 INFO - PROCESS | 25592 | RSS: Main: 220463104 13:37:54 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51222/tests/kraken/driver.html?testName=ai-astar) 13:37:56 INFO - PROCESS | 25592 | RSS: Main: 283652096 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | __start_tp_report 13:37:56 INFO - PROCESS | 25592 | _x_x_mozilla_page_load 13:37:56 INFO - PROCESS | 25592 | _x_x_mozilla_page_load_details 13:37:56 INFO - PROCESS | 25592 | |i|pagename|runs| 13:37:56 INFO - PROCESS | 25592 | |0;ai-astar;110;112;106;112;111;113;100;112;114;113 13:37:56 INFO - PROCESS | 25592 | |1;audio-beat-detection;165;131;160;189;132;159;152;133;191;140 13:37:56 INFO - PROCESS | 25592 | |2;audio-dft;161;161;161;162;162;161;159;162;160;161 13:37:56 INFO - PROCESS | 25592 | |3;audio-fft;74;75;77;164;74;74;73;76;154;74 13:37:56 INFO - PROCESS | 25592 | |4;audio-oscillator;94;94;160;93;93;93;143;93;93;143 13:37:56 INFO - PROCESS | 25592 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;116;116 13:37:56 INFO - PROCESS | 25592 | |6;imaging-darkroom;146;145;147;145;146;146;145;145;146;145 13:37:56 INFO - PROCESS | 25592 | |7;imaging-desaturate;94;94;95;95;94;95;95;94;95;94 13:37:56 INFO - PROCESS | 25592 | |8;json-parse-financial;64;66;64;64;65;65;64;92;64;63 13:37:56 INFO - PROCESS | 25592 | |9;json-stringify-tinderbox;64;65;65;64;66;66;65;64;64;68 13:37:56 INFO - PROCESS | 25592 | |10;stanford-crypto-aes;78;78;78;77;79;80;79;79;80;80 13:37:56 INFO - PROCESS | 25592 | |11;stanford-crypto-ccm;132;136;138;135;132;141;131;143;165;144 13:37:56 INFO - PROCESS | 25592 | |12;stanford-crypto-pbkdf2;171;183;176;171;174;171;170;173;171;169 13:37:56 INFO - PROCESS | 25592 | |13;stanford-crypto-sha256-iterative;72;75;72;72;72;73;71;71;72;73 13:37:56 INFO - PROCESS | 25592 | __end_tp_report 13:37:56 INFO - PROCESS | 25592 | __start_cc_report 13:37:56 INFO - PROCESS | 25592 | _x_x_mozilla_cycle_collect,1901 13:37:56 INFO - PROCESS | 25592 | __end_cc_report 13:37:56 INFO - PROCESS | 25592 | __startTimestamp1461098276506__endTimestamp 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | ------- Summary: start ------- 13:37:56 INFO - PROCESS | 25592 | Number of tests: 14 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:4.24 (3.8%) stddev-sans-first:4.50 13:37:56 INFO - PROCESS | 25592 | Values: 110.0 112.0 106.0 112.0 111.0 113.0 100.0 112.0 114.0 113.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:159.50 stddev:22.15 (13.9%) stddev-sans-first:23.21 13:37:56 INFO - PROCESS | 25592 | Values: 165.0 131.0 160.0 189.0 132.0 159.0 152.0 133.0 191.0 140.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 13:37:56 INFO - PROCESS | 25592 | Values: 161.0 161.0 161.0 162.0 162.0 161.0 159.0 162.0 160.0 161.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#3] audio-fft Cycles:10 Average:91.50 Median:74.00 stddev:35.67 (48.2%) stddev-sans-first:37.27 13:37:56 INFO - PROCESS | 25592 | Values: 74.0 75.0 77.0 164.0 74.0 74.0 73.0 76.0 154.0 74.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.15 (29.2%) stddev-sans-first:28.18 13:37:56 INFO - PROCESS | 25592 | Values: 94.0 94.0 160.0 93.0 93.0 93.0 143.0 93.0 93.0 143.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:37:56 INFO - PROCESS | 25592 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:37:56 INFO - PROCESS | 25592 | Values: 146.0 145.0 147.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 13:37:56 INFO - PROCESS | 25592 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:64.50 stddev:8.79 (13.6%) stddev-sans-first:9.25 13:37:56 INFO - PROCESS | 25592 | Values: 64.0 66.0 64.0 64.0 65.0 65.0 64.0 92.0 64.0 63.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 13:37:56 INFO - PROCESS | 25592 | Values: 64.0 65.0 65.0 64.0 66.0 66.0 65.0 64.0 64.0 68.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:1.03 (1.3%) stddev-sans-first:1.05 13:37:56 INFO - PROCESS | 25592 | Values: 78.0 78.0 78.0 77.0 79.0 80.0 79.0 79.0 80.0 80.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:139.50 stddev:10.02 (7.2%) stddev-sans-first:10.24 13:37:56 INFO - PROCESS | 25592 | Values: 132.0 136.0 138.0 135.0 132.0 141.0 131.0 143.0 165.0 144.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:172.00 stddev:4.09 (2.4%) stddev-sans-first:4.28 13:37:56 INFO - PROCESS | 25592 | Values: 171.0 183.0 176.0 171.0 174.0 171.0 170.0 173.0 171.0 169.0 13:37:56 INFO - PROCESS | 25592 | 13:37:56 INFO - PROCESS | 25592 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 13:37:56 INFO - PROCESS | 25592 | Values: 72.0 75.0 72.0 72.0 72.0 73.0 71.0 71.0 72.0 73.0 13:37:56 INFO - PROCESS | 25592 | -------- Summary: end -------- 13:37:56 INFO - PROCESS | 25592 | 13:37:57 INFO - TEST-INFO | 25592: exit 0 13:37:57 INFO - TEST-OK | kraken | took 64123ms 13:37:57 INFO - SUITE-END | took 1183s 13:37:57 INFO - Completed test suite (00:19:43) 13:37:57 INFO - javascript benchmark 13:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.1390034338497, 2650.204938518444, 2659.188947371051, 2659.228823641144, 2682.7585517303437, 4551.089782043588, 4618.8152473901, 4634.1658501469765, 4648.0239149778545, 4670.416197975257, 4590.196715574778, 4665.486796452387, 4714.481407045222, 4743.90512189756, 4752.76236188191, 4242.681798865082, 4273.316269396897, 4277.55085716, 4330.761808100553, 4356.085222103362, 4300.204462174492, 4328.372386004027, 4377.299632058871, 4404.361367601696, 4409.118176364724, 4208.894777630553, 4267.829286828523, 4333.133373325316, 4369.1916995355805, 4374.803133858953, 4206.558311377292, 4230.048239146198, 4230.21740977917, 4232.492100947875, 4233.111046680201, 4188.183304255671, 4204.1801848639525, 4206.558311377292, 4212.241796476633, 4218.557051509578, 4497.280435130363, 4525.072360166158, 4553.476350219734, 4577.359169716243, 4579.0, 4969.627277954168, 4978.253262010691, 4983.401991760976, 4988.850334489971, 5027.949720502821, 4829.613630909554, 5004.424491183488, 5005.924911126336, 5017.6989380636915, 5021.322121513585, 4637.6289896808175, 4675.2052151134385, 4738.47876733559, 4746.406699162605, 4748.121597504472, 5106.285120083191, 5113.233015047773, 5135.281060651511, 5160.071187186342, 5199.4020687621405, 4768.189407800613, 4918.311436398907, 4936.8765780855765, 4943.431505376856, 4984.37695288089, 4995.825146119869, 5041.218611115283, 5054.924176137288, 5100.030994111107, 5114.693118412907, 4856.247281671346, 4862.635302352338, 4870.488598697157, 4884.731339776346, 4920.188168952154, 4776.5701086902345, 4842.5157484251295, 4881.536254055859, 4883.389576302962, 4920.163572192664, 4249.702520823513, 4255.744655320629, 4267.210566045292, 4313.137372525507, 4329.372241025034, 3731.384321586908, 3732.6080761520193, 3742.045778326509, 3742.812859357076, 3774.7168962327387, 4134.462519872397, 4223.408722778813, 4306.354046892991, 4311.396404503372, 4328.5022222444195, 4897.191963326082, 4900.705957642553, 4904.411470623548, 4946.950530494721, 4959.851204463872, 4186.895327616834, 4192.706510544293, 4202.894927626834, 4229.0, 4231.069164783743, 4318.611324980767, 4430.246858034142, 4443.666724995638, 4474.127545128668, 4541.0, 4677.391939047902, 4678.649101317346, 4687.765611719332, 4694.248920172756, 4727.3854398927915, 4993.750312484434, 4998.60011199096, 5001.1498045331655, 5016.448190699093, 5060.569851562511, 4510.030343476168, 4664.813407463664, 4674.859754207379, 4727.456342520654, 4739.1706451371565, 4882.584980276716, 4887.584555312838, 4903.754812259444, 4905.558499735041, 4916.8770780730765, 4945.876353091057, 4967.40391153064, 4970.577500912463, 4978.47725988766, 5019.297298378157, 4692.48382677912, 4811.0, 4850.684705494132, 4879.926801098058, 4883.511648835088, 4798.808047678193, 4809.591184749335, 4810.39870016248, 4829.251466022772, 4874.975625121851, 4569.200389931682, 4749.311349854321, 4764.380630518011, 4780.211265141213, 4828.782704778364, 4837.129316723023, 4880.707157570557, 4881.8535443936735, 4915.803367865388, 4929.457759646364, 4747.83382581608, 4773.307870358848, 4777.665563410528, 4782.760861956958, 4822.059698358787], "value": 4564.627726596195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.7430679114773, 615.4092071611253, 619.8047615001274, 625.1029772276781, 629.3517676792904, 34077.0, 35507.2898542029, 35567.644323556786, 35613.82193089034, 35736.642633573654, 37841.62158378415, 38462.80768596153, 38788.41817372742, 38801.22397552047, 38850.8057459713, 7553.509021913572, 7746.0317460317465, 7751.651175697107, 7752.844943101163, 7753.185915478878, 7679.155292917774, 7778.261065198825, 7790.182030886732, 7848.843023139534, 7867.763967080997, 7884.487508311941, 7946.086200087007, 7948.960255198745, 7952.840943181133, 7957.0451545814585, 7834.0, 7915.0, 7949.523028618301, 7949.523028618301, 7968.561729104897, 7870.567118808463, 7925.564093974829, 7955.721549745731, 7967.8406431871035, 7974.162712915118, 37708.0, 38240.04399889997, 38248.0, 38269.23461530754, 38274.61725382738, 3064.9233769155726, 3185.0, 3263.689949454798, 3338.098713347407, 3504.176518518146, 28403.738354944635, 29107.417851642847, 29293.56059659107, 29599.0, 29651.40697186066, 3285.4250506161325, 3340.9498857517156, 3361.865525379006, 3382.695557399821, 3388.0513456232293, 197457.0, 199208.00395998074, 199470.0, 199753.0, 199986.0, 32895.83552082272, 51860.48139518632, 52348.0, 52422.47577524252, 52492.0, 32196.0, 32417.0, 32426.351472970407, 32464.188395290308, 32468.350632987207, 12048.87951120495, 12218.32799196035, 12267.938660306641, 12320.568780092834, 12344.506219751109, 10134.493275336205, 10232.079112879877, 10248.59005639781, 10316.793664126675, 10337.844932326021, 7993.560354180576, 8169.223923727236, 8211.630476628447, 8226.05400378964, 8253.95873020631, 3175.301433684586, 3207.9839600802316, 3209.406259841937, 3223.2103134732142, 3264.3144939562485, 868.4224990381325, 901.454619954931, 950.3157726436955, 954.398728800851, 1003.1673710820002, 26714.0, 28288.858555707502, 28687.426251474855, 28933.85533072321, 28940.565891511644, 965.9613615455444, 974.1670871404989, 976.9023097690316, 985.3250523391499, 1080.3517889266534, 14836.406543738345, 14924.17917014553, 15147.242637868063, 15304.464343747915, 15419.383224670888, 346764.0, 350176.0, 355214.0, 355682.0, 357454.0, 49186.26220606694, 50108.0, 50133.74933125311, 50139.49860501421, 50185.74907125441, 1060.6605886116522, 1154.3016475032653, 1193.2959553863263, 1226.4358395138336, 1277.2847205564728, 25401.364965876, 28147.15558533247, 28272.701374901982, 28361.29096772597, 28574.42851143007, 39767.60232397639, 39972.0, 40376.79811600923, 40390.39414408845, 40487.0, 235950.0, 236049.0, 238271.0, 238693.0, 239239.0, 23254.186103486296, 25746.613800792627, 25856.741432585433, 26175.214743557724, 26205.86897065579, 37016.62983370132, 40167.0, 40331.1933761329, 40771.0, 41330.173396531296, 32944.83527582347, 33626.66373336235, 34284.48573271453, 34551.65448345484, 34743.30513389769, 33942.0, 34219.0, 34289.828550857084, 34667.4799877997, 34730.47904281387, 31265.0, 32104.67895321017, 34363.31273374568, 34727.13182170466, 36923.446148308336, 27242.096422644114, 31260.843695782285, 31305.0, 31312.64201353415, 31321.37357252888, 23694.289171324886, 23864.522709545363, 24203.031878725356, 24219.39451513656, 24252.1511747088], "value": 15970.362008576294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.99132273443576, 385.52965382233674, 387.89526827756487, 400.4053979839939, 403.7416053725614, 15396.384144634216, 16114.194290285497, 16299.51101466955, 16317.673646527062, 16330.183490825471, 16681.249343779527, 16756.162191890387, 16894.53905812746, 17116.572085697862, 17144.82855171448, 5151.278820965059, 5291.100512912814, 5315.574754019669, 5324.520793128618, 5330.600204984622, 3610.368185567528, 5554.1391084381985, 5953.166556682068, 5988.700564971756, 5999.160117583542, 5860.941390586104, 5897.498712609433, 5922.230110085704, 5935.703214839241, 5958.821235362946, 5838.386969368219, 5991.700414979277, 5992.041273396236, 6021.548383871227, 6033.637981721089, 3345.8159801210923, 3527.770694904823, 3536.876209332661, 3537.8054207018604, 4884.29177769225, 19828.60342793136, 20405.693914591295, 20606.381808545768, 20620.69068963967, 20677.5864482711, 1985.602879424121, 1986.920523179071, 2028.6247044296704, 2042.8774273543636, 2309.56118337517, 12454.564090256888, 13278.800817987738, 13317.733645327136, 13733.107348022346, 13807.0, 1773.4768243368108, 1830.6338732253469, 1850.3616252392903, 1857.0250618425434, 1909.9140538675792, 66157.0, 66406.33593664049, 67299.0, 67760.6611966937, 68470.0, 9526.571304291323, 9549.427034377959, 10086.44524551142, 10167.0, 10178.643747468803, 13638.795418068737, 13697.726045479034, 13723.45106195741, 13753.312334383241, 13781.51764688231, 7127.0, 7183.640817959081, 7196.820079498055, 7225.819354516179, 7293.562386256842, 6759.831004224934, 6776.220734615484, 6779.35596118368, 6921.48088893335, 6929.757458488929, 6210.378962103844, 6224.914653591007, 6240.563160578807, 6263.279722831841, 6275.403836635513, 1607.9517614471586, 1691.112166112776, 1765.2083135617358, 1774.210476338017, 1811.424061066854, 799.8960135182389, 904.3217586809892, 957.9760505987406, 989.3766926836047, 1032.7934413117407, 15268.923655381652, 15870.841291587167, 16382.672346553003, 16479.670406592042, 16661.50015499537, 916.8578870274985, 920.3143657974717, 935.1163150822543, 941.1999800169801, 941.3975055964188, 9810.091807274704, 9983.550740216708, 9984.850227246598, 10088.243381746399, 10205.234607404474, 372725.0, 374969.0, 378602.0, 392862.0, 399889.0, 69819.65090174516, 70765.2923470769, 72327.0, 72346.63826680939, 73208.0, 944.2917811641269, 988.2291812386206, 1002.0480543483719, 1007.7984403119406, 1008.0625018732502, 15116.319765610793, 15762.290696918437, 15990.760138597698, 15998.520044398687, 16144.1927903602, 35781.10547236236, 35798.105047374025, 36372.63627363693, 36409.817950910074, 36503.63496365002, 46560.53439465698, 51592.48407515877, 51939.740301298254, 52049.479505204465, 52283.0, 7780.766577002699, 7946.125926148235, 8052.677892884219, 8063.113057563781, 8099.14958929304, 10720.571177152826, 11395.0, 11643.301401915913, 11805.0, 11870.703232419259, 7929.444938854455, 10087.495625218562, 10566.780975995127, 10633.20250981195, 10824.729381765204, 10558.577656893638, 10705.89294107049, 10794.190435717195, 10991.670249892515, 11132.109431245319, 10518.737031573966, 10806.405647689138, 10929.18031147683, 10936.781264374828, 11135.33188008722, 7412.777616671508, 7761.068671759425, 7847.450678452682, 7867.645955931882, 8008.199180081945, 9453.527323633929, 10739.945041219085, 10773.73065673333, 10805.906210644343, 10814.29707069038], "value": 8419.421400268468, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.9550965716203, 1460.1822979131687, 1509.5546813689962, 1662.4015354472388, 1807.8372946434827, 6605.27341992381, 7790.18203088676, 7975.880361794578, 8024.43828931975, 8050.154733752959, 7759.767206983785, 7814.8046298842555, 7881.0, 7910.564918929456, 7915.643796029178, 1877.0427082188046, 2185.9562808743817, 2222.766609505999, 2249.2689875790434, 2261.739899911515, 2235.3629215673536, 2252.977470225301, 2253.571821353946, 2255.289583781112, 2255.9661605075935, 2153.720016397866, 2187.1142187414043, 2192.4299682082615, 2193.7696541863115, 2193.7915897989665, 1762.488878225313, 2191.222116148776, 2246.4383904023994, 2255.751867294596, 2260.2541161416693, 2128.382768996989, 2135.2099723102397, 2138.4440045588103, 2156.5040040790705, 2200.3728937252804, 7672.386209103258, 7780.961095194544, 7803.531788092732, 7806.219378062206, 7809.687612495493, 4499.460064792246, 4608.147492713825, 4618.330342100377, 4633.582977532004, 4673.228917228653, 2909.912702618925, 2910.1124157132067, 2981.731644152015, 2985.7611391088662, 3000.294930691286, 904.7285814255697, 929.1173385284008, 942.4392486470539, 943.5093751249381, 965.2181732796457, 10445.119878421805, 10469.84295235572, 10474.738131546696, 10478.790424191473, 10486.842697359545, 4005.6795456364002, 4124.298869192245, 4237.309308589068, 4252.170826688828, 4272.5727427257025, 8933.15135062168, 8986.595603197871, 8994.325425592975, 8996.145366190201, 9009.594568244445, 4135.234981528427, 4622.537746225351, 4624.653151013687, 4638.6752927294765, 4656.32483289921, 4159.584041595876, 4239.25812982733, 4239.703220774516, 4269.5516970718245, 4277.679174061957, 3743.9064023399633, 3752.774833509998, 3820.0, 3841.8463261469788, 3856.845726170922, 1252.7619752247044, 1254.3038613569374, 1261.3630116791146, 1266.4237771813803, 1272.077743635875, 702.8840241360118, 732.4104096202501, 836.8368168207263, 849.9915000849912, 870.2298465857635, 5187.688738675692, 5244.868878278074, 5278.129108697099, 5284.233786100994, 5341.278927344836, 861.793169639282, 875.6847534887436, 904.4934836491586, 905.2441211588266, 917.8164367126468, 3638.6179451157245, 3666.3767159582935, 3677.742558020913, 3697.5932647408763, 3702.8148592570265, 9439.150476457151, 10024.599016039423, 10043.045910638477, 10106.494675266207, 10114.848277275847, 9753.609855605697, 9903.405795652285, 9910.35582687123, 9916.157126644172, 9921.057499537532, 7601.46789724725, 7624.237576242443, 7666.4633475656165, 7692.499987500794, 7753.418493613001, 5154.561862241601, 5260.421353651172, 5316.813911513079, 5450.5912056595125, 5515.090010148441, 9239.815203696024, 9307.76730581741, 9335.486548239913, 9458.479783611692, 9475.52622368865, 8802.86795698078, 9184.632614695338, 9406.482643454676, 9507.524623768646, 9642.084002019797, 6211.81364559064, 6728.889733193968, 6832.248452670103, 6900.896486552806, 7076.363127318566, 7649.349805266615, 7709.99770029915, 7742.922570774445, 7749.961250193713, 7756.379489640928, 6658.400743933069, 6840.042394064735, 6848.0, 6948.513604047668, 6976.511644184859, 6867.969804529361, 6871.347222013901, 6885.139357580302, 7017.403520700797, 7019.859602808017, 6470.094186813756, 6470.579412338183, 6474.352564743488, 6507.186601674791, 6553.2136143661155, 4679.087577922272, 4781.043791241835, 4786.329913811999, 4799.1601469743355, 4824.734639594856, 4712.222483290218, 4791.0, 4797.856064318076, 4804.855854324376, 4859.198232291632], "value": 4208.318414219902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.37598307317654, 318.4697478697968, 319.2656889154943, 322.8159948829167, 324.37881457009826, 5072.391313042435, 5073.949260507394, 5116.744162791855, 5127.846164615058, 5134.306868572741, 5031.672941258816, 5035.874103147414, 5046.697198168113, 5046.899062018758, 5073.974630126853, 3713.8143092845316, 3795.804321638675, 3962.9801850990702, 3979.1842672252264, 3985.521737391517, 3957.821898014582, 3962.0, 3970.1464185200175, 3971.62269584389, 3972.510308634262, 3706.4440333949856, 3924.489816323874, 3935.3703407454814, 3944.704147188958, 3947.1118998225456, 3820.9044773880737, 3940.876850097737, 3941.8423263069444, 3945.11234972129, 3952.6245006724457, 3473.9131521711906, 3497.265574229415, 3503.6861177058604, 3509.403401421739, 3510.613832478425, 4809.831655892027, 4831.396075490564, 4832.202686556714, 4835.371401717754, 4836.540528649808, 4184.937225941613, 4451.421315229032, 4452.332150177467, 4470.26240670289, 4537.977310113428, 5193.506616871391, 5217.3217481727515, 5231.241469986869, 5243.161094224905, 5248.6091185835785, 3712.3132220539287, 3715.4612581175847, 3719.2189640175598, 3728.608496107897, 3734.0314450012306, 5309.575233981311, 5496.642718223303, 5552.139418390156, 5557.916631250494, 5603.187537806995, 3795.6773674237998, 3811.123441608446, 3840.9231815363537, 3852.2295540891932, 3859.691224702073, 3894.0, 3895.182011777502, 3901.843926242975, 3903.4730311408166, 3904.590018048121, 4331.631811296075, 4430.87012811731, 4441.777911104432, 4453.977730111329, 4488.483824360175, 5327.627066105335, 5361.115415956324, 5365.517103460629, 5366.570674346043, 5373.838784836461, 1387.549046559872, 1406.7116241170536, 1407.3877863129571, 1412.7951447040123, 1413.5264686330195, 875.785432569012, 954.2604481526872, 973.7078876337071, 984.7587341101475, 993.0863605482829, 4576.816927322936, 4584.060267645124, 4595.471520775153, 4601.677882548256, 4604.102200071021, 5391.4338994405025, 5403.486668766461, 5404.3784964728775, 5405.243265942771, 5428.782848686008, 4437.64498840092, 4589.449266088024, 4608.769561521911, 4613.677042606985, 4615.676902616785, 2861.31328481163, 2881.6109825173753, 2893.146521776039, 2894.088362165911, 2900.5787164289345, 5072.923906141411, 5074.746262686851, 5094.15946368845, 5109.846704598868, 5114.846554603368, 5417.052015897202, 5556.111022236503, 5575.972120139454, 5666.575006874501, 5713.942860571424, 5161.53546180853, 5177.404598471148, 5193.272941788077, 5196.350456192976, 5212.582993360522, 5505.174223866452, 5511.58663100261, 5528.944710552843, 5532.114861622121, 5550.833474995757, 5247.501487358695, 5431.5926305526455, 5439.129739241703, 5462.098753705753, 5466.594698332721, 5166.199239117943, 5166.767495462788, 5173.32746742921, 5174.223866419917, 5176.042432150064, 3785.1104990327804, 3797.9810100949317, 3801.4677945088265, 3808.638179372955, 3809.828557714854, 5405.324334458192, 5431.234848674276, 5468.972655136698, 5494.2033405155225, 5495.148252020783, 5236.659617124875, 5277.577793776565, 5314.867128321823, 5320.866978325573, 5339.225812257123, 5104.668196567211, 5324.254604355471, 5326.414094449685, 5327.600429967845, 5338.839834804962, 5016.488458079286, 5231.267622532772, 5239.318888544465, 5242.764075616683, 5246.76389562463, 5151.072806894795, 5310.468953104813, 5352.6448362720275, 5357.0, 5369.597280204079, 5206.271122042993, 5206.427292997843, 5212.921806172986, 5217.426083130928, 5234.2933703951], "value": 3998.1176661105746, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.7539903901327, 610.27124270706, 679.5175425447932, 690.7824035428839, 695.3359541637733, 11886.940565297184, 11909.0, 12061.758764824699, 12084.093692973018, 12105.031597472214, 11611.535538578468, 11688.123390745686, 11702.297862128278, 11702.707432314175, 11762.823557646641, 635.16475834278, 792.4690457393531, 810.9675612975474, 811.0510702478085, 812.8049268175654, 776.4564804636749, 798.0981490915258, 798.7124635131348, 798.7763426240662, 799.4044436894493, 838.9454685445427, 839.1566475691922, 840.2185967050641, 841.4572600672562, 846.5174850335311, 654.9901751473732, 672.334388954936, 828.9295409890136, 829.2992421403904, 836.0886633569409, 498.3247699367341, 605.6305653551331, 629.7669862150988, 630.533405280094, 630.59956927351, 12081.335526546036, 12262.0, 12337.383130843511, 12352.25886446807, 12433.813492797615, 11050.392228427434, 11317.83023254652, 11349.262297950607, 11501.884981150166, 11744.354060526668, 9208.12522810332, 9294.953525232399, 9321.114494123047, 9497.382670126419, 9504.524773761284, 3178.570892929448, 3223.597050368704, 3244.78908870925, 3257.153140183569, 3270.035339574831, 43423.348649770276, 43450.56549434528, 43555.56444435547, 45688.08623827505, 45944.3108353375, 9469.66856160031, 9508.809823803485, 10109.34289271195, 10119.0, 10378.0, 16897.408590699266, 18592.721109183374, 18696.158672859754, 18710.0, 18724.15741291645, 6176.258848938156, 6204.720787564571, 6291.0, 6294.65379404128, 6383.0, 3401.4897765334904, 3478.3912815257736, 3480.9477857832153, 3496.59789124254, 3652.6712595866497, 2736.206500114984, 2828.7736981041467, 2833.8583070846375, 2835.220314413553, 2838.8438635875227, 514.9098907691139, 515.4896652314256, 524.1247117314094, 525.0627629681001, 531.1183435497056, 465.6763549333249, 530.9840704778862, 537.8843548636984, 546.8058839112058, 567.9687617181012, 6966.860662786716, 6985.685644146026, 7051.541649792747, 7441.218672039358, 7689.577073260913, 524.0750076115659, 556.4546744190716, 571.4285714285714, 574.3022227993008, 584.392232078642, 3381.644927282649, 3427.537282466835, 3464.757466977338, 3473.2532505511435, 3494.371013217645, 48492.75753621209, 49886.50113498891, 50166.74916625393, 50694.239586406235, 50694.49305506972, 41826.79086604608, 42252.57747422548, 42395.57604423978, 42723.35914961278, 43906.56093439089, 38737.80631096826, 39348.40977385342, 39532.604673953465, 40156.0, 40228.59771402307, 7705.152433232228, 7907.327877130509, 7948.920510794818, 8102.79743006406, 8130.593470326578, 27658.585121222794, 28085.43829123365, 28126.85936570304, 28286.575701364083, 28779.28051798722, 35687.64312356843, 35707.46438803472, 38821.80589097036, 39144.80427597958, 39231.0, 10768.784624307627, 10819.891801081889, 10916.945415272872, 10957.726056848323, 11329.093672506344, 11573.710657233636, 11724.120690948042, 11879.287242765462, 12162.391880406121, 12243.0, 10168.186545076524, 10192.28653994243, 10240.897591024292, 10391.792164156826, 10418.114460270961, 9676.0, 9695.22438204956, 10003.849942250727, 10143.0, 10509.684709458423, 10407.427591482541, 10591.576336946437, 10657.89342106569, 11045.72385690332, 11056.170787190831, 9352.859707104262, 9394.624215031323, 9448.291378146529, 9691.9030809691, 9901.504924753877, 8605.913940860512, 9136.081422901265, 9321.0, 9348.906510934803, 9375.953120234355], "value": 5699.687825027246, "unit": "score"}], "name": "dromaeo_css", "value": 6237.017416812785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 112.0, 111.0, 113.0, 100.0, 112.0, 114.0, 113.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 160.0, 189.0, 132.0, 159.0, 152.0, 133.0, 191.0, 140.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 159.0, 162.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 164.0, 74.0, 74.0, 73.0, 76.0, 154.0, 74.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 160.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 143.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 64.0, 92.0, 64.0, 63.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 64.0, 64.0, 68.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 79.0, 80.0, 79.0, 79.0, 80.0, 80.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 138.0, 135.0, 132.0, 141.0, 131.0, 143.0, 165.0, 144.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 183.0, 176.0, 171.0, 174.0, 171.0, 170.0, 173.0, 171.0, 169.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 72.0, 72.0, 72.0, 73.0, 71.0, 71.0, 72.0, 73.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1580.5, "alertThreshold": 2.0}]} 13:37:57 INFO - Return code: 0 13:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:37:57 ERROR - # TBPL SUCCESS # 13:37:57 INFO - Running post-action listener: _resource_record_post_action 13:37:57 INFO - Running post-run listener: _resource_record_post_run 13:37:58 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518062080; Read time: 20; Write time: 776124 13:37:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234205184; Read time: 0; Write time: 434452 13:37:58 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283856896; Read time: 20; Write time: 341672 13:37:58 INFO - Running post-run listener: _upload_blobber_files 13:37:58 INFO - Blob upload gear active. 13:37:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:58 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 13:37:58 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:37:58 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:37:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:00 INFO - (blobuploader) - INFO - Done attempting. 13:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:00 INFO - (blobuploader) - INFO - Done attempting. 13:38:00 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:00 INFO - Return code: 0 13:38:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c6f4963fc07cccdf412efcb5a65ef68e2b15e3b623363e38b674e332b79f2112f5d7f13a03c4857573a49c00500cb50bde714f57cdb4d6b1321f49af210f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3b32e1ef14c15e919fbc84596a7c2851c8111a3058c0513d157f0ff06f3bf7aba01cbd7a692f7767192ca4880a5ea7fede2e24ee7d65bedb9cbeaec2d43d520"} 13:38:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:00 INFO - Contents: 13:38:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c6f4963fc07cccdf412efcb5a65ef68e2b15e3b623363e38b674e332b79f2112f5d7f13a03c4857573a49c00500cb50bde714f57cdb4d6b1321f49af210f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3b32e1ef14c15e919fbc84596a7c2851c8111a3058c0513d157f0ff06f3bf7aba01cbd7a692f7767192ca4880a5ea7fede2e24ee7d65bedb9cbeaec2d43d520"} 13:38:00 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:00 INFO - Copying logs to upload dir... 13:38:00 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.400481 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-19 13:37:59.595830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 13:37:59.599632) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c6f4963fc07cccdf412efcb5a65ef68e2b15e3b623363e38b674e332b79f2112f5d7f13a03c4857573a49c00500cb50bde714f57cdb4d6b1321f49af210f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3b32e1ef14c15e919fbc84596a7c2851c8111a3058c0513d157f0ff06f3bf7aba01cbd7a692f7767192ca4880a5ea7fede2e24ee7d65bedb9cbeaec2d43d520"} build_url:https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/UYyG7BEEQJiQDOhVZC8BPw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c6f4963fc07cccdf412efcb5a65ef68e2b15e3b623363e38b674e332b79f2112f5d7f13a03c4857573a49c00500cb50bde714f57cdb4d6b1321f49af210f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3b32e1ef14c15e919fbc84596a7c2851c8111a3058c0513d157f0ff06f3bf7aba01cbd7a692f7767192ca4880a5ea7fede2e24ee7d65bedb9cbeaec2d43d520"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 13:37:59.624784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:37:59.625131) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461096846.298098-306428052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:37:59.709126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 13:37:59.709449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 13:37:59.709751) ========= ========= Total master_lag: 0.14 =========