builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1461063132.73 results: success (0) buildid: 20160419030056 builduid: bd5eb86fb01844748181336b72825a7b revision: 170eb8db5f8c99212b07756ce67ef86c45d7c229 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.729251) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.729664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.729955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.769917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.770199) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 03:52:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-04-19 03:52:13 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074527 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.861662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.862018) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015356 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.911838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:12.914384) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 170eb8db5f8c99212b07756ce67ef86c45d7c229 --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 170eb8db5f8c99212b07756ce67ef86c45d7c229 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 03:52:13,139 truncating revision to first 12 chars 2016-04-19 03:52:13,139 Setting DEBUG logging. 2016-04-19 03:52:13,139 attempt 1/10 2016-04-19 03:52:13,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/170eb8db5f8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 03:52:13,478 unpacking tar archive at: fx-team-170eb8db5f8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:13.542519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:13.543057) ========= script_repo_revision: 170eb8db5f8c99212b07756ce67ef86c45d7c229 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:13.543599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:13.543872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 03:52:13.560743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-19 03:52:13.561269) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:13 INFO - MultiFileLogger online at 20160419 03:52:13 in /builds/slave/test 03:52:13 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 03:52:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:13 INFO - {'append_to_log': False, 03:52:13 INFO - 'base_work_dir': '/builds/slave/test', 03:52:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:52:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:13 INFO - 'branch': 'Fx-Team-Non-PGO', 03:52:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:13 INFO - 'config_files': ('talos/linux_config.py',), 03:52:13 INFO - 'default_actions': ('clobber', 03:52:13 INFO - 'read-buildbot-config', 03:52:13 INFO - 'download-and-extract', 03:52:13 INFO - 'populate-webroot', 03:52:13 INFO - 'create-virtualenv', 03:52:13 INFO - 'install', 03:52:13 INFO - 'run-tests'), 03:52:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:13 INFO - 'download_minidump_stackwalk': True, 03:52:13 INFO - 'download_symbols': 'ondemand', 03:52:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:13 INFO - 'installer_path': 'installer.exe', 03:52:13 INFO - 'log_level': 'info', 03:52:13 INFO - 'log_name': 'talos', 03:52:13 INFO - 'log_to_console': True, 03:52:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:13 INFO - 'opt_config_files': (), 03:52:13 INFO - 'pip_index': False, 03:52:13 INFO - 'sps_profile': False, 03:52:13 INFO - 'sps_profile_interval': 0, 03:52:13 INFO - 'suite': 'dromaeojs', 03:52:13 INFO - 'system_bits': '32', 03:52:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:13 INFO - 'title': 'talos-linux64-ix-022', 03:52:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:13 INFO - 'use_talos_json': True, 03:52:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:13 INFO - 'work_dir': 'build'} 03:52:13 INFO - ##### 03:52:13 INFO - ##### Running clobber step. 03:52:13 INFO - ##### 03:52:13 INFO - Running pre-action listener: _resource_record_pre_action 03:52:13 INFO - Running main action method: clobber 03:52:13 INFO - rmtree: /builds/slave/test/build 03:52:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:14 INFO - Running post-action listener: _resource_record_post_action 03:52:14 INFO - ##### 03:52:14 INFO - ##### Running read-buildbot-config step. 03:52:14 INFO - ##### 03:52:14 INFO - Running pre-action listener: _resource_record_pre_action 03:52:14 INFO - Running main action method: read_buildbot_config 03:52:14 INFO - Using buildbot properties: 03:52:14 INFO - { 03:52:14 INFO - "project": "", 03:52:14 INFO - "product": "firefox", 03:52:14 INFO - "script_repo_revision": "production", 03:52:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:52:14 INFO - "repository": "", 03:52:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:52:14 INFO - "buildid": "20160419030056", 03:52:14 INFO - "pgo_build": "False", 03:52:14 INFO - "basedir": "/builds/slave/test", 03:52:14 INFO - "buildnumber": 1663, 03:52:14 INFO - "slavename": "talos-linux64-ix-022", 03:52:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:52:14 INFO - "platform": "ubuntu64_hw", 03:52:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:52:14 INFO - "branch": "fx-team", 03:52:14 INFO - "repo_path": "integration/fx-team", 03:52:14 INFO - "revision": "170eb8db5f8c99212b07756ce67ef86c45d7c229", 03:52:14 INFO - "stage_platform": "linux64", 03:52:14 INFO - "builduid": "bd5eb86fb01844748181336b72825a7b", 03:52:14 INFO - "slavebuilddir": "test" 03:52:14 INFO - } 03:52:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:52:14 INFO - Running post-action listener: _resource_record_post_action 03:52:14 INFO - ##### 03:52:14 INFO - ##### Running download-and-extract step. 03:52:14 INFO - ##### 03:52:14 INFO - Running pre-action listener: _resource_record_pre_action 03:52:14 INFO - Running main action method: download_and_extract 03:52:14 INFO - mkdir: /builds/slave/test/build/tests 03:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:14 INFO - https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:52:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:23 INFO - Downloaded 1361 bytes. 03:52:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:52:23 INFO - Using the following test package requirements: 03:52:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:52:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:52:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:52:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'jsshell-linux-x86_64.zip'], 03:52:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:52:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:52:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:52:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:52:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:52:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:52:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:52:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:23 INFO - https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:24 INFO - Downloaded 22209599 bytes. 03:52:24 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'] 03:52:24 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 03:52:26 INFO - Return code: 0 03:52:26 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 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:26 INFO - https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:52:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:30 INFO - Downloaded 22209599 bytes. 03:52:30 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'] 03:52:30 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 03:52:32 INFO - Return code: 0 03:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:32 INFO - https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:34 INFO - Downloaded 10845952 bytes. 03:52:34 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'] 03:52:34 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 03:52:34 INFO - Return code: 0 03:52:34 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')]} 03:52:34 INFO - https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:52:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZkqi35qQUSsOzzPI63a4g/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 03:52:35 INFO - Downloaded 54452909 bytes. 03:52:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:35 INFO - mkdir: /builds/slave/test/properties 03:52:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:35 INFO - Contents: 03:52:35 INFO - build_url:https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:52:36 INFO - Running post-action listener: _resource_record_post_action 03:52:36 INFO - Running post-action listener: set_extra_try_arguments 03:52:36 INFO - ##### 03:52:36 INFO - ##### Running populate-webroot step. 03:52:36 INFO - ##### 03:52:36 INFO - Running pre-action listener: _resource_record_pre_action 03:52:36 INFO - Running main action method: populate_webroot 03:52:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:36 INFO - '--tppagecycles', 03:52:36 INFO - '7'], 03:52:36 INFO - 'tests': ['tsvgm']}}, 03:52:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['damp', 'tps']}, 03:52:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'tests': ['damp', 'tps']}, 03:52:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['dromaeo_dom']}, 03:52:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['a11yr', 03:52:36 INFO - 'ts_paint', 03:52:36 INFO - 'tpaint', 03:52:36 INFO - 'sessionrestore', 03:52:36 INFO - 'sessionrestore_no_auto_restore', 03:52:36 INFO - 'tabpaint']}, 03:52:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:36 INFO - 'ts_paint', 03:52:36 INFO - 'tpaint', 03:52:36 INFO - 'sessionrestore', 03:52:36 INFO - 'sessionrestore_no_auto_restore', 03:52:36 INFO - 'tabpaint']}, 03:52:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:36 INFO - 'ts_paint', 03:52:36 INFO - 'tpaint', 03:52:36 INFO - 'sessionrestore', 03:52:36 INFO - 'sessionrestore_no_auto_restore', 03:52:36 INFO - 'tabpaint']}, 03:52:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:36 INFO - 'ts_paint', 03:52:36 INFO - 'tpaint', 03:52:36 INFO - 'sessionrestore', 03:52:36 INFO - 'sessionrestore_no_auto_restore', 03:52:36 INFO - 'tabpaint']}, 03:52:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['a11yr', 03:52:36 INFO - 'ts_paint', 03:52:36 INFO - 'tpaint', 03:52:36 INFO - 'sessionrestore', 03:52:36 INFO - 'sessionrestore_no_auto_restore', 03:52:36 INFO - 'tabpaint']}, 03:52:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['a11yr', 03:52:36 INFO - 'ts_paint', 03:52:36 INFO - 'tpaint', 03:52:36 INFO - 'sessionrestore', 03:52:36 INFO - 'sessionrestore_no_auto_restore', 03:52:36 INFO - 'tabpaint']}, 03:52:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['tsvgx', 03:52:36 INFO - 'tsvgr_opacity', 03:52:36 INFO - 'tart', 03:52:36 INFO - 'tscrollx', 03:52:36 INFO - 'cart']}, 03:52:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:36 INFO - 'tsvgr_opacity', 03:52:36 INFO - 'tart', 03:52:36 INFO - 'tscrollx', 03:52:36 INFO - 'cart']}, 03:52:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'talos_options': ['--disable-e10s'], 03:52:36 INFO - 'tests': ['tp5o']}, 03:52:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'tests': ['tp5o']}, 03:52:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'talos_options': ['--disable-e10s', 03:52:36 INFO - '--xperf_path', 03:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:36 INFO - 'tests': ['tp5n']}, 03:52:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:36 INFO - 'talos_options': ['--xperf_path', 03:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:36 INFO - 'tests': ['tp5n']}}, 03:52:36 INFO - 'talos.zip': {'path': '', 03:52:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:36 INFO - Running post-action listener: _resource_record_post_action 03:52:36 INFO - ##### 03:52:36 INFO - ##### Running create-virtualenv step. 03:52:36 INFO - ##### 03:52:36 INFO - Running pre-action listener: _resource_record_pre_action 03:52:36 INFO - Running main action method: create_virtualenv 03:52:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:36 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 03:52:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:36 INFO - Using real prefix '/usr' 03:52:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:39 INFO - Installing pip.................done. 03:52:39 INFO - Return code: 0 03:52:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:39 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')]} 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:39 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')]} 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:39 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:39 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 03:52:39 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 03:52:39 INFO - Using env: {'DISPLAY': ':0', 03:52:39 INFO - 'HOME': '/home/cltbld', 03:52:39 INFO - 'LANG': 'en_US.UTF-8', 03:52:39 INFO - 'LANGUAGE': 'en_US:en', 03:52:39 INFO - 'LOGNAME': 'cltbld', 03:52:39 INFO - 'MAIL': '/var/mail/cltbld', 03:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:39 INFO - 'MOZ_NO_REMOTE': '1', 03:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:39 INFO - 'NO_EM_RESTART': '1', 03:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:39 INFO - 'PWD': '/builds/slave/test', 03:52:39 INFO - 'SHELL': '/bin/bash', 03:52:39 INFO - 'SHLVL': '1', 03:52:39 INFO - 'TERM': 'linux', 03:52:39 INFO - 'TMOUT': '86400', 03:52:39 INFO - 'USER': 'cltbld', 03:52:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:39 INFO - '_': '/tools/buildbot/bin/python'} 03:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:39 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 03:52:39 INFO - Cleaning up... 03:52:39 INFO - Return code: 0 03:52:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:52:39 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')]} 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:39 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')]} 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:39 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:39 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 03:52:39 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 03:52:39 INFO - Using env: {'DISPLAY': ':0', 03:52:39 INFO - 'HOME': '/home/cltbld', 03:52:39 INFO - 'LANG': 'en_US.UTF-8', 03:52:39 INFO - 'LANGUAGE': 'en_US:en', 03:52:39 INFO - 'LOGNAME': 'cltbld', 03:52:39 INFO - 'MAIL': '/var/mail/cltbld', 03:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:39 INFO - 'MOZ_NO_REMOTE': '1', 03:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:39 INFO - 'NO_EM_RESTART': '1', 03:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:39 INFO - 'PWD': '/builds/slave/test', 03:52:39 INFO - 'SHELL': '/bin/bash', 03:52:39 INFO - 'SHLVL': '1', 03:52:39 INFO - 'TERM': 'linux', 03:52:39 INFO - 'TMOUT': '86400', 03:52:39 INFO - 'USER': 'cltbld', 03:52:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:39 INFO - '_': '/tools/buildbot/bin/python'} 03:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:39 INFO - Downloading/unpacking psutil>=0.7.1 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:41 INFO - Installing collected packages: psutil 03:52:41 INFO - Running setup.py install for psutil 03:52:41 INFO - building 'psutil._psutil_linux' extension 03:52:41 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 03:52:42 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 03:52:42 INFO - building 'psutil._psutil_posix' extension 03:52:42 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 03:52:42 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 03:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:42 INFO - Successfully installed psutil 03:52:42 INFO - Cleaning up... 03:52:42 INFO - Return code: 0 03:52:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:52:42 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')]} 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:42 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')]} 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:42 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:42 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 03:52:42 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 03:52:42 INFO - Using env: {'DISPLAY': ':0', 03:52:42 INFO - 'HOME': '/home/cltbld', 03:52:42 INFO - 'LANG': 'en_US.UTF-8', 03:52:42 INFO - 'LANGUAGE': 'en_US:en', 03:52:42 INFO - 'LOGNAME': 'cltbld', 03:52:42 INFO - 'MAIL': '/var/mail/cltbld', 03:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:42 INFO - 'MOZ_NO_REMOTE': '1', 03:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:42 INFO - 'NO_EM_RESTART': '1', 03:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:42 INFO - 'PWD': '/builds/slave/test', 03:52:42 INFO - 'SHELL': '/bin/bash', 03:52:42 INFO - 'SHLVL': '1', 03:52:42 INFO - 'TERM': 'linux', 03:52:42 INFO - 'TMOUT': '86400', 03:52:42 INFO - 'USER': 'cltbld', 03:52:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:42 INFO - '_': '/tools/buildbot/bin/python'} 03:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:52:44 INFO - Installing collected packages: mozsystemmonitor 03:52:44 INFO - Running setup.py install for mozsystemmonitor 03:52:44 INFO - Successfully installed mozsystemmonitor 03:52:44 INFO - Cleaning up... 03:52:44 INFO - Return code: 0 03:52:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:44 INFO - Using env: {'DISPLAY': ':0', 03:52:44 INFO - 'HOME': '/home/cltbld', 03:52:44 INFO - 'LANG': 'en_US.UTF-8', 03:52:44 INFO - 'LANGUAGE': 'en_US:en', 03:52:44 INFO - 'LOGNAME': 'cltbld', 03:52:44 INFO - 'MAIL': '/var/mail/cltbld', 03:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:44 INFO - 'MOZ_NO_REMOTE': '1', 03:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:44 INFO - 'NO_EM_RESTART': '1', 03:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:44 INFO - 'PWD': '/builds/slave/test', 03:52:44 INFO - 'SHELL': '/bin/bash', 03:52:44 INFO - 'SHLVL': '1', 03:52:44 INFO - 'TERM': 'linux', 03:52:44 INFO - 'TMOUT': '86400', 03:52:44 INFO - 'USER': 'cltbld', 03:52:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:44 INFO - '_': '/tools/buildbot/bin/python'} 03:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:47 INFO - Downloading docopt-0.6.1.tar.gz 03:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:47 INFO - Running setup.py install for blobuploader 03:52:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:47 INFO - Running setup.py install for requests 03:52:47 INFO - Running setup.py install for docopt 03:52:47 INFO - Successfully installed blobuploader requests docopt 03:52:47 INFO - Cleaning up... 03:52:48 INFO - Return code: 0 03:52:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:48 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:48 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 03:52:48 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 03:52:48 INFO - Using env: {'DISPLAY': ':0', 03:52:48 INFO - 'HOME': '/home/cltbld', 03:52:48 INFO - 'LANG': 'en_US.UTF-8', 03:52:48 INFO - 'LANGUAGE': 'en_US:en', 03:52:48 INFO - 'LOGNAME': 'cltbld', 03:52:48 INFO - 'MAIL': '/var/mail/cltbld', 03:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:48 INFO - 'MOZ_NO_REMOTE': '1', 03:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:48 INFO - 'NO_EM_RESTART': '1', 03:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:48 INFO - 'PWD': '/builds/slave/test', 03:52:48 INFO - 'SHELL': '/bin/bash', 03:52:48 INFO - 'SHLVL': '1', 03:52:48 INFO - 'TERM': 'linux', 03:52:48 INFO - 'TMOUT': '86400', 03:52:48 INFO - 'USER': 'cltbld', 03:52:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:48 INFO - '_': '/tools/buildbot/bin/python'} 03:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:48 INFO - Running setup.py (path:/tmp/pip-0h1yii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:48 INFO - Running setup.py (path:/tmp/pip-_fxBMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:48 INFO - Running setup.py (path:/tmp/pip-xzE4nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:48 INFO - Running setup.py (path:/tmp/pip-L5gXLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:48 INFO - Running setup.py (path:/tmp/pip-gIsA4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:48 INFO - Running setup.py (path:/tmp/pip-UUtdo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:48 INFO - Running setup.py (path:/tmp/pip-P_cMiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:48 INFO - Running setup.py (path:/tmp/pip-XBSZYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:48 INFO - Running setup.py (path:/tmp/pip-8EIhaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:48 INFO - Running setup.py (path:/tmp/pip-8PxX3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:48 INFO - Running setup.py (path:/tmp/pip-MsfFUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:49 INFO - Running setup.py (path:/tmp/pip-6sM0tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:49 INFO - Running setup.py (path:/tmp/pip-9J1AaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:49 INFO - Running setup.py (path:/tmp/pip-y8AjeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:49 INFO - Running setup.py (path:/tmp/pip-ZnyFz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:49 INFO - Running setup.py (path:/tmp/pip-5EW0AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:49 INFO - Running setup.py (path:/tmp/pip-qZMhZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:49 INFO - Running setup.py install for manifestparser 03:52:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:49 INFO - Running setup.py install for mozcrash 03:52:49 INFO - Running setup.py install for mozdebug 03:52:49 INFO - Running setup.py install for mozdevice 03:52:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:49 INFO - Running setup.py install for mozfile 03:52:49 INFO - Running setup.py install for mozhttpd 03:52:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for mozinfo 03:52:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for mozInstall 03:52:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for mozleak 03:52:50 INFO - Running setup.py install for mozlog 03:52:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for moznetwork 03:52:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for mozprocess 03:52:50 INFO - Running setup.py install for mozprofile 03:52:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for mozrunner 03:52:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Running setup.py install for mozscreenshot 03:52:51 INFO - Running setup.py install for moztest 03:52:51 INFO - Running setup.py install for mozversion 03:52:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:51 INFO - Cleaning up... 03:52:51 INFO - Return code: 0 03:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:51 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:51 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 03:52:51 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 03:52:51 INFO - Using env: {'DISPLAY': ':0', 03:52:51 INFO - 'HOME': '/home/cltbld', 03:52:51 INFO - 'LANG': 'en_US.UTF-8', 03:52:51 INFO - 'LANGUAGE': 'en_US:en', 03:52:51 INFO - 'LOGNAME': 'cltbld', 03:52:51 INFO - 'MAIL': '/var/mail/cltbld', 03:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:51 INFO - 'MOZ_NO_REMOTE': '1', 03:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:51 INFO - 'NO_EM_RESTART': '1', 03:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:51 INFO - 'PWD': '/builds/slave/test', 03:52:51 INFO - 'SHELL': '/bin/bash', 03:52:51 INFO - 'SHLVL': '1', 03:52:51 INFO - 'TERM': 'linux', 03:52:51 INFO - 'TMOUT': '86400', 03:52:51 INFO - 'USER': 'cltbld', 03:52:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:51 INFO - '_': '/tools/buildbot/bin/python'} 03:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:51 INFO - Running setup.py (path:/tmp/pip-4GMcaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:51 INFO - Running setup.py (path:/tmp/pip-SHPmBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:51 INFO - Running setup.py (path:/tmp/pip-AZd5bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:51 INFO - Running setup.py (path:/tmp/pip-bPbIeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:51 INFO - Running setup.py (path:/tmp/pip-IgtmoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:51 INFO - Running setup.py (path:/tmp/pip-zJK9st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:51 INFO - Running setup.py (path:/tmp/pip-5n2cdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:51 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)) 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:51 INFO - Running setup.py (path:/tmp/pip-CJH80C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:52 INFO - Running setup.py (path:/tmp/pip-PwJj1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:52 INFO - Running setup.py (path:/tmp/pip-umdTBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:52 INFO - Running setup.py (path:/tmp/pip-CaxmaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:52 INFO - Running setup.py (path:/tmp/pip-rHEdPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:52 INFO - Running setup.py (path:/tmp/pip-vMjmS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:52 INFO - Running setup.py (path:/tmp/pip-r5JPTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:52 INFO - Running setup.py (path:/tmp/pip-_jtIR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:52 INFO - Running setup.py (path:/tmp/pip-XYkvUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:52 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)) 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:52 INFO - Running setup.py (path:/tmp/pip-mglixC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:52 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)) 03:52:52 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)) 03:52:52 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)) 03:52:52 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)) 03:52:52 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)) 03:52:52 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)) 03:52:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:54 INFO - Downloading blessings-1.6.tar.gz 03:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:54 INFO - Installing collected packages: blessings 03:52:54 INFO - Running setup.py install for blessings 03:52:54 INFO - Successfully installed blessings 03:52:54 INFO - Cleaning up... 03:52:54 INFO - Return code: 0 03:52:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:55 INFO - Reading from file tmpfile_stdout 03:52:55 INFO - Current package versions: 03:52:55 INFO - argparse == 1.2.1 03:52:55 INFO - blessings == 1.6 03:52:55 INFO - blobuploader == 1.2.4 03:52:55 INFO - docopt == 0.6.1 03:52:55 INFO - manifestparser == 1.1 03:52:55 INFO - mozInstall == 1.12 03:52:55 INFO - mozcrash == 0.17 03:52:55 INFO - mozdebug == 0.1 03:52:55 INFO - mozdevice == 0.48 03:52:55 INFO - mozfile == 1.2 03:52:55 INFO - mozhttpd == 0.7 03:52:55 INFO - mozinfo == 0.9 03:52:55 INFO - mozleak == 0.1 03:52:55 INFO - mozlog == 3.1 03:52:55 INFO - moznetwork == 0.27 03:52:55 INFO - mozprocess == 0.22 03:52:55 INFO - mozprofile == 0.28 03:52:55 INFO - mozrunner == 6.11 03:52:55 INFO - mozscreenshot == 0.1 03:52:55 INFO - mozsystemmonitor == 0.0 03:52:55 INFO - moztest == 0.7 03:52:55 INFO - mozversion == 1.4 03:52:55 INFO - psutil == 3.1.1 03:52:55 INFO - requests == 1.2.3 03:52:55 INFO - wsgiref == 0.1.2 03:52:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:55 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:55 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 03:52:55 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 03:52:55 INFO - Using env: {'DISPLAY': ':0', 03:52:55 INFO - 'HOME': '/home/cltbld', 03:52:55 INFO - 'LANG': 'en_US.UTF-8', 03:52:55 INFO - 'LANGUAGE': 'en_US:en', 03:52:55 INFO - 'LOGNAME': 'cltbld', 03:52:55 INFO - 'MAIL': '/var/mail/cltbld', 03:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:55 INFO - 'MOZ_NO_REMOTE': '1', 03:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:55 INFO - 'NO_EM_RESTART': '1', 03:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:55 INFO - 'PWD': '/builds/slave/test', 03:52:55 INFO - 'SHELL': '/bin/bash', 03:52:55 INFO - 'SHLVL': '1', 03:52:55 INFO - 'TERM': 'linux', 03:52:55 INFO - 'TMOUT': '86400', 03:52:55 INFO - 'USER': 'cltbld', 03:52:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:55 INFO - '_': '/tools/buildbot/bin/python'} 03:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 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)) 03:52:55 INFO - Cleaning up... 03:52:55 INFO - Return code: 0 03:52:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:55 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:55 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 03:52:55 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 03:52:55 INFO - Using env: {'DISPLAY': ':0', 03:52:55 INFO - 'HOME': '/home/cltbld', 03:52:55 INFO - 'LANG': 'en_US.UTF-8', 03:52:55 INFO - 'LANGUAGE': 'en_US:en', 03:52:55 INFO - 'LOGNAME': 'cltbld', 03:52:55 INFO - 'MAIL': '/var/mail/cltbld', 03:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:55 INFO - 'MOZ_NO_REMOTE': '1', 03:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:55 INFO - 'NO_EM_RESTART': '1', 03:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:55 INFO - 'PWD': '/builds/slave/test', 03:52:55 INFO - 'SHELL': '/bin/bash', 03:52:55 INFO - 'SHLVL': '1', 03:52:55 INFO - 'TERM': 'linux', 03:52:55 INFO - 'TMOUT': '86400', 03:52:55 INFO - 'USER': 'cltbld', 03:52:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:55 INFO - '_': '/tools/buildbot/bin/python'} 03:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:55 INFO - Downloading/unpacking jsonschema 03:52:55 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 03:52:55 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 03:52:55 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 03:52:55 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 03:52:55 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 03:52:55 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 03:52:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:57 INFO - Downloading/unpacking functools32 (from jsonschema) 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:57 INFO - warning: no files found matching '*.txt' 03:52:57 INFO - no previously-included directories found matching 'build' 03:52:57 INFO - no previously-included directories found matching 'dist' 03:52:57 INFO - no previously-included directories found matching '.git*' 03:52:57 INFO - Installing collected packages: jsonschema, functools32 03:52:57 INFO - Running setup.py install for functools32 03:52:57 INFO - warning: no files found matching '*.txt' 03:52:57 INFO - no previously-included directories found matching 'build' 03:52:57 INFO - no previously-included directories found matching 'dist' 03:52:57 INFO - no previously-included directories found matching '.git*' 03:52:57 INFO - Successfully installed jsonschema functools32 03:52:57 INFO - Cleaning up... 03:52:57 INFO - Return code: 0 03:52:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:52:57 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')]} 03:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:57 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')]} 03:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:57 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 0x7f97602cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', '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 03:52:57 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 03:52:57 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 03:52:57 INFO - Using env: {'DISPLAY': ':0', 03:52:57 INFO - 'HOME': '/home/cltbld', 03:52:57 INFO - 'LANG': 'en_US.UTF-8', 03:52:57 INFO - 'LANGUAGE': 'en_US:en', 03:52:57 INFO - 'LOGNAME': 'cltbld', 03:52:57 INFO - 'MAIL': '/var/mail/cltbld', 03:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:57 INFO - 'MOZ_NO_REMOTE': '1', 03:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:57 INFO - 'NO_EM_RESTART': '1', 03:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:57 INFO - 'PWD': '/builds/slave/test', 03:52:57 INFO - 'SHELL': '/bin/bash', 03:52:57 INFO - 'SHLVL': '1', 03:52:57 INFO - 'TERM': 'linux', 03:52:57 INFO - 'TMOUT': '86400', 03:52:57 INFO - 'USER': 'cltbld', 03:52:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:57 INFO - '_': '/tools/buildbot/bin/python'} 03:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:57 INFO - Downloading/unpacking flake8 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 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 03:52:57 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 03:52:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:52:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:53:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:53:00 INFO - no previously-included directories found matching 'docs/_build' 03:53:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:53:00 INFO - Running setup.py install for pep8 03:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:53:00 INFO - no previously-included directories found matching 'docs/_build' 03:53:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:53:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:53:00 INFO - Cleaning up... 03:53:00 INFO - Return code: 0 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - Running post-action listener: _start_resource_monitoring 03:53:00 INFO - Starting resource monitoring. 03:53:00 INFO - ##### 03:53:00 INFO - ##### Running install step. 03:53:00 INFO - ##### 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: install 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:01 INFO - Reading from file tmpfile_stdout 03:53:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:01 INFO - Reading from file tmpfile_stdout 03:53:01 INFO - Output received: 03:53:01 INFO - Usage: mozinstall [options] installer 03:53:01 INFO - Options: 03:53:01 INFO - -h, --help show this help message and exit 03:53:01 INFO - -d DEST, --destination=DEST 03:53:01 INFO - Directory to install application into. [default: 03:53:01 INFO - "/builds/slave/test"] 03:53:01 INFO - --app=APP Application being installed. [default: firefox] 03:53:01 INFO - mkdir: /builds/slave/test/build/application 03:53:01 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'] 03:53:01 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 03:53:16 INFO - Reading from file tmpfile_stdout 03:53:16 INFO - Output received: 03:53:16 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:16 INFO - Running post-action listener: _resource_record_post_action 03:53:16 INFO - ##### 03:53:16 INFO - ##### Running run-tests step. 03:53:16 INFO - ##### 03:53:16 INFO - Running pre-action listener: _resource_record_pre_action 03:53:16 INFO - Running main action method: run_tests 03:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:16 INFO - Python 2.7.3 03:53:16 INFO - Return code: 0 03:53:16 INFO - grabbing minidump binary from tooltool 03:53:16 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')]} 03:53:16 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 0x116a410>, '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 0x116b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:16 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 03:53:16 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 03:53:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:16 INFO - Return code: 0 03:53:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:53:17 INFO - Return code: 0 03:53:17 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/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:53:17 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/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:53:17 INFO - Using env: {'DISPLAY': ':0', 03:53:17 INFO - 'HOME': '/home/cltbld', 03:53:17 INFO - 'LANG': 'en_US.UTF-8', 03:53:17 INFO - 'LANGUAGE': 'en_US:en', 03:53:17 INFO - 'LOGNAME': 'cltbld', 03:53:17 INFO - 'MAIL': '/var/mail/cltbld', 03:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:17 INFO - 'MOZ_NO_REMOTE': '1', 03:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:17 INFO - 'NO_EM_RESTART': '1', 03:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:17 INFO - 'PWD': '/builds/slave/test', 03:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:17 INFO - 'SHELL': '/bin/bash', 03:53:17 INFO - 'SHLVL': '1', 03:53:17 INFO - 'TERM': 'linux', 03:53:17 INFO - 'TMOUT': '86400', 03:53:17 INFO - 'USER': 'cltbld', 03:53:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104', 03:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:17 INFO - '_': '/tools/buildbot/bin/python'} 03:53:17 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/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:53:18 INFO - mozversion application_buildid: 20160419030056 03:53:18 INFO - mozversion application_changeset: 170eb8db5f8c99212b07756ce67ef86c45d7c229 03:53:18 INFO - mozversion application_display_name: Nightly 03:53:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:18 INFO - mozversion application_name: Firefox 03:53:18 INFO - mozversion application_remotingname: firefox 03:53:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:53:18 INFO - mozversion application_vendor: Mozilla 03:53:18 INFO - mozversion application_version: 48.0a1 03:53:18 INFO - mozversion platform_buildid: 20160419030056 03:53:18 INFO - mozversion platform_changeset: 170eb8db5f8c99212b07756ce67ef86c45d7c229 03:53:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:53:18 INFO - mozversion platform_version: 48.0a1 03:53:18 INFO - using testdate: 1461063198 03:53:18 INFO - actual date: 1461063198 03:53:18 INFO - starting webserver on 'localhost:41216' 03:53:18 INFO - SUITE-START | Running 2 tests 03:53:18 INFO - TEST-START | dromaeo_css 03:53:18 INFO - operating with platform_type : linux_ 03:53:18 INFO - Initialising browser for dromaeo_css test... 03:53:18 INFO - TEST-INFO | started process 4504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC49scN/profile http://localhost:41216/getInfo.html) 03:53:22 INFO - PROCESS | 4504 | __metrics Screen width/height:1600/1200 03:53:22 INFO - PROCESS | 4504 | colorDepth:24 03:53:22 INFO - PROCESS | 4504 | Browser inner width/height: 1024/697 03:53:22 INFO - PROCESS | 4504 | __metrics 03:53:23 ERROR - PROCESS | 4504 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:53:24 INFO - TEST-INFO | 4504: exit 0 03:53:24 INFO - Browser initialized. 03:53:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:24 INFO - TEST-INFO | started process 4587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC49scN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:36 INFO - PROCESS | 4587 | RSS: Main: 155373568 03:53:36 INFO - PROCESS | 4587 | 03:54:28 INFO - PROCESS | 4587 | 1461063268004 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] 03:56:39 INFO - PROCESS | 4587 | Cycle 1(1): loaded http://localhost:41216/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41216/tests/dromaeo/cssquery-ext.html) 03:56:40 INFO - PROCESS | 4587 | RSS: Main: 262189056 03:56:40 INFO - PROCESS | 4587 | 03:59:43 INFO - PROCESS | 4587 | Cycle 1(1): loaded http://localhost:41216/tests/dromaeo/cssquery-ext.html (next: http://localhost:41216/tests/dromaeo/cssquery-jquery.html) 03:59:43 INFO - PROCESS | 4587 | RSS: Main: 234041344 03:59:43 INFO - PROCESS | 4587 | 04:02:45 INFO - PROCESS | 4587 | Cycle 1(1): loaded http://localhost:41216/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41216/tests/dromaeo/cssquery-mootools.html) 04:02:46 INFO - PROCESS | 4587 | RSS: Main: 233099264 04:02:46 INFO - PROCESS | 4587 | 04:05:48 INFO - PROCESS | 4587 | Cycle 1(1): loaded http://localhost:41216/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41216/tests/dromaeo/cssquery-prototype.html) 04:05:49 INFO - PROCESS | 4587 | RSS: Main: 229982208 04:05:49 INFO - PROCESS | 4587 | 04:08:52 INFO - PROCESS | 4587 | Cycle 1(1): loaded http://localhost:41216/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41216/tests/dromaeo/cssquery-yui.html) 04:08:52 INFO - PROCESS | 4587 | RSS: Main: 214491136 04:08:52 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | Cycle 1(1): loaded http://localhost:41216/tests/dromaeo/cssquery-yui.html (next: http://localhost:41216/tests/dromaeo/cssquery-dojo.html) 04:11:55 INFO - PROCESS | 4587 | RSS: Main: 320749568 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | __start_tp_report 04:11:55 INFO - PROCESS | 4587 | _x_x_mozilla_page_load 04:11:55 INFO - PROCESS | 4587 | _x_x_mozilla_page_load_details 04:11:55 INFO - PROCESS | 4587 | |i|pagename|runs| 04:11:55 INFO - PROCESS | 4587 | |0;dojo.html;2576.3945472813894;2633.1310667479734;2647.6558047453827;2675.210812810221;2692.7441893020155;4467.821287148518;4547.113312903985;4549.090181963612;4562.84030058948;4582.495925448198;4584.106099310636;4608.53914608539;4642.6750127491005;4678.368420263263;4683.484816670172;4155.854545090922;4192.182524407742;4238.067625122468;4254.957450425502;4325.935110973338;4229.069604686964;4249.787510624472;4349.064951035527;4387.934180987288;4398.098389830077;4189.120284740208;4294.677899157576;4314.80583373749;4346.6088052075465;4352.695311328208;4191.832326706928;4229.661627069827;4251.681123915719;4277.529471758104;4286;4199.2441360555085;4217.114405974749;4219.9578004219875;4260.147970405931;4264.424302719155;4335.804888780012;4485.798139083717;4491.820327186909;4497.550244975509;4544.954550454519;4919.508049195088;4953.975230123862;4959.776810043557;5002.224655178453;5010.498950104997;4867.732274724889;4876.195427754416;4894.265860120975;4897.51024897511;4945.159322915077;4539.432570928634;4594.609458196024;4602.424696912886;4616.838410655678;4636.675432719677;5016.1723315653235;5033.295338652591;5036.294918711384;5052.646314758005;5080.720560369141;4797.352357431771;4797.616190704805;4799.352087468217;4846.39420072491;4847.442544107403;4823.493533178966;4829.27560865873;4919.901601968012;4936.605071594264;4987.401511818605;4839.128956787812;4848.393950756155;4848.903021939542;4895.534924182197;4939.851804445872;4872.342233798463;4878.268259761065;4882.584980276645;4890.755462226874;4926.064047830901;4150.3566947123245;4165.541790403053;4221.155768846243;4250.681198910094;4253.064325848309;3640.3265395901844;3657.74395792292;3684.7236457265276;3696.4455331699924;3709.647583479565;4208.558101399371;4213.325867861127;4213.768242746617;4220.873373798791;4258.914821703549;4818.734969576637;4891.26631005352;4917.65576409655;4972.925406118911;4976.850694479172;4230.70385073042;4237.597428244312;4242.5121111072;4250.702450828474;4300.311950087971;4518;4520.276755719069;4525.162844873643;4556.453225612948;4564.041551274203;4516.299973504178;4663.603593694574;4709.529047095263;4731.6214702823;4739.905201895874;4954.77703503336;4979.128652485728;4980.32765576657;4981.62637802159;5008.173651347633;4536.274196128604;4683.15703173432;4692.835750748707;4699.741514216751;4745.928811067768;4840.467548569584;4875.536824001714;4880.682755620874;4925.926111108408;4934.605231581537;4847.248676455155;4868.2210846264425;4870.2938073979785;4902.828401006091;4941.110600091874;4618.976905115453;4743.075100355535;4747.477777444409;4750.311204875205;4754.904901902012;4695.389599352063;4710.552497512731;4727.432708074915;4754.50077741846;4772.6659133861685;4676.111538807616;4690.671652984258;4697.7651117444675;4707.19977603815;4742.620590352694;4625.051864367864;4693.6949098308505;4807.206810876166;4837.975810120927;4848.5636292733825;4703.223968045234;4720.5043470436485;4722.315264286728;4746.2168742157155;4772.570468657837 04:11:55 INFO - PROCESS | 4587 | |1;ext.html;562.2971285892634;603.7192705391992;604.9637021778693;613.7084884679775;615.9384061593839;35078.47382289268;35837.46243806338;35932.82033589835;35943.92168234954;35946;37517.81241093798;38317.80841095798;38328;38347.424788628196;38393.23213535728;7291.08861392326;7503.0996280446425;7506.361959233444;7641.961790191055;7850.371970242395;9764.804703905918;10182.541785619627;10189.235807314444;10204.08163265306;10204.183665306758;9907.356021858592;10025;10027.498625068754;10029.197664186848;10032.69901902944;7523.210062943422;9821.90178098217;9863.605455781795;9979.002099790036;10285.331453455501;9762.414255144715;9816.460094694788;9884.90115098847;9920.958299378606;9931.354461959949;34896.651033489594;35573.110672233146;35620.109497262514;35630.82184589087;35635.465468018;2964.836933968631;3072.554479600468;3103.891363802256;3446.190145315849;3496.7202623790035;28434.715652843413;28824.947884945912;29529.114126576238;29549.40901181986;30046.69953300461;3322.551455553518;3373.3927892979254;3384.526166336715;3385.39062968668;3438.7249020078334;236391;237538;238346;238655;239864.99999999825;54363;55065.72467137719;55108.17337739937;55117;55175.51710173052;59993.70003150043;62105.37894620996;62147.6892615534;62165.68917155476;62193.689031555456;15757.763633545277;15968.600784980468;15986.680266394607;16069.116198608956;16088.195590220443;9577.377470464537;11942.701432464259;12038.458269377725;12371.13402061847;12421.689457763629;17954;17984.730229046574;18237.90881045586;18272.177752001193;18277.268909243747;6789.355011273921;7054.954063321682;7063.223045464994;7083.539569927938;7217;909.8771665825161;929.9163075323254;960.1406740966795;962.3456049886145;969.9224062075017;27420.588691169647;28168;28467.430651386858;28485.430291394056;28871;920.6317473010849;1011.3830563356347;1035.6219979707353;1039.6153423233452;1099.1591432554103;14727.484538041117;15039.398424063134;15041.107057291356;15191.164485953157;15329.080255184725;327470;333009;335467;335471;335623;49621;50546.49453505418;50583.24125138126;50588.241176382384;50615.493845061814;1061.7186445591924;1194.2177873492876;1232.8534462949365;1236.7773800715777;1244.1788419642992;25638;27987.72012279851;28323.575146373234;28373.716262837108;28810.855945720137;39433.80283098566;39601.603983959794;39921.40117898292;39992;40070.19859602733;224652;224692;226445;227109;227810;21725.239616613973;24927.376815579755;25656.615150773127;25686.100986465382;25717.3570660735;36053.45919811257;36167.457488137174;36352.27295454129;36714.265714685025;37270.44094338641;33274.500882486296;33508.49737253992;33877.153071173416;33947.32105357829;34132.317353653285;33287;33764.83117584397;33801.661983379854;33902.491462628575;34594.82702586471;34204.82897585496;34240.48639270363;34382.31235375329;34755.478667819494;37812.43281350727;28571.714282857738;28815.567766483102;31403.52894706627;31464.213394665316;31531.36937261196;24370.87814560916;24585;24665.38336541529;24960.750392495844;25078.37304067413 04:11:55 INFO - PROCESS | 4587 | |2;jquery.html;378.71974738693365;380.70495366091274;393.65358484533607;394.1820722001846;400.77957123582024;15448.768268475967;16685.24916378763;16828.74756878648;16940.23768930398;16965.49103526893;16791.244394002268;17287.654246915055;17352.219150138244;17502.474925752216;17508.56228594286;4960.330355402019;5186.351706036746;5193.766280517386;5210.16637338026;5212.713300768456;3658.3049220648127;5591.1054231323;5883.794067207648;5911.113333000041;5917.171595976567;5786.334571524287;5846.473817356437;5851.15158302046;5872.060470324749;5880.235569375996;5760.193572899777;5952.9702351488395;5976.5517586180995;5982.8803423931495;5986.790462333797;3361;3575.410057340536;4849.927251091236;5220.399654039796;5270.209468579744;19019.80980190194;19209.519762005923;19284.22863085475;20229.39311820633;20282.594348113103;1885.886846789197;1942.1648691062837;2010.316492392579;2278.669592909019;2358.9528209435716;10839.458027098692;11775.823362649568;12178.51285948561;12791.5522956697;12823.422945967453;1686.5306936617937;1690.7041267778213;1692.0947293198203;1701.7447382892665;1735.6962531556926;64924.675376622814;68345.3165468344;68413.31586684169;68474;68669.65665171642;9290.489023103793;9351.345405821663;9522.428654280766;9524.619015239312;9646.131848133702;13448.46206151743;13548.59354219375;13550.728985420434;13553;13571.457141714418;7398.3341499265325;7496.550206987489;7497.437692173109;7574.280443357872;7578.242175782488;7155.606441645656;7158.821029474305;7201.279872012757;7294.452916031319;7383.963080184672;5994.790182343597;6132.08018797184;6146.907796383058;6251.468625166821;6265.71804268809;1610.9436169734004;1691.2896583434988;1763.1360633289596;1796.5598428384867;1802.9278828846961;806.7700705298962;919.1911118215927;947.346331031586;948.184561277301;979.1481411172325;15319.540413787605;15644.296006679726;15763.66989349935;16140.919295403683;16420;879.771259472529;880.1154839386504;891.3092353426017;927.4481683398367;959.9184069354183;9142.177204051668;9314.72055838326;9479.620815167455;9547.761305967268;9620.37467564606;306601;310612;311292;393739;400194;82217.58891205506;86789;86951.1304886943;88794.55602721946;89035.55482222677;940.9623615055322;957.9760505987406;969.4474149734724;972.4505654305295;973.3867663372031;14782.260886955824;14968.850311496746;15257.923710381378;15312;15444;33357.83321083379;33741.32517349689;33896;34399.312013760085;34627;44657;47962;49622.75188624034;49677.751611241714;50221.74889125531;7521.210272921265;7573;7583;7630.1606823248285;7742.729004484816;10307.94846025765;11062.280951738112;11373.820430714299;11385.601503947322;11731.061515078944;9801.36291141102;10078.244131690006;10109.595616175271;10238.232132590234;10371.377717336984;9794.608215671293;10115.696529104138;10166.796664066826;10180.287379883337;10186.134178594903;10233.874273829724;10380.532876020749;10406.375617462976;10551.683449496528;10568;6452.451541619015;6735;6993.391519950338;7701;7721.150673425806;9569.808603828023;9886.209103271578;10050.597976081168;10060.195184385379;10089.24330675217 04:11:55 INFO - PROCESS | 4587 | |3;mootools.html;1263.709346850225;1418.7304412161686;1480.9851901480984;1578.7395079811831;1790.3912669692302;7408.888866666997;7614.619269036553;7628.923710762891;7635.083789945201;7667.654955527;7431.368333691643;7577.204393538668;7577.772666820004;7579.317861392474;7588.16530181681;1881.5390229393818;2163.9242626508076;2199.0434161139915;2227.2761352560483;2235.441139715063;2230.119102954332;2269.5914735347633;2275.9886200568976;2276.7495575486682;2277.1688333758143;2195.5938151441956;2254.5152792149684;2256.7630398808137;2256.7968882800546;2257.3566533537946;1924.422673198042;2149.4196566927;2219.82241420686;2222;2227.5656247031834;2162;2176.1621775616345;2187.059564387313;2188.7592364839857;2201.273579718689;7623.123340815821;7670.156282808886;7682.308592226671;7698.846023079563;7705.576193309365;4497.392851964975;4666.136764698507;4679.766011699401;4682.531746825324;4686.484486706459;2927.897523586664;2934.369110641201;3001.2196828824444;3030.6060212172497;3044.7868649194565;943.8772959515288;1695.8049824270242;1714.914254287293;1720.6128621060286;1728.4900954218535;9985.251106166994;10075.848862267072;10103.393796372167;10108.696739097839;10113.292069555135;3960.1881614269005;4026.57720939303;4103.076807718239;4123.072308730511;4137.855175068858;8082.797930051678;8096.473729207582;8111.310538604167;8123.512589244664;8318.334533237326;3967.0677390813134;4436.0462500562535;4437.600615944581;4438.178936896685;4445.5776701213335;4110.219058378958;4192.7065105442325;4196.370544418301;4217.768022758716;4235;3475.808830514346;3495.8951231463097;3562.3943929532043;3577.338192434408;3609.783412995229;1092.208149091902;1105.3699391346854;1110.4558766204502;1112.7941330853819;1128.6388355726253;830.4270053662954;834.6369329341755;840.4495055738502;842.7598134531752;844.923956843887;5183.792648294026;5228.2680424740565;5412;5440.510354068153;5459;427.7262551966744;429.5167936071919;431.3680458128856;435.965122790176;436.6026915506873;3644.7630903991158;3683.4290684943876;3707.351213537674;3736.0286325555007;3751.15598990225;9151.588178531982;9681.806363872684;9684.176844968257;9706.077922597342;9716.75708107303;9521.857172142423;9583.089606487372;9614;9621.615135394646;9637.566309515949;6960.303969602999;7024.121984751804;7034.437245020386;7050.753223637251;7057.50597458173;5122.871928201825;5220.295260139985;5265.341832270966;5277.868053298698;5367.490088441592;8521.147885211429;8561.44350617208;8628.482291062557;8686.218240358145;8701.303895688456;8583.828323433372;8633.266172375419;8861.291096712119;8873.068327825744;8929.241014513838;6161.507079433724;6397.808065758035;6399.0401439782545;6857.759978400732;6975.267596902455;6796.694148763218;7176.820579485346;7261.128664560287;7360.116785985716;7378.778636640909;6536.379043990813;6642.867142657216;6744.190697116377;6746.156730408699;6851.177858656993;6668.699908504032;6696.966515167588;6704.6982885769285;6718.126643536309;6939.063226464565;6387.744490220339;6496.545241833026;6544.116544266653;6558.04908288286;6560.245571759308;4603.240465323318;4701.412323459567;4704.717716936994;4790.592799611933;4799.064182484382;4616.469106052847;4624.953750462452;4686.343911852276;4702.11140678907;4808.230683090689 04:11:55 INFO - PROCESS | 4587 | |4;prototype.html;308.79310861722644;312.66076307206686;315.3849992514597;317.21489313947984;319.56539106814745;5121.692698438092;5151.356080489939;5172.741362931857;5179.792808287669;5195.428502864686;5065.822696205633;5083.771230294637;5088.618353623475;5093.923591146136;5099.337086178792;3781.508403907495;3848.8460461581503;3902.200048989964;3955.09032922428;3970.3721474195586;3990.700697447703;3993.960060399402;3996.940045899299;4012.8394864205397;4030.879073627796;3785.65929066384;3945.9605403946025;3977.4232736253225;3979.6418322350983;4003.719739618228;3837.2901013312485;3945.349017412138;3981.3231750602467;3991.261616600938;4010.939835902464;3543.7519373643854;3547.379208638478;3548.7515873888838;3559.110222444389;3564.803935783531;4845.830395936126;4860;4864.537868902484;4883.926741098886;4893.290472881448;4378.255696531597;4615.976920115378;4621.861344159681;4626.398568186114;4640.953590464086;5363.892722145535;5364.6512976656395;5369.731513424353;5378.784848606051;5379.542738867201;3890.533136023695;3893.377059670439;3896.2207558488417;3904.2581909437117;3920.313945059603;5550.72246387679;5609.80365687199;5629.155626655994;5634.859128521779;5650.547956163538;3945.546262179829;3982.084120652208;3983.6414722674517;3984.2828290907914;3995.2808494471274;4000.699947503949;4009.4587230724064;4010.438538604598;4011;4011.9799401002806;4393.0994146199955;4556.749378784199;4557.384753058361;4560;4567.406237189144;5325.334333208349;5349.759260833272;5355.98236335095;5356.3572371315695;5369.19462080691;1397.2385050147693;1421.9289035548181;1422.2177802208744;1425.600831767107;1427.8429372768987;902.9774255643662;958.4632605740808;977.9902200978041;979.7746518300688;983.188869182927;4623.930641040387;4624.375709279204;4651.558101980307;4655.138799322136;4655.580997710154;5464.890702185934;5469.031148786434;5476.123820188751;5479.232907392969;5492.945070549244;4526.388937493396;4630.560096790799;4650.255959046536;4662.7668616569035;4672.859814205512;2908.69458706837;2915.2420370703344;2923.137674386061;2926.6976195593184;2942.823430594171;5174.24973378858;5180;5183.3261675981885;5189.870253243699;5195.948040519622;5456.836294911159;5629.706621626395;5751.217122691979;5752.741126649311;5776.104703770839;5269.682579355162;5281.498257665516;5287.074761916572;5296.152615581488;5306.8407947761625;5293.523582877559;5589.916151257653;5608.495235428831;5610.354809196831;5632.408597097246;5422.728863556886;5456.61803673739;5456.672599644034;5478.123500239943;5483.067878460592;5224;5227.294315267391;5229.111051121395;5242.895142097213;5257.395399529103;3818.4081467372603;3878.96121038786;3888.727789054739;3902.375619900802;3905.7851818150275;5550.139728342114;5550.944490555043;5557.110862262019;5557.388687244481;5564.749586268708;5340.786368545215;5369.785208591768;5375.6774593524515;5390.407055224001;5422.295101636762;5214.270002199771;5348.224507446321;5348.732563371894;5388.622796404214;5395.109806881821;5024.57291130258;5241.6068794839775;5284.497972692588;5285.735713214401;5314.4951229633125;5140.845774626767;5411.404745478073;5445.591580631548;5450.91823622638;5451.918221226605;5309.681419114865;5314.97342513285;5333.546648534762;5335.813246536352;5337.866553336197 04:11:55 INFO - PROCESS | 4587 | |5;yui.html;679.1069743287574;680.2177495879739;712.2521352579791;756.5120497279258;767.6353731977312;11795.528178872846;12105.818412723795;12121.636350909486;12132.393380330992;12149.939250303747;11349.773004539904;11399.37303448312;11409.48657310421;11419.086473082154;11419.885801141985;634.3244444666416;770.5453782268461;790.8022994251437;796.8964034675485;798.3732769775727;782.4835608498393;786.5162924801234;790.075611534506;792.2354927494966;796.8127490039836;837.815680550278;839.9496030238174;840.0507426607925;840.6385254340662;841.1252297610478;659.9010148477719;802.9518228906285;820.2658620534647;820.9220124088203;821.2936874288107;609.1380696314753;609.3327806052365;609.3906093906094;609.5885277437711;609.6250805754429;10991.945040274748;11073.114150867992;11081.168912331526;11084.722881927935;11086.778264434746;11690.766184676258;12413.44139513724;12648.810267845989;12670.873291267062;12695.682607934783;10703.304285221435;11065.225434219608;11104.938394079438;11214;11223.831642525369;3255.365203785263;3326.501024846268;3350.463925771865;3413.897583072487;3421.9657803421896;47489.76255118737;47736.28395574069;47970.5202947973;48021.279680804815;48223.75888120537;9475.620975160917;9791;9988.750281242881;10184.949075254577;10399.32404393712;17432.302707891795;17455.563610909576;17478.91260543689;17487.82512174862;17490.737638935425;6333.65164915934;6449.129367535323;6490.350964903472;6532.314107018695;6780.254172041072;3573.3032058748295;3602.819859007039;3653.415453527423;3686.4101743720876;3914.2171565686976;2856.3430411005584;2950.0264912578796;2951.0851635992913;2951.1736713720193;2953.9113826585235;488.4822088586039;495.6381841255903;502.4322515557397;514.3930162408394;551.1952549278019;539.3016044222741;548.8216329692866;582.1384351160307;585.2450339062647;597.2593983460478;7735.970565770282;7804.804879878048;7895.289423951872;7911.169327220674;8352.081271060179;595.5116804220584;603.6740160313469;610.3042531514078;611.3031144495279;612.7487730030666;3893.3381325174787;3971.1065010372436;3987.6610488108836;3991.44119823225;4016.493661424508;56419.43580564142;57176.42823571794;58197.70901145467;58253;58417.41582584205;47781.522184778405;47992.760036199594;49538.50461495411;49571.75214123906;50572.74713626482;43483.78258108689;44893.73509516591;45507;45806.04521412262;46438.30342544865;7480.177180510248;7504.699812007459;7575.545467271982;7652.387808975157;7809.180036096355;27117.322066948484;29552.261193470335;29782.553261700657;30664.84667576648;30807.075787726404;35257.64742352646;35891.282174356886;35969;36373.636263637025;37543.81228093842;9594.472304023067;10445.164386848883;10699.94650026745;10793.892061079288;10950.671479855617;11597.18819682614;11699.2980421175;11779.116566257737;11906.285622862655;12360;10836.349819010884;10921.907809219014;11137.10903127764;11148.275362101438;11602.883971160518;10672.199585030998;11029.393383363671;11090.889091109308;11114.555417783522;11286.322820630789;10608.628697995533;10952.178586606196;11098.61154859576;11110.222284440011;11197.44012799373;9133.77165570866;9405.905940940504;9413.576389062371;9468.857967130361;9758.46328451942;8585.18440748128;8838.425502342327;8870.600822963112;8874.467531948103;9353.345265831327 04:11:55 INFO - PROCESS | 4587 | __end_tp_report 04:11:55 INFO - PROCESS | 4587 | __start_cc_report 04:11:55 INFO - PROCESS | 4587 | _x_x_mozilla_cycle_collect,1118 04:11:55 INFO - PROCESS | 4587 | __end_cc_report 04:11:55 INFO - PROCESS | 4587 | __startTimestamp1461064315764__endTimestamp 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | ------- Summary: start ------- 04:11:55 INFO - PROCESS | 4587 | Number of tests: 6 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | [#0] dojo.html Cycles:165 Average:4551.22 Median:4690.67 stddev:458.33 (9.8%) stddev-sans-first:432.76 04:11:55 INFO - PROCESS | 4587 | Values: 2576.4 2633.1 2647.7 2675.2 2692.7 4467.8 4547.1 4549.1 4562.8 4582.5 4584.1 4608.5 4642.7 4678.4 4683.5 4155.9 4192.2 4238.1 4255.0 4325.9 4229.1 4249.8 4349.1 4387.9 4398.1 4189.1 4294.7 4314.8 4346.6 4352.7 4191.8 4229.7 4251.7 4277.5 4286.0 4199.2 4217.1 4220.0 4260.1 4264.4 4335.8 4485.8 4491.8 4497.6 4545.0 4919.5 4954.0 4959.8 5002.2 5010.5 4867.7 4876.2 4894.3 4897.5 4945.2 4539.4 4594.6 4602.4 4616.8 4636.7 5016.2 5033.3 5036.3 5052.6 5080.7 4797.4 4797.6 4799.4 4846.4 4847.4 4823.5 4829.3 4919.9 4936.6 4987.4 4839.1 4848.4 4848.9 4895.5 4939.9 4872.3 4878.3 4882.6 4890.8 4926.1 4150.4 4165.5 4221.2 4250.7 4253.1 3640.3 3657.7 3684.7 3696.4 3709.6 4208.6 4213.3 4213.8 4220.9 4258.9 4818.7 4891.3 4917.7 4972.9 4976.9 4230.7 4237.6 4242.5 4250.7 4300.3 4518.0 4520.3 4525.2 4556.5 4564.0 4516.3 4663.6 4709.5 4731.6 4739.9 4954.8 4979.1 4980.3 4981.6 5008.2 4536.3 4683.2 4692.8 4699.7 4745.9 4840.5 4875.5 4880.7 4925.9 4934.6 4847.2 4868.2 4870.3 4902.8 4941.1 4619.0 4743.1 4747.5 4750.3 4754.9 4695.4 4710.6 4727.4 4754.5 4772.7 4676.1 4690.7 4697.8 4707.2 4742.6 4625.1 4693.7 4807.2 4838.0 4848.6 4703.2 4720.5 4722.3 4746.2 4772.6 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | [#1] ext.html Cycles:180 Average:42880.65 Median:33783.25 stddev:70650.38 (209.1%) stddev-sans-first:70777.12 04:11:55 INFO - PROCESS | 4587 | Values: 562.3 603.7 605.0 613.7 615.9 35078.5 35837.5 35932.8 35943.9 35946.0 37517.8 38317.8 38328.0 38347.4 38393.2 7291.1 7503.1 7506.4 7642.0 7850.4 9764.8 10182.5 10189.2 10204.1 10204.2 9907.4 10025.0 10027.5 10029.2 10032.7 7523.2 9821.9 9863.6 9979.0 10285.3 9762.4 9816.5 9884.9 9921.0 9931.4 34896.7 35573.1 35620.1 35630.8 35635.5 2964.8 3072.6 3103.9 3446.2 3496.7 28434.7 28824.9 29529.1 29549.4 30046.7 3322.6 3373.4 3384.5 3385.4 3438.7 236391.0 237538.0 238346.0 238655.0 239865.0 54363.0 55065.7 55108.2 55117.0 55175.5 59993.7 62105.4 62147.7 62165.7 62193.7 15757.8 15968.6 15986.7 16069.1 16088.2 9577.4 11942.7 12038.5 12371.1 12421.7 17954.0 17984.7 18237.9 18272.2 18277.3 6789.4 7055.0 7063.2 7083.5 7217.0 909.9 929.9 960.1 962.3 969.9 27420.6 28168.0 28467.4 28485.4 28871.0 920.6 1011.4 1035.6 1039.6 1099.2 14727.5 15039.4 15041.1 15191.2 15329.1 327470.0 333009.0 335467.0 335471.0 335623.0 49621.0 50546.5 50583.2 50588.2 50615.5 1061.7 1194.2 1232.9 1236.8 1244.2 25638.0 27987.7 28323.6 28373.7 28810.9 39433.8 39601.6 39921.4 39992.0 40070.2 224652.0 224692.0 226445.0 227109.0 227810.0 21725.2 24927.4 25656.6 25686.1 25717.4 36053.5 36167.5 36352.3 36714.3 37270.4 33274.5 33508.5 33877.2 33947.3 34132.3 33287.0 33764.8 33801.7 33902.5 34594.8 34204.8 34240.5 34382.3 34755.5 37812.4 28571.7 28815.6 31403.5 31464.2 31531.4 24370.9 24585.0 24665.4 24960.8 25078.4 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | [#2] jquery.html Cycles:180 Average:23146.97 Median:26405.96 stddev:57837.92 (219.0%) stddev-sans-first:57974.90 04:11:55 INFO - PROCESS | 4587 | Values: 378.7 380.7 393.7 394.2 400.8 15448.8 16685.2 16828.7 16940.2 16965.5 16791.2 17287.7 17352.2 17502.5 17508.6 4960.3 5186.4 5193.8 5210.2 5212.7 3658.3 5591.1 5883.8 5911.1 5917.2 5786.3 5846.5 5851.2 5872.1 5880.2 5760.2 5953.0 5976.6 5982.9 5986.8 3361.0 3575.4 4849.9 5220.4 5270.2 19019.8 19209.5 19284.2 20229.4 20282.6 1885.9 1942.2 2010.3 2278.7 2359.0 10839.5 11775.8 12178.5 12791.6 12823.4 1686.5 1690.7 1692.1 1701.7 1735.7 64924.7 68345.3 68413.3 68474.0 68669.7 9290.5 9351.3 9522.4 9524.6 9646.1 13448.5 13548.6 13550.7 13553.0 13571.5 7398.3 7496.6 7497.4 7574.3 7578.2 7155.6 7158.8 7201.3 7294.5 7384.0 5994.8 6132.1 6146.9 6251.5 6265.7 1610.9 1691.3 1763.1 1796.6 1802.9 806.8 919.2 947.3 948.2 979.1 15319.5 15644.3 15763.7 16140.9 16420.0 879.8 880.1 891.3 927.4 959.9 9142.2 9314.7 9479.6 9547.8 9620.4 306601.0 310612.0 311292.0 393739.0 400194.0 82217.6 86789.0 86951.1 88794.6 89035.6 941.0 958.0 969.4 972.5 973.4 14782.3 14968.9 15257.9 15312.0 15444.0 33357.8 33741.3 33896.0 34399.3 34627.0 44657.0 47962.0 49622.8 49677.8 50221.7 7521.2 7573.0 7583.0 7630.2 7742.7 10307.9 11062.3 11373.8 11385.6 11731.1 9801.4 10078.2 10109.6 10238.2 10371.4 9794.6 10115.7 10166.8 10180.3 10186.1 10233.9 10380.5 10406.4 10551.7 10568.0 6452.5 6735.0 6993.4 7701.0 7721.2 9569.8 9886.2 10050.6 10060.2 10089.2 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | [#3] mootools.html Cycles:180 Average:5063.26 Median:4794.83 stddev:2758.75 (57.5%) stddev-sans-first:2751.71 04:11:55 INFO - PROCESS | 4587 | Values: 1263.7 1418.7 1481.0 1578.7 1790.4 7408.9 7614.6 7628.9 7635.1 7667.7 7431.4 7577.2 7577.8 7579.3 7588.2 1881.5 2163.9 2199.0 2227.3 2235.4 2230.1 2269.6 2276.0 2276.7 2277.2 2195.6 2254.5 2256.8 2256.8 2257.4 1924.4 2149.4 2219.8 2222.0 2227.6 2162.0 2176.2 2187.1 2188.8 2201.3 7623.1 7670.2 7682.3 7698.8 7705.6 4497.4 4666.1 4679.8 4682.5 4686.5 2927.9 2934.4 3001.2 3030.6 3044.8 943.9 1695.8 1714.9 1720.6 1728.5 9985.3 10075.8 10103.4 10108.7 10113.3 3960.2 4026.6 4103.1 4123.1 4137.9 8082.8 8096.5 8111.3 8123.5 8318.3 3967.1 4436.0 4437.6 4438.2 4445.6 4110.2 4192.7 4196.4 4217.8 4235.0 3475.8 3495.9 3562.4 3577.3 3609.8 1092.2 1105.4 1110.5 1112.8 1128.6 830.4 834.6 840.4 842.8 844.9 5183.8 5228.3 5412.0 5440.5 5459.0 427.7 429.5 431.4 436.0 436.6 3644.8 3683.4 3707.4 3736.0 3751.2 9151.6 9681.8 9684.2 9706.1 9716.8 9521.9 9583.1 9614.0 9621.6 9637.6 6960.3 7024.1 7034.4 7050.8 7057.5 5122.9 5220.3 5265.3 5277.9 5367.5 8521.1 8561.4 8628.5 8686.2 8701.3 8583.8 8633.3 8861.3 8873.1 8929.2 6161.5 6397.8 6399.0 6857.8 6975.3 6796.7 7176.8 7261.1 7360.1 7378.8 6536.4 6642.9 6744.2 6746.2 6851.2 6668.7 6697.0 6704.7 6718.1 6939.1 6387.7 6496.5 6544.1 6558.0 6560.2 4603.2 4701.4 4704.7 4790.6 4799.1 4616.5 4625.0 4686.3 4702.1 4808.2 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | [#4] prototype.html Cycles:180 Average:4462.06 Median:5110.51 stddev:1291.48 (25.3%) stddev-sans-first:1256.91 04:11:55 INFO - PROCESS | 4587 | Values: 308.8 312.7 315.4 317.2 319.6 5121.7 5151.4 5172.7 5179.8 5195.4 5065.8 5083.8 5088.6 5093.9 5099.3 3781.5 3848.8 3902.2 3955.1 3970.4 3990.7 3994.0 3996.9 4012.8 4030.9 3785.7 3946.0 3977.4 3979.6 4003.7 3837.3 3945.3 3981.3 3991.3 4010.9 3543.8 3547.4 3548.8 3559.1 3564.8 4845.8 4860.0 4864.5 4883.9 4893.3 4378.3 4616.0 4621.9 4626.4 4641.0 5363.9 5364.7 5369.7 5378.8 5379.5 3890.5 3893.4 3896.2 3904.3 3920.3 5550.7 5609.8 5629.2 5634.9 5650.5 3945.5 3982.1 3983.6 3984.3 3995.3 4000.7 4009.5 4010.4 4011.0 4012.0 4393.1 4556.7 4557.4 4560.0 4567.4 5325.3 5349.8 5356.0 5356.4 5369.2 1397.2 1421.9 1422.2 1425.6 1427.8 903.0 958.5 978.0 979.8 983.2 4623.9 4624.4 4651.6 4655.1 4655.6 5464.9 5469.0 5476.1 5479.2 5492.9 4526.4 4630.6 4650.3 4662.8 4672.9 2908.7 2915.2 2923.1 2926.7 2942.8 5174.2 5180.0 5183.3 5189.9 5195.9 5456.8 5629.7 5751.2 5752.7 5776.1 5269.7 5281.5 5287.1 5296.2 5306.8 5293.5 5589.9 5608.5 5610.4 5632.4 5422.7 5456.6 5456.7 5478.1 5483.1 5224.0 5227.3 5229.1 5242.9 5257.4 3818.4 3879.0 3888.7 3902.4 3905.8 5550.1 5550.9 5557.1 5557.4 5564.7 5340.8 5369.8 5375.7 5390.4 5422.3 5214.3 5348.2 5348.7 5388.6 5395.1 5024.6 5241.6 5284.5 5285.7 5314.5 5140.8 5411.4 5445.6 5450.9 5451.9 5309.7 5315.0 5333.5 5335.8 5337.9 04:11:55 INFO - PROCESS | 4587 | 04:11:55 INFO - PROCESS | 4587 | [#5] yui.html Cycles:180 Average:12977.76 Median:46964.03 stddev:15215.51 (32.4%) stddev-sans-first:15230.16 04:11:55 INFO - PROCESS | 4587 | Values: 679.1 680.2 712.3 756.5 767.6 11795.5 12105.8 12121.6 12132.4 12149.9 11349.8 11399.4 11409.5 11419.1 11419.9 634.3 770.5 790.8 796.9 798.4 782.5 786.5 790.1 792.2 796.8 837.8 839.9 840.1 840.6 841.1 659.9 803.0 820.3 820.9 821.3 609.1 609.3 609.4 609.6 609.6 10991.9 11073.1 11081.2 11084.7 11086.8 11690.8 12413.4 12648.8 12670.9 12695.7 10703.3 11065.2 11104.9 11214.0 11223.8 3255.4 3326.5 3350.5 3413.9 3422.0 47489.8 47736.3 47970.5 48021.3 48223.8 9475.6 9791.0 9988.8 10184.9 10399.3 17432.3 17455.6 17478.9 17487.8 17490.7 6333.7 6449.1 6490.4 6532.3 6780.3 3573.3 3602.8 3653.4 3686.4 3914.2 2856.3 2950.0 2951.1 2951.2 2953.9 488.5 495.6 502.4 514.4 551.2 539.3 548.8 582.1 585.2 597.3 7736.0 7804.8 7895.3 7911.2 8352.1 595.5 603.7 610.3 611.3 612.7 3893.3 3971.1 3987.7 3991.4 4016.5 56419.4 57176.4 58197.7 58253.0 58417.4 47781.5 47992.8 49538.5 49571.8 50572.7 43483.8 44893.7 45507.0 45806.0 46438.3 7480.2 7504.7 7575.5 7652.4 7809.2 27117.3 29552.3 29782.6 30664.8 30807.1 35257.6 35891.3 35969.0 36373.6 37543.8 9594.5 10445.2 10699.9 10793.9 10950.7 11597.2 11699.3 11779.1 11906.3 12360.0 10836.3 10921.9 11137.1 11148.3 11602.9 10672.2 11029.4 11090.9 11114.6 11286.3 10608.6 10952.2 11098.6 11110.2 11197.4 9133.8 9405.9 9413.6 9468.9 9758.5 8585.2 8838.4 8870.6 8874.5 9353.3 04:11:55 INFO - PROCESS | 4587 | -------- Summary: end -------- 04:11:55 INFO - PROCESS | 4587 | 04:11:56 INFO - TEST-INFO | 4587: exit 0 04:11:56 INFO - TEST-OK | dromaeo_css | took 1118401ms 04:11:56 INFO - TEST-START | kraken 04:11:56 INFO - operating with platform_type : linux_ 04:11:56 INFO - Initialising browser for kraken test... 04:11:56 INFO - TEST-INFO | started process 4771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2hdw8K/profile http://localhost:41216/getInfo.html) 04:12:00 INFO - PROCESS | 4771 | __metrics Screen width/height:1600/1200 04:12:00 INFO - PROCESS | 4771 | colorDepth:24 04:12:00 INFO - PROCESS | 4771 | Browser inner width/height: 1024/697 04:12:00 INFO - PROCESS | 4771 | __metrics 04:12:01 ERROR - PROCESS | 4771 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:12:02 INFO - TEST-INFO | 4771: exit 0 04:12:02 INFO - Browser initialized. 04:12:02 INFO - Running cycle 1/1 for kraken test... 04:12:02 INFO - TEST-INFO | started process 4855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2hdw8K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:14 INFO - PROCESS | 4855 | RSS: Main: 155049984 04:12:14 INFO - PROCESS | 4855 | 04:12:17 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41216/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:17 INFO - PROCESS | 4855 | RSS: Main: 209711104 04:12:17 INFO - PROCESS | 4855 | 04:12:20 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41216/tests/kraken/driver.html?testName=audio-dft) 04:12:21 INFO - PROCESS | 4855 | RSS: Main: 195182592 04:12:21 INFO - PROCESS | 4855 | 04:12:24 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41216/tests/kraken/driver.html?testName=audio-fft) 04:12:25 INFO - PROCESS | 4855 | RSS: Main: 266158080 04:12:25 INFO - PROCESS | 4855 | 04:12:27 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41216/tests/kraken/driver.html?testName=audio-oscillator) 04:12:27 INFO - PROCESS | 4855 | RSS: Main: 174579712 04:12:27 INFO - PROCESS | 4855 | 04:12:30 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41216/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:30 INFO - PROCESS | 4855 | RSS: Main: 178606080 04:12:30 INFO - PROCESS | 4855 | 04:12:33 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41216/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:34 INFO - PROCESS | 4855 | RSS: Main: 214777856 04:12:34 INFO - PROCESS | 4855 | 04:12:37 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41216/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:38 INFO - PROCESS | 4855 | RSS: Main: 214892544 04:12:38 INFO - PROCESS | 4855 | 04:12:41 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41216/tests/kraken/driver.html?testName=json-parse-financial) 04:12:42 INFO - PROCESS | 4855 | RSS: Main: 215539712 04:12:42 INFO - PROCESS | 4855 | 04:12:43 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41216/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:44 INFO - PROCESS | 4855 | RSS: Main: 202108928 04:12:44 INFO - PROCESS | 4855 | 04:12:46 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:46 INFO - PROCESS | 4855 | RSS: Main: 204529664 04:12:46 INFO - PROCESS | 4855 | 04:12:48 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:49 INFO - PROCESS | 4855 | RSS: Main: 219729920 04:12:49 INFO - PROCESS | 4855 | 04:12:52 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:52 INFO - PROCESS | 4855 | RSS: Main: 223715328 04:12:52 INFO - PROCESS | 4855 | 04:12:55 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:56 INFO - PROCESS | 4855 | RSS: Main: 218562560 04:12:56 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | Cycle 1(1): loaded http://localhost:41216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41216/tests/kraken/driver.html?testName=ai-astar) 04:12:58 INFO - PROCESS | 4855 | RSS: Main: 281825280 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | __start_tp_report 04:12:58 INFO - PROCESS | 4855 | _x_x_mozilla_page_load 04:12:58 INFO - PROCESS | 4855 | _x_x_mozilla_page_load_details 04:12:58 INFO - PROCESS | 4855 | |i|pagename|runs| 04:12:58 INFO - PROCESS | 4855 | |0;ai-astar;112;114;108;114;113;113;102;112;114;113 04:12:58 INFO - PROCESS | 4855 | |1;audio-beat-detection;163;135;155;189;134;154;161;134;183;138 04:12:58 INFO - PROCESS | 4855 | |2;audio-dft;161;161;161;162;162;163;162;163;162;163 04:12:58 INFO - PROCESS | 4855 | |3;audio-fft;75;74;103;103;75;74;73;117;112;73 04:12:58 INFO - PROCESS | 4855 | |4;audio-oscillator;94;95;150;93;92;93;146;93;93;145 04:12:58 INFO - PROCESS | 4855 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;118 04:12:58 INFO - PROCESS | 4855 | |6;imaging-darkroom;146;146;145;146;146;147;146;146;145;147 04:12:58 INFO - PROCESS | 4855 | |7;imaging-desaturate;94;95;96;96;96;95;94;95;94;96 04:12:58 INFO - PROCESS | 4855 | |8;json-parse-financial;63;65;64;65;64;64;65;80;62;64 04:12:58 INFO - PROCESS | 4855 | |9;json-stringify-tinderbox;64;66;64;65;65;64;65;64;64;64 04:12:58 INFO - PROCESS | 4855 | |10;stanford-crypto-aes;79;79;78;79;87;79;80;79;79;81 04:12:58 INFO - PROCESS | 4855 | |11;stanford-crypto-ccm;138;138;134;132;130;140;134;131;171;136 04:12:58 INFO - PROCESS | 4855 | |12;stanford-crypto-pbkdf2;180;179;173;175;179;176;173;171;177;173 04:12:58 INFO - PROCESS | 4855 | |13;stanford-crypto-sha256-iterative;78;73;71;77;72;73;71;70;71;71 04:12:58 INFO - PROCESS | 4855 | __end_tp_report 04:12:58 INFO - PROCESS | 4855 | __start_cc_report 04:12:58 INFO - PROCESS | 4855 | _x_x_mozilla_cycle_collect,1910 04:12:58 INFO - PROCESS | 4855 | __end_cc_report 04:12:58 INFO - PROCESS | 4855 | __startTimestamp1461064378587__endTimestamp 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | ------- Summary: start ------- 04:12:58 INFO - PROCESS | 4855 | Number of tests: 14 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:4.00 04:12:58 INFO - PROCESS | 4855 | Values: 112.0 114.0 108.0 114.0 113.0 113.0 102.0 112.0 114.0 113.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:158.00 stddev:20.03 (12.7%) stddev-sans-first:21.01 04:12:58 INFO - PROCESS | 4855 | Values: 163.0 135.0 155.0 189.0 134.0 154.0 161.0 134.0 183.0 138.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 04:12:58 INFO - PROCESS | 4855 | Values: 161.0 161.0 161.0 162.0 162.0 163.0 162.0 163.0 162.0 163.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#3] audio-fft Cycles:10 Average:87.90 Median:73.50 stddev:18.40 (25.0%) stddev-sans-first:18.91 04:12:58 INFO - PROCESS | 4855 | Values: 75.0 74.0 103.0 103.0 75.0 74.0 73.0 117.0 112.0 73.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:25.99 (27.9%) stddev-sans-first:26.96 04:12:58 INFO - PROCESS | 4855 | Values: 94.0 95.0 150.0 93.0 92.0 93.0 146.0 93.0 93.0 145.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:12:58 INFO - PROCESS | 4855 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:12:58 INFO - PROCESS | 4855 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.50 stddev:0.88 (0.9%) stddev-sans-first:0.83 04:12:58 INFO - PROCESS | 4855 | Values: 94.0 95.0 96.0 96.0 96.0 95.0 94.0 95.0 94.0 96.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:64.50 stddev:5.15 (8.0%) stddev-sans-first:5.37 04:12:58 INFO - PROCESS | 4855 | Values: 63.0 65.0 64.0 65.0 64.0 64.0 65.0 80.0 62.0 64.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:12:58 INFO - PROCESS | 4855 | Values: 64.0 66.0 64.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:2.58 (3.3%) stddev-sans-first:2.71 04:12:58 INFO - PROCESS | 4855 | Values: 79.0 79.0 78.0 79.0 87.0 79.0 80.0 79.0 79.0 81.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:137.00 stddev:11.91 (8.7%) stddev-sans-first:12.63 04:12:58 INFO - PROCESS | 4855 | Values: 138.0 138.0 134.0 132.0 130.0 140.0 134.0 131.0 171.0 136.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.50 stddev:3.10 (1.8%) stddev-sans-first:2.85 04:12:58 INFO - PROCESS | 4855 | Values: 180.0 179.0 173.0 175.0 179.0 176.0 173.0 171.0 177.0 173.0 04:12:58 INFO - PROCESS | 4855 | 04:12:58 INFO - PROCESS | 4855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:72.50 stddev:2.71 (3.7%) stddev-sans-first:2.09 04:12:58 INFO - PROCESS | 4855 | Values: 78.0 73.0 71.0 77.0 72.0 73.0 71.0 70.0 71.0 71.0 04:12:58 INFO - PROCESS | 4855 | -------- Summary: end -------- 04:12:58 INFO - PROCESS | 4855 | 04:12:59 INFO - TEST-INFO | 4855: exit 0 04:12:59 INFO - TEST-OK | kraken | took 63093ms 04:12:59 INFO - SUITE-END | took 1181s 04:12:59 INFO - Completed test suite (00:19:41) 04:12:59 INFO - javascript benchmark 04:12:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.3945472813894, 2633.1310667479734, 2647.6558047453827, 2675.210812810221, 2692.7441893020155, 4467.821287148518, 4547.113312903985, 4549.090181963612, 4562.84030058948, 4582.495925448198, 4584.106099310636, 4608.53914608539, 4642.6750127491005, 4678.368420263263, 4683.484816670172, 4155.854545090922, 4192.182524407742, 4238.067625122468, 4254.957450425502, 4325.935110973338, 4229.069604686964, 4249.787510624472, 4349.064951035527, 4387.934180987288, 4398.098389830077, 4189.120284740208, 4294.677899157576, 4314.80583373749, 4346.6088052075465, 4352.695311328208, 4191.832326706928, 4229.661627069827, 4251.681123915719, 4277.529471758104, 4286.0, 4199.2441360555085, 4217.114405974749, 4219.9578004219875, 4260.147970405931, 4264.424302719155, 4335.804888780012, 4485.798139083717, 4491.820327186909, 4497.550244975509, 4544.954550454519, 4919.508049195088, 4953.975230123862, 4959.776810043557, 5002.224655178453, 5010.498950104997, 4867.732274724889, 4876.195427754416, 4894.265860120975, 4897.51024897511, 4945.159322915077, 4539.432570928634, 4594.609458196024, 4602.424696912886, 4616.838410655678, 4636.675432719677, 5016.1723315653235, 5033.295338652591, 5036.294918711384, 5052.646314758005, 5080.720560369141, 4797.352357431771, 4797.616190704805, 4799.352087468217, 4846.39420072491, 4847.442544107403, 4823.493533178966, 4829.27560865873, 4919.901601968012, 4936.605071594264, 4987.401511818605, 4839.128956787812, 4848.393950756155, 4848.903021939542, 4895.534924182197, 4939.851804445872, 4872.342233798463, 4878.268259761065, 4882.584980276645, 4890.755462226874, 4926.064047830901, 4150.3566947123245, 4165.541790403053, 4221.155768846243, 4250.681198910094, 4253.064325848309, 3640.3265395901844, 3657.74395792292, 3684.7236457265276, 3696.4455331699924, 3709.647583479565, 4208.558101399371, 4213.325867861127, 4213.768242746617, 4220.873373798791, 4258.914821703549, 4818.734969576637, 4891.26631005352, 4917.65576409655, 4972.925406118911, 4976.850694479172, 4230.70385073042, 4237.597428244312, 4242.5121111072, 4250.702450828474, 4300.311950087971, 4518.0, 4520.276755719069, 4525.162844873643, 4556.453225612948, 4564.041551274203, 4516.299973504178, 4663.603593694574, 4709.529047095263, 4731.6214702823, 4739.905201895874, 4954.77703503336, 4979.128652485728, 4980.32765576657, 4981.62637802159, 5008.173651347633, 4536.274196128604, 4683.15703173432, 4692.835750748707, 4699.741514216751, 4745.928811067768, 4840.467548569584, 4875.536824001714, 4880.682755620874, 4925.926111108408, 4934.605231581537, 4847.248676455155, 4868.2210846264425, 4870.2938073979785, 4902.828401006091, 4941.110600091874, 4618.976905115453, 4743.075100355535, 4747.477777444409, 4750.311204875205, 4754.904901902012, 4695.389599352063, 4710.552497512731, 4727.432708074915, 4754.50077741846, 4772.6659133861685, 4676.111538807616, 4690.671652984258, 4697.7651117444675, 4707.19977603815, 4742.620590352694, 4625.051864367864, 4693.6949098308505, 4807.206810876166, 4837.975810120927, 4848.5636292733825, 4703.223968045234, 4720.5043470436485, 4722.315264286728, 4746.2168742157155, 4772.570468657837], "value": 4523.3954487677565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2971285892634, 603.7192705391992, 604.9637021778693, 613.7084884679775, 615.9384061593839, 35078.47382289268, 35837.46243806338, 35932.82033589835, 35943.92168234954, 35946.0, 37517.81241093798, 38317.80841095798, 38328.0, 38347.424788628196, 38393.23213535728, 7291.08861392326, 7503.0996280446425, 7506.361959233444, 7641.961790191055, 7850.371970242395, 9764.804703905918, 10182.541785619627, 10189.235807314444, 10204.08163265306, 10204.183665306758, 9907.356021858592, 10025.0, 10027.498625068754, 10029.197664186848, 10032.69901902944, 7523.210062943422, 9821.90178098217, 9863.605455781795, 9979.002099790036, 10285.331453455501, 9762.414255144715, 9816.460094694788, 9884.90115098847, 9920.958299378606, 9931.354461959949, 34896.651033489594, 35573.110672233146, 35620.109497262514, 35630.82184589087, 35635.465468018, 2964.836933968631, 3072.554479600468, 3103.891363802256, 3446.190145315849, 3496.7202623790035, 28434.715652843413, 28824.947884945912, 29529.114126576238, 29549.40901181986, 30046.69953300461, 3322.551455553518, 3373.3927892979254, 3384.526166336715, 3385.39062968668, 3438.7249020078334, 236391.0, 237538.0, 238346.0, 238655.0, 239864.99999999825, 54363.0, 55065.72467137719, 55108.17337739937, 55117.0, 55175.51710173052, 59993.70003150043, 62105.37894620996, 62147.6892615534, 62165.68917155476, 62193.689031555456, 15757.763633545277, 15968.600784980468, 15986.680266394607, 16069.116198608956, 16088.195590220443, 9577.377470464537, 11942.701432464259, 12038.458269377725, 12371.13402061847, 12421.689457763629, 17954.0, 17984.730229046574, 18237.90881045586, 18272.177752001193, 18277.268909243747, 6789.355011273921, 7054.954063321682, 7063.223045464994, 7083.539569927938, 7217.0, 909.8771665825161, 929.9163075323254, 960.1406740966795, 962.3456049886145, 969.9224062075017, 27420.588691169647, 28168.0, 28467.430651386858, 28485.430291394056, 28871.0, 920.6317473010849, 1011.3830563356347, 1035.6219979707353, 1039.6153423233452, 1099.1591432554103, 14727.484538041117, 15039.398424063134, 15041.107057291356, 15191.164485953157, 15329.080255184725, 327470.0, 333009.0, 335467.0, 335471.0, 335623.0, 49621.0, 50546.49453505418, 50583.24125138126, 50588.241176382384, 50615.493845061814, 1061.7186445591924, 1194.2177873492876, 1232.8534462949365, 1236.7773800715777, 1244.1788419642992, 25638.0, 27987.72012279851, 28323.575146373234, 28373.716262837108, 28810.855945720137, 39433.80283098566, 39601.603983959794, 39921.40117898292, 39992.0, 40070.19859602733, 224652.0, 224692.0, 226445.0, 227109.0, 227810.0, 21725.239616613973, 24927.376815579755, 25656.615150773127, 25686.100986465382, 25717.3570660735, 36053.45919811257, 36167.457488137174, 36352.27295454129, 36714.265714685025, 37270.44094338641, 33274.500882486296, 33508.49737253992, 33877.153071173416, 33947.32105357829, 34132.317353653285, 33287.0, 33764.83117584397, 33801.661983379854, 33902.491462628575, 34594.82702586471, 34204.82897585496, 34240.48639270363, 34382.31235375329, 34755.478667819494, 37812.43281350727, 28571.714282857738, 28815.567766483102, 31403.52894706627, 31464.213394665316, 31531.36937261196, 24370.87814560916, 24585.0, 24665.38336541529, 24960.750392495844, 25078.37304067413], "value": 17621.65070143372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.71974738693365, 380.70495366091274, 393.65358484533607, 394.1820722001846, 400.77957123582024, 15448.768268475967, 16685.24916378763, 16828.74756878648, 16940.23768930398, 16965.49103526893, 16791.244394002268, 17287.654246915055, 17352.219150138244, 17502.474925752216, 17508.56228594286, 4960.330355402019, 5186.351706036746, 5193.766280517386, 5210.16637338026, 5212.713300768456, 3658.3049220648127, 5591.1054231323, 5883.794067207648, 5911.113333000041, 5917.171595976567, 5786.334571524287, 5846.473817356437, 5851.15158302046, 5872.060470324749, 5880.235569375996, 5760.193572899777, 5952.9702351488395, 5976.5517586180995, 5982.8803423931495, 5986.790462333797, 3361.0, 3575.410057340536, 4849.927251091236, 5220.399654039796, 5270.209468579744, 19019.80980190194, 19209.519762005923, 19284.22863085475, 20229.39311820633, 20282.594348113103, 1885.886846789197, 1942.1648691062837, 2010.316492392579, 2278.669592909019, 2358.9528209435716, 10839.458027098692, 11775.823362649568, 12178.51285948561, 12791.5522956697, 12823.422945967453, 1686.5306936617937, 1690.7041267778213, 1692.0947293198203, 1701.7447382892665, 1735.6962531556926, 64924.675376622814, 68345.3165468344, 68413.31586684169, 68474.0, 68669.65665171642, 9290.489023103793, 9351.345405821663, 9522.428654280766, 9524.619015239312, 9646.131848133702, 13448.46206151743, 13548.59354219375, 13550.728985420434, 13553.0, 13571.457141714418, 7398.3341499265325, 7496.550206987489, 7497.437692173109, 7574.280443357872, 7578.242175782488, 7155.606441645656, 7158.821029474305, 7201.279872012757, 7294.452916031319, 7383.963080184672, 5994.790182343597, 6132.08018797184, 6146.907796383058, 6251.468625166821, 6265.71804268809, 1610.9436169734004, 1691.2896583434988, 1763.1360633289596, 1796.5598428384867, 1802.9278828846961, 806.7700705298962, 919.1911118215927, 947.346331031586, 948.184561277301, 979.1481411172325, 15319.540413787605, 15644.296006679726, 15763.66989349935, 16140.919295403683, 16420.0, 879.771259472529, 880.1154839386504, 891.3092353426017, 927.4481683398367, 959.9184069354183, 9142.177204051668, 9314.72055838326, 9479.620815167455, 9547.761305967268, 9620.37467564606, 306601.0, 310612.0, 311292.0, 393739.0, 400194.0, 82217.58891205506, 86789.0, 86951.1304886943, 88794.55602721946, 89035.55482222677, 940.9623615055322, 957.9760505987406, 969.4474149734724, 972.4505654305295, 973.3867663372031, 14782.260886955824, 14968.850311496746, 15257.923710381378, 15312.0, 15444.0, 33357.83321083379, 33741.32517349689, 33896.0, 34399.312013760085, 34627.0, 44657.0, 47962.0, 49622.75188624034, 49677.751611241714, 50221.74889125531, 7521.210272921265, 7573.0, 7583.0, 7630.1606823248285, 7742.729004484816, 10307.94846025765, 11062.280951738112, 11373.820430714299, 11385.601503947322, 11731.061515078944, 9801.36291141102, 10078.244131690006, 10109.595616175271, 10238.232132590234, 10371.377717336984, 9794.608215671293, 10115.696529104138, 10166.796664066826, 10180.287379883337, 10186.134178594903, 10233.874273829724, 10380.532876020749, 10406.375617462976, 10551.683449496528, 10568.0, 6452.451541619015, 6735.0, 6993.391519950338, 7701.0, 7721.150673425806, 9569.808603828023, 9886.209103271578, 10050.597976081168, 10060.195184385379, 10089.24330675217], "value": 8291.320577994233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.709346850225, 1418.7304412161686, 1480.9851901480984, 1578.7395079811831, 1790.3912669692302, 7408.888866666997, 7614.619269036553, 7628.923710762891, 7635.083789945201, 7667.654955527, 7431.368333691643, 7577.204393538668, 7577.772666820004, 7579.317861392474, 7588.16530181681, 1881.5390229393818, 2163.9242626508076, 2199.0434161139915, 2227.2761352560483, 2235.441139715063, 2230.119102954332, 2269.5914735347633, 2275.9886200568976, 2276.7495575486682, 2277.1688333758143, 2195.5938151441956, 2254.5152792149684, 2256.7630398808137, 2256.7968882800546, 2257.3566533537946, 1924.422673198042, 2149.4196566927, 2219.82241420686, 2222.0, 2227.5656247031834, 2162.0, 2176.1621775616345, 2187.059564387313, 2188.7592364839857, 2201.273579718689, 7623.123340815821, 7670.156282808886, 7682.308592226671, 7698.846023079563, 7705.576193309365, 4497.392851964975, 4666.136764698507, 4679.766011699401, 4682.531746825324, 4686.484486706459, 2927.897523586664, 2934.369110641201, 3001.2196828824444, 3030.6060212172497, 3044.7868649194565, 943.8772959515288, 1695.8049824270242, 1714.914254287293, 1720.6128621060286, 1728.4900954218535, 9985.251106166994, 10075.848862267072, 10103.393796372167, 10108.696739097839, 10113.292069555135, 3960.1881614269005, 4026.57720939303, 4103.076807718239, 4123.072308730511, 4137.855175068858, 8082.797930051678, 8096.473729207582, 8111.310538604167, 8123.512589244664, 8318.334533237326, 3967.0677390813134, 4436.0462500562535, 4437.600615944581, 4438.178936896685, 4445.5776701213335, 4110.219058378958, 4192.7065105442325, 4196.370544418301, 4217.768022758716, 4235.0, 3475.808830514346, 3495.8951231463097, 3562.3943929532043, 3577.338192434408, 3609.783412995229, 1092.208149091902, 1105.3699391346854, 1110.4558766204502, 1112.7941330853819, 1128.6388355726253, 830.4270053662954, 834.6369329341755, 840.4495055738502, 842.7598134531752, 844.923956843887, 5183.792648294026, 5228.2680424740565, 5412.0, 5440.510354068153, 5459.0, 427.7262551966744, 429.5167936071919, 431.3680458128856, 435.965122790176, 436.6026915506873, 3644.7630903991158, 3683.4290684943876, 3707.351213537674, 3736.0286325555007, 3751.15598990225, 9151.588178531982, 9681.806363872684, 9684.176844968257, 9706.077922597342, 9716.75708107303, 9521.857172142423, 9583.089606487372, 9614.0, 9621.615135394646, 9637.566309515949, 6960.303969602999, 7024.121984751804, 7034.437245020386, 7050.753223637251, 7057.50597458173, 5122.871928201825, 5220.295260139985, 5265.341832270966, 5277.868053298698, 5367.490088441592, 8521.147885211429, 8561.44350617208, 8628.482291062557, 8686.218240358145, 8701.303895688456, 8583.828323433372, 8633.266172375419, 8861.291096712119, 8873.068327825744, 8929.241014513838, 6161.507079433724, 6397.808065758035, 6399.0401439782545, 6857.759978400732, 6975.267596902455, 6796.694148763218, 7176.820579485346, 7261.128664560287, 7360.116785985716, 7378.778636640909, 6536.379043990813, 6642.867142657216, 6744.190697116377, 6746.156730408699, 6851.177858656993, 6668.699908504032, 6696.966515167588, 6704.6982885769285, 6718.126643536309, 6939.063226464565, 6387.744490220339, 6496.545241833026, 6544.116544266653, 6558.04908288286, 6560.245571759308, 4603.240465323318, 4701.412323459567, 4704.717716936994, 4790.592799611933, 4799.064182484382, 4616.469106052847, 4624.953750462452, 4686.343911852276, 4702.11140678907, 4808.230683090689], "value": 4083.8947479710346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.79310861722644, 312.66076307206686, 315.3849992514597, 317.21489313947984, 319.56539106814745, 5121.692698438092, 5151.356080489939, 5172.741362931857, 5179.792808287669, 5195.428502864686, 5065.822696205633, 5083.771230294637, 5088.618353623475, 5093.923591146136, 5099.337086178792, 3781.508403907495, 3848.8460461581503, 3902.200048989964, 3955.09032922428, 3970.3721474195586, 3990.700697447703, 3993.960060399402, 3996.940045899299, 4012.8394864205397, 4030.879073627796, 3785.65929066384, 3945.9605403946025, 3977.4232736253225, 3979.6418322350983, 4003.719739618228, 3837.2901013312485, 3945.349017412138, 3981.3231750602467, 3991.261616600938, 4010.939835902464, 3543.7519373643854, 3547.379208638478, 3548.7515873888838, 3559.110222444389, 3564.803935783531, 4845.830395936126, 4860.0, 4864.537868902484, 4883.926741098886, 4893.290472881448, 4378.255696531597, 4615.976920115378, 4621.861344159681, 4626.398568186114, 4640.953590464086, 5363.892722145535, 5364.6512976656395, 5369.731513424353, 5378.784848606051, 5379.542738867201, 3890.533136023695, 3893.377059670439, 3896.2207558488417, 3904.2581909437117, 3920.313945059603, 5550.72246387679, 5609.80365687199, 5629.155626655994, 5634.859128521779, 5650.547956163538, 3945.546262179829, 3982.084120652208, 3983.6414722674517, 3984.2828290907914, 3995.2808494471274, 4000.699947503949, 4009.4587230724064, 4010.438538604598, 4011.0, 4011.9799401002806, 4393.0994146199955, 4556.749378784199, 4557.384753058361, 4560.0, 4567.406237189144, 5325.334333208349, 5349.759260833272, 5355.98236335095, 5356.3572371315695, 5369.19462080691, 1397.2385050147693, 1421.9289035548181, 1422.2177802208744, 1425.600831767107, 1427.8429372768987, 902.9774255643662, 958.4632605740808, 977.9902200978041, 979.7746518300688, 983.188869182927, 4623.930641040387, 4624.375709279204, 4651.558101980307, 4655.138799322136, 4655.580997710154, 5464.890702185934, 5469.031148786434, 5476.123820188751, 5479.232907392969, 5492.945070549244, 4526.388937493396, 4630.560096790799, 4650.255959046536, 4662.7668616569035, 4672.859814205512, 2908.69458706837, 2915.2420370703344, 2923.137674386061, 2926.6976195593184, 2942.823430594171, 5174.24973378858, 5180.0, 5183.3261675981885, 5189.870253243699, 5195.948040519622, 5456.836294911159, 5629.706621626395, 5751.217122691979, 5752.741126649311, 5776.104703770839, 5269.682579355162, 5281.498257665516, 5287.074761916572, 5296.152615581488, 5306.8407947761625, 5293.523582877559, 5589.916151257653, 5608.495235428831, 5610.354809196831, 5632.408597097246, 5422.728863556886, 5456.61803673739, 5456.672599644034, 5478.123500239943, 5483.067878460592, 5224.0, 5227.294315267391, 5229.111051121395, 5242.895142097213, 5257.395399529103, 3818.4081467372603, 3878.96121038786, 3888.727789054739, 3902.375619900802, 3905.7851818150275, 5550.139728342114, 5550.944490555043, 5557.110862262019, 5557.388687244481, 5564.749586268708, 5340.786368545215, 5369.785208591768, 5375.6774593524515, 5390.407055224001, 5422.295101636762, 5214.270002199771, 5348.224507446321, 5348.732563371894, 5388.622796404214, 5395.109806881821, 5024.57291130258, 5241.6068794839775, 5284.497972692588, 5285.735713214401, 5314.4951229633125, 5140.845774626767, 5411.404745478073, 5445.591580631548, 5450.91823622638, 5451.918221226605, 5309.681419114865, 5314.97342513285, 5333.546648534762, 5335.813246536352, 5337.866553336197], "value": 4055.704419004656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1069743287574, 680.2177495879739, 712.2521352579791, 756.5120497279258, 767.6353731977312, 11795.528178872846, 12105.818412723795, 12121.636350909486, 12132.393380330992, 12149.939250303747, 11349.773004539904, 11399.37303448312, 11409.48657310421, 11419.086473082154, 11419.885801141985, 634.3244444666416, 770.5453782268461, 790.8022994251437, 796.8964034675485, 798.3732769775727, 782.4835608498393, 786.5162924801234, 790.075611534506, 792.2354927494966, 796.8127490039836, 837.815680550278, 839.9496030238174, 840.0507426607925, 840.6385254340662, 841.1252297610478, 659.9010148477719, 802.9518228906285, 820.2658620534647, 820.9220124088203, 821.2936874288107, 609.1380696314753, 609.3327806052365, 609.3906093906094, 609.5885277437711, 609.6250805754429, 10991.945040274748, 11073.114150867992, 11081.168912331526, 11084.722881927935, 11086.778264434746, 11690.766184676258, 12413.44139513724, 12648.810267845989, 12670.873291267062, 12695.682607934783, 10703.304285221435, 11065.225434219608, 11104.938394079438, 11214.0, 11223.831642525369, 3255.365203785263, 3326.501024846268, 3350.463925771865, 3413.897583072487, 3421.9657803421896, 47489.76255118737, 47736.28395574069, 47970.5202947973, 48021.279680804815, 48223.75888120537, 9475.620975160917, 9791.0, 9988.750281242881, 10184.949075254577, 10399.32404393712, 17432.302707891795, 17455.563610909576, 17478.91260543689, 17487.82512174862, 17490.737638935425, 6333.65164915934, 6449.129367535323, 6490.350964903472, 6532.314107018695, 6780.254172041072, 3573.3032058748295, 3602.819859007039, 3653.415453527423, 3686.4101743720876, 3914.2171565686976, 2856.3430411005584, 2950.0264912578796, 2951.0851635992913, 2951.1736713720193, 2953.9113826585235, 488.4822088586039, 495.6381841255903, 502.4322515557397, 514.3930162408394, 551.1952549278019, 539.3016044222741, 548.8216329692866, 582.1384351160307, 585.2450339062647, 597.2593983460478, 7735.970565770282, 7804.804879878048, 7895.289423951872, 7911.169327220674, 8352.081271060179, 595.5116804220584, 603.6740160313469, 610.3042531514078, 611.3031144495279, 612.7487730030666, 3893.3381325174787, 3971.1065010372436, 3987.6610488108836, 3991.44119823225, 4016.493661424508, 56419.43580564142, 57176.42823571794, 58197.70901145467, 58253.0, 58417.41582584205, 47781.522184778405, 47992.760036199594, 49538.50461495411, 49571.75214123906, 50572.74713626482, 43483.78258108689, 44893.73509516591, 45507.0, 45806.04521412262, 46438.30342544865, 7480.177180510248, 7504.699812007459, 7575.545467271982, 7652.387808975157, 7809.180036096355, 27117.322066948484, 29552.261193470335, 29782.553261700657, 30664.84667576648, 30807.075787726404, 35257.64742352646, 35891.282174356886, 35969.0, 36373.636263637025, 37543.81228093842, 9594.472304023067, 10445.164386848883, 10699.94650026745, 10793.892061079288, 10950.671479855617, 11597.18819682614, 11699.2980421175, 11779.116566257737, 11906.285622862655, 12360.0, 10836.349819010884, 10921.907809219014, 11137.10903127764, 11148.275362101438, 11602.883971160518, 10672.199585030998, 11029.393383363671, 11090.889091109308, 11114.555417783522, 11286.322820630789, 10608.628697995533, 10952.178586606196, 11098.61154859576, 11110.222284440011, 11197.44012799373, 9133.77165570866, 9405.905940940504, 9413.576389062371, 9468.857967130361, 9758.46328451942, 8585.18440748128, 8838.425502342327, 8870.600822963112, 8874.467531948103, 9353.345265831327], "value": 5908.1040514851375, "unit": "score"}], "name": "dromaeo_css", "value": 6335.7118347876485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 108.0, 114.0, 113.0, 113.0, 102.0, 112.0, 114.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 135.0, 155.0, 189.0, 134.0, 154.0, 161.0, 134.0, 183.0, 138.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 103.0, 103.0, 75.0, 74.0, 73.0, 117.0, 112.0, 73.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 150.0, 93.0, 92.0, 93.0, 146.0, 93.0, 93.0, 145.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 96.0, 96.0, 95.0, 94.0, 95.0, 94.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 80.0, 62.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 87.0, 79.0, 80.0, 79.0, 79.0, 81.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 134.0, 132.0, 130.0, 140.0, 134.0, 131.0, 171.0, 136.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 173.0, 175.0, 179.0, 176.0, 173.0, 171.0, 177.0, 173.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 71.0, 77.0, 72.0, 73.0, 71.0, 70.0, 71.0, 71.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1580.3, "alertThreshold": 2.0}]} 04:12:59 INFO - Return code: 0 04:12:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:12:59 ERROR - # TBPL SUCCESS # 04:12:59 INFO - Running post-action listener: _resource_record_post_action 04:12:59 INFO - Running post-run listener: _resource_record_post_run 04:13:00 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517263360; Read time: 20; Write time: 402472 04:13:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233984000; Read time: 0; Write time: 213992 04:13:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283279360; Read time: 20; Write time: 188480 04:13:00 INFO - Running post-run listener: _upload_blobber_files 04:13:00 INFO - Blob upload gear active. 04:13:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:00 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 04:13:00 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'] 04:13:00 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 04:13:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:02 INFO - (blobuploader) - INFO - Done attempting. 04:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:03 INFO - (blobuploader) - INFO - Done attempting. 04:13:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:03 INFO - Return code: 0 04:13:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dac5822d3f3cf188ad402ff91ca77ba850359feee39ac995e7dc07d9b160891388161581d001bea1ede0c63ac2841b6bec8581b34a42035eefcbbfcb6fad60c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6c948108159a2defc2f243edd0057cb485952f0979cc4878cdb19abe4a0d559ff1b37238d6fc11afcea37e0dd307c6182d040dc5b94d794b984ee7b2e3617c"} 04:13:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:03 INFO - Contents: 04:13:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dac5822d3f3cf188ad402ff91ca77ba850359feee39ac995e7dc07d9b160891388161581d001bea1ede0c63ac2841b6bec8581b34a42035eefcbbfcb6fad60c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6c948108159a2defc2f243edd0057cb485952f0979cc4878cdb19abe4a0d559ff1b37238d6fc11afcea37e0dd307c6182d040dc5b94d794b984ee7b2e3617c"} 04:13:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:03 INFO - Copying logs to upload dir... 04:13:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.350135 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-19 04:13:02.946392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:13:02.949811) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104 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/2dac5822d3f3cf188ad402ff91ca77ba850359feee39ac995e7dc07d9b160891388161581d001bea1ede0c63ac2841b6bec8581b34a42035eefcbbfcb6fad60c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6c948108159a2defc2f243edd0057cb485952f0979cc4878cdb19abe4a0d559ff1b37238d6fc11afcea37e0dd307c6182d040dc5b94d794b984ee7b2e3617c"} build_url:https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/JZkqi35qQUSsOzzPI63a4g/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/2dac5822d3f3cf188ad402ff91ca77ba850359feee39ac995e7dc07d9b160891388161581d001bea1ede0c63ac2841b6bec8581b34a42035eefcbbfcb6fad60c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6c948108159a2defc2f243edd0057cb485952f0979cc4878cdb19abe4a0d559ff1b37238d6fc11afcea37e0dd307c6182d040dc5b94d794b984ee7b2e3617c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:13:02.979388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:13:02.979719) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1461063045.917417-169194104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:13:03.064540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:13:03.064898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:13:03.065272) ========= ========= Total master_lag: 0.20 =========