builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1461106273.3 results: success (0) buildid: 20160419144541 builduid: 2a26a10cba314fcdb1d8fafee751e806 revision: 00bb04b8c9a0495fe026f609b18e09835e49c927 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.296470) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.296940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.297230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.332392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.332668) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 15:51:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-19 15:51:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.436922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.437234) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022542 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.486452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:13.486762) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 00bb04b8c9a0495fe026f609b18e09835e49c927 --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 00bb04b8c9a0495fe026f609b18e09835e49c927 --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=9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 15:51:13,839 truncating revision to first 12 chars 2016-04-19 15:51:13,839 Setting DEBUG logging. 2016-04-19 15:51:13,839 attempt 1/10 2016-04-19 15:51:13,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/00bb04b8c9a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 15:51:14,076 unpacking tar archive at: fx-team-00bb04b8c9a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.507510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:14.009593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:14.010123) ========= script_repo_revision: 00bb04b8c9a0495fe026f609b18e09835e49c927 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:14.010763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:14.011252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 15:51:14.022500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-19 15:51:14.022975) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:14 INFO - MultiFileLogger online at 20160419 15:51:14 in /builds/slave/test 15:51:14 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 15:51:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:14 INFO - {'append_to_log': False, 15:51:14 INFO - 'base_work_dir': '/builds/slave/test', 15:51:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:51:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:14 INFO - 'branch': 'Fx-Team-Non-PGO', 15:51:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:14 INFO - 'config_files': ('talos/linux_config.py',), 15:51:14 INFO - 'default_actions': ('clobber', 15:51:14 INFO - 'read-buildbot-config', 15:51:14 INFO - 'download-and-extract', 15:51:14 INFO - 'populate-webroot', 15:51:14 INFO - 'create-virtualenv', 15:51:14 INFO - 'install', 15:51:14 INFO - 'run-tests'), 15:51:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:14 INFO - 'download_minidump_stackwalk': True, 15:51:14 INFO - 'download_symbols': 'ondemand', 15:51:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:14 INFO - 'installer_path': 'installer.exe', 15:51:14 INFO - 'log_level': 'info', 15:51:14 INFO - 'log_name': 'talos', 15:51:14 INFO - 'log_to_console': True, 15:51:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:14 INFO - 'opt_config_files': (), 15:51:14 INFO - 'pip_index': False, 15:51:14 INFO - 'sps_profile': False, 15:51:14 INFO - 'sps_profile_interval': 0, 15:51:14 INFO - 'suite': 'dromaeojs', 15:51:14 INFO - 'system_bits': '32', 15:51:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:14 INFO - 'title': 'talos-linux64-ix-013', 15:51:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:14 INFO - 'use_talos_json': True, 15:51:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:14 INFO - 'work_dir': 'build'} 15:51:14 INFO - ##### 15:51:14 INFO - ##### Running clobber step. 15:51:14 INFO - ##### 15:51:14 INFO - Running pre-action listener: _resource_record_pre_action 15:51:14 INFO - Running main action method: clobber 15:51:14 INFO - rmtree: /builds/slave/test/build 15:51:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:15 INFO - Running post-action listener: _resource_record_post_action 15:51:15 INFO - ##### 15:51:15 INFO - ##### Running read-buildbot-config step. 15:51:15 INFO - ##### 15:51:15 INFO - Running pre-action listener: _resource_record_pre_action 15:51:15 INFO - Running main action method: read_buildbot_config 15:51:15 INFO - Using buildbot properties: 15:51:15 INFO - { 15:51:15 INFO - "project": "", 15:51:15 INFO - "product": "firefox", 15:51:15 INFO - "script_repo_revision": "production", 15:51:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:51:15 INFO - "repository": "", 15:51:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:51:15 INFO - "buildid": "20160419144541", 15:51:15 INFO - "pgo_build": "False", 15:51:15 INFO - "basedir": "/builds/slave/test", 15:51:15 INFO - "buildnumber": 1673, 15:51:15 INFO - "slavename": "talos-linux64-ix-013", 15:51:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:51:15 INFO - "platform": "ubuntu64_hw", 15:51:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:51:15 INFO - "branch": "fx-team", 15:51:15 INFO - "repo_path": "integration/fx-team", 15:51:15 INFO - "revision": "00bb04b8c9a0495fe026f609b18e09835e49c927", 15:51:15 INFO - "stage_platform": "linux64", 15:51:15 INFO - "builduid": "2a26a10cba314fcdb1d8fafee751e806", 15:51:15 INFO - "slavebuilddir": "test" 15:51:15 INFO - } 15:51:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:51:15 INFO - Running post-action listener: _resource_record_post_action 15:51:15 INFO - ##### 15:51:15 INFO - ##### Running download-and-extract step. 15:51:15 INFO - ##### 15:51:15 INFO - Running pre-action listener: _resource_record_pre_action 15:51:15 INFO - Running main action method: download_and_extract 15:51:15 INFO - mkdir: /builds/slave/test/build/tests 15:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:15 INFO - https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:51:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:51:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:51:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:17 INFO - Downloaded 1361 bytes. 15:51:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:51:17 INFO - Using the following test package requirements: 15:51:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:51:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'jsshell-linux-x86_64.zip'], 15:51:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:51:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:51:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:17 INFO - https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:19 INFO - Downloaded 22267191 bytes. 15:51:19 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'] 15:51:19 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 15:51:20 INFO - Return code: 0 15:51:20 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 15:51:20 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')]} 15:51:20 INFO - https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:36 INFO - Downloaded 22267191 bytes. 15:51:36 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'] 15:51:36 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 15:51:38 INFO - Return code: 0 15:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:38 INFO - https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:39 INFO - Downloaded 10845952 bytes. 15:51:39 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'] 15:51:39 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 15:51:39 INFO - Return code: 0 15:51: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')]} 15:51:39 INFO - https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LYnrts4SRK2PpxxFhS-iqg/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 15:51:41 INFO - Downloaded 54518588 bytes. 15:51:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:41 INFO - mkdir: /builds/slave/test/properties 15:51:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:41 INFO - Contents: 15:51:41 INFO - build_url:https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:42 INFO - Running post-action listener: _resource_record_post_action 15:51:42 INFO - Running post-action listener: set_extra_try_arguments 15:51:42 INFO - ##### 15:51:42 INFO - ##### Running populate-webroot step. 15:51:42 INFO - ##### 15:51:42 INFO - Running pre-action listener: _resource_record_pre_action 15:51:42 INFO - Running main action method: populate_webroot 15:51:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:42 INFO - '--tppagecycles', 15:51:42 INFO - '7'], 15:51:42 INFO - 'tests': ['tsvgm']}}, 15:51:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['damp', 'tps']}, 15:51:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'tests': ['damp', 'tps']}, 15:51:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['dromaeo_dom']}, 15:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['a11yr', 15:51:42 INFO - 'ts_paint', 15:51:42 INFO - 'tpaint', 15:51:42 INFO - 'sessionrestore', 15:51:42 INFO - 'sessionrestore_no_auto_restore', 15:51:42 INFO - 'tabpaint']}, 15:51:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:42 INFO - 'ts_paint', 15:51:42 INFO - 'tpaint', 15:51:42 INFO - 'sessionrestore', 15:51:42 INFO - 'sessionrestore_no_auto_restore', 15:51:42 INFO - 'tabpaint']}, 15:51:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:42 INFO - 'ts_paint', 15:51:42 INFO - 'tpaint', 15:51:42 INFO - 'sessionrestore', 15:51:42 INFO - 'sessionrestore_no_auto_restore', 15:51:42 INFO - 'tabpaint']}, 15:51:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:42 INFO - 'ts_paint', 15:51:42 INFO - 'tpaint', 15:51:42 INFO - 'sessionrestore', 15:51:42 INFO - 'sessionrestore_no_auto_restore', 15:51:42 INFO - 'tabpaint']}, 15:51:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['a11yr', 15:51:42 INFO - 'ts_paint', 15:51:42 INFO - 'tpaint', 15:51:42 INFO - 'sessionrestore', 15:51:42 INFO - 'sessionrestore_no_auto_restore', 15:51:42 INFO - 'tabpaint']}, 15:51:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['a11yr', 15:51:42 INFO - 'ts_paint', 15:51:42 INFO - 'tpaint', 15:51:42 INFO - 'sessionrestore', 15:51:42 INFO - 'sessionrestore_no_auto_restore', 15:51:42 INFO - 'tabpaint']}, 15:51:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['tsvgx', 15:51:42 INFO - 'tsvgr_opacity', 15:51:42 INFO - 'tart', 15:51:42 INFO - 'tscrollx', 15:51:42 INFO - 'cart']}, 15:51:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:42 INFO - 'tsvgr_opacity', 15:51:42 INFO - 'tart', 15:51:42 INFO - 'tscrollx', 15:51:42 INFO - 'cart']}, 15:51:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'talos_options': ['--disable-e10s'], 15:51:42 INFO - 'tests': ['tp5o']}, 15:51:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'tests': ['tp5o']}, 15:51:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'talos_options': ['--disable-e10s', 15:51:42 INFO - '--xperf_path', 15:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:42 INFO - 'tests': ['tp5n']}, 15:51:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:42 INFO - 'talos_options': ['--xperf_path', 15:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:42 INFO - 'tests': ['tp5n']}}, 15:51:42 INFO - 'talos.zip': {'path': '', 15:51:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:42 INFO - Running post-action listener: _resource_record_post_action 15:51:42 INFO - ##### 15:51:42 INFO - ##### Running create-virtualenv step. 15:51:42 INFO - ##### 15:51:42 INFO - Running pre-action listener: _resource_record_pre_action 15:51:42 INFO - Running main action method: create_virtualenv 15:51:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:42 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 15:51:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:42 INFO - Using real prefix '/usr' 15:51:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:44 INFO - Installing pip.................done. 15:51:44 INFO - Return code: 0 15:51:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:51: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', 'pip>=1.5'] in /builds/slave/test/build 15:51: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 pip>=1.5 15:51:44 INFO - Using env: {'DISPLAY': ':0', 15:51:44 INFO - 'HOME': '/home/cltbld', 15:51:44 INFO - 'LANG': 'en_US.UTF-8', 15:51:44 INFO - 'LANGUAGE': 'en_US:en', 15:51:44 INFO - 'LOGNAME': 'cltbld', 15:51:44 INFO - 'MAIL': '/var/mail/cltbld', 15:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:45 INFO - 'MOZ_NO_REMOTE': '1', 15:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:45 INFO - 'NO_EM_RESTART': '1', 15:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:45 INFO - 'PWD': '/builds/slave/test', 15:51:45 INFO - 'SHELL': '/bin/bash', 15:51:45 INFO - 'SHLVL': '1', 15:51:45 INFO - 'TERM': 'linux', 15:51:45 INFO - 'TMOUT': '86400', 15:51:45 INFO - 'USER': 'cltbld', 15:51:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:45 INFO - '_': '/tools/buildbot/bin/python'} 15:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:45 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 15:51:45 INFO - Cleaning up... 15:51:45 INFO - Return code: 0 15:51:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:45 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')]} 15:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:45 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')]} 15:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:45 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:51:45 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 15:51:45 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 15:51:45 INFO - Using env: {'DISPLAY': ':0', 15:51:45 INFO - 'HOME': '/home/cltbld', 15:51:45 INFO - 'LANG': 'en_US.UTF-8', 15:51:45 INFO - 'LANGUAGE': 'en_US:en', 15:51:45 INFO - 'LOGNAME': 'cltbld', 15:51:45 INFO - 'MAIL': '/var/mail/cltbld', 15:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:45 INFO - 'MOZ_NO_REMOTE': '1', 15:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:45 INFO - 'NO_EM_RESTART': '1', 15:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:45 INFO - 'PWD': '/builds/slave/test', 15:51:45 INFO - 'SHELL': '/bin/bash', 15:51:45 INFO - 'SHLVL': '1', 15:51:45 INFO - 'TERM': 'linux', 15:51:45 INFO - 'TMOUT': '86400', 15:51:45 INFO - 'USER': 'cltbld', 15:51:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:45 INFO - '_': '/tools/buildbot/bin/python'} 15:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:45 INFO - Downloading/unpacking psutil>=0.7.1 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:47 INFO - Installing collected packages: psutil 15:51:47 INFO - Running setup.py install for psutil 15:51:47 INFO - building 'psutil._psutil_linux' extension 15:51:47 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 15:51:47 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 15:51:47 INFO - building 'psutil._psutil_posix' extension 15:51:47 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 15:51:47 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 15:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:47 INFO - Successfully installed psutil 15:51:47 INFO - Cleaning up... 15:51:47 INFO - Return code: 0 15:51:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:51:47 INFO - Using env: {'DISPLAY': ':0', 15:51:47 INFO - 'HOME': '/home/cltbld', 15:51:47 INFO - 'LANG': 'en_US.UTF-8', 15:51:47 INFO - 'LANGUAGE': 'en_US:en', 15:51:47 INFO - 'LOGNAME': 'cltbld', 15:51:47 INFO - 'MAIL': '/var/mail/cltbld', 15:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:47 INFO - 'MOZ_NO_REMOTE': '1', 15:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:47 INFO - 'NO_EM_RESTART': '1', 15:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:47 INFO - 'PWD': '/builds/slave/test', 15:51:47 INFO - 'SHELL': '/bin/bash', 15:51:47 INFO - 'SHLVL': '1', 15:51:47 INFO - 'TERM': 'linux', 15:51:47 INFO - 'TMOUT': '86400', 15:51:47 INFO - 'USER': 'cltbld', 15:51:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:47 INFO - '_': '/tools/buildbot/bin/python'} 15:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:50 INFO - Installing collected packages: mozsystemmonitor 15:51:50 INFO - Running setup.py install for mozsystemmonitor 15:51:50 INFO - Successfully installed mozsystemmonitor 15:51:50 INFO - Cleaning up... 15:51:50 INFO - Return code: 0 15:51:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:50 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')]} 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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')]} 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:51:50 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 15:51:50 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 15:51:50 INFO - Using env: {'DISPLAY': ':0', 15:51:50 INFO - 'HOME': '/home/cltbld', 15:51:50 INFO - 'LANG': 'en_US.UTF-8', 15:51:50 INFO - 'LANGUAGE': 'en_US:en', 15:51:50 INFO - 'LOGNAME': 'cltbld', 15:51:50 INFO - 'MAIL': '/var/mail/cltbld', 15:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:50 INFO - 'MOZ_NO_REMOTE': '1', 15:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:50 INFO - 'NO_EM_RESTART': '1', 15:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:50 INFO - 'PWD': '/builds/slave/test', 15:51:50 INFO - 'SHELL': '/bin/bash', 15:51:50 INFO - 'SHLVL': '1', 15:51:50 INFO - 'TERM': 'linux', 15:51:50 INFO - 'TMOUT': '86400', 15:51:50 INFO - 'USER': 'cltbld', 15:51:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:50 INFO - '_': '/tools/buildbot/bin/python'} 15:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:52 INFO - Downloading docopt-0.6.1.tar.gz 15:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:53 INFO - Running setup.py install for blobuploader 15:51:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:53 INFO - Running setup.py install for requests 15:51:53 INFO - Running setup.py install for docopt 15:51:53 INFO - Successfully installed blobuploader requests docopt 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:51:53 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 15:51:53 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 15:51:53 INFO - Using env: {'DISPLAY': ':0', 15:51:53 INFO - 'HOME': '/home/cltbld', 15:51:53 INFO - 'LANG': 'en_US.UTF-8', 15:51:53 INFO - 'LANGUAGE': 'en_US:en', 15:51:53 INFO - 'LOGNAME': 'cltbld', 15:51:53 INFO - 'MAIL': '/var/mail/cltbld', 15:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:53 INFO - 'MOZ_NO_REMOTE': '1', 15:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:53 INFO - 'NO_EM_RESTART': '1', 15:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:53 INFO - 'PWD': '/builds/slave/test', 15:51:53 INFO - 'SHELL': '/bin/bash', 15:51:53 INFO - 'SHLVL': '1', 15:51:53 INFO - 'TERM': 'linux', 15:51:53 INFO - 'TMOUT': '86400', 15:51:53 INFO - 'USER': 'cltbld', 15:51:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:53 INFO - '_': '/tools/buildbot/bin/python'} 15:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:53 INFO - Running setup.py (path:/tmp/pip-foRDAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:53 INFO - Running setup.py (path:/tmp/pip-_yHuJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:53 INFO - Running setup.py (path:/tmp/pip-FUJ14B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:54 INFO - Running setup.py (path:/tmp/pip-byha0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:54 INFO - Running setup.py (path:/tmp/pip-C_MDkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:54 INFO - Running setup.py (path:/tmp/pip-MQZbZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:54 INFO - Running setup.py (path:/tmp/pip-6Embrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:54 INFO - Running setup.py (path:/tmp/pip-KUDQLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:54 INFO - Running setup.py (path:/tmp/pip-VPi_JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:54 INFO - Running setup.py (path:/tmp/pip-e9KCJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:54 INFO - Running setup.py (path:/tmp/pip-hJnuQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:54 INFO - Running setup.py (path:/tmp/pip-VcxVma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:54 INFO - Running setup.py (path:/tmp/pip-8XGYNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:54 INFO - Running setup.py (path:/tmp/pip-2rAm7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:54 INFO - Running setup.py (path:/tmp/pip-dUqduP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:54 INFO - Running setup.py (path:/tmp/pip-RZUBrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:54 INFO - Running setup.py (path:/tmp/pip-gPAqnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:55 INFO - Running setup.py install for manifestparser 15:51:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Running setup.py install for mozcrash 15:51:55 INFO - Running setup.py install for mozdebug 15:51:55 INFO - Running setup.py install for mozdevice 15:51:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Running setup.py install for mozfile 15:51:55 INFO - Running setup.py install for mozhttpd 15:51:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Running setup.py install for mozinfo 15:51:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Running setup.py install for mozInstall 15:51:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Running setup.py install for mozleak 15:51:55 INFO - Running setup.py install for mozlog 15:51:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Running setup.py install for moznetwork 15:51:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Running setup.py install for mozprocess 15:51:56 INFO - Running setup.py install for mozprofile 15:51:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Running setup.py install for mozrunner 15:51:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Running setup.py install for mozscreenshot 15:51:56 INFO - Running setup.py install for moztest 15:51:56 INFO - Running setup.py install for mozversion 15:51:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:56 INFO - Cleaning up... 15:51:56 INFO - Return code: 0 15:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:56 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')]} 15:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:56 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')]} 15:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:56 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:51:56 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 15:51:56 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 15:51:56 INFO - Using env: {'DISPLAY': ':0', 15:51:56 INFO - 'HOME': '/home/cltbld', 15:51:56 INFO - 'LANG': 'en_US.UTF-8', 15:51:56 INFO - 'LANGUAGE': 'en_US:en', 15:51:56 INFO - 'LOGNAME': 'cltbld', 15:51:56 INFO - 'MAIL': '/var/mail/cltbld', 15:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:56 INFO - 'MOZ_NO_REMOTE': '1', 15:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:56 INFO - 'NO_EM_RESTART': '1', 15:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:56 INFO - 'PWD': '/builds/slave/test', 15:51:56 INFO - 'SHELL': '/bin/bash', 15:51:56 INFO - 'SHLVL': '1', 15:51:56 INFO - 'TERM': 'linux', 15:51:56 INFO - 'TMOUT': '86400', 15:51:56 INFO - 'USER': 'cltbld', 15:51:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:56 INFO - '_': '/tools/buildbot/bin/python'} 15:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:57 INFO - Running setup.py (path:/tmp/pip-9QGYsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:57 INFO - Running setup.py (path:/tmp/pip-v3FwMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:57 INFO - Running setup.py (path:/tmp/pip-njNYOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:57 INFO - Running setup.py (path:/tmp/pip-qY236A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:57 INFO - Running setup.py (path:/tmp/pip-JzYIrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:57 INFO - Running setup.py (path:/tmp/pip-y7qAx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:57 INFO - Running setup.py (path:/tmp/pip-58ucvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:57 INFO - Running setup.py (path:/tmp/pip-TeD4bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:57 INFO - Running setup.py (path:/tmp/pip-Wnwjom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:57 INFO - Running setup.py (path:/tmp/pip-vWKNIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:57 INFO - Running setup.py (path:/tmp/pip-9qBwYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:57 INFO - Running setup.py (path:/tmp/pip-hZWfIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:57 INFO - Running setup.py (path:/tmp/pip-J4jOha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:57 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)) 15:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:57 INFO - Running setup.py (path:/tmp/pip-dKI3U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:58 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)) 15:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:58 INFO - Running setup.py (path:/tmp/pip-lsy4Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:58 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)) 15:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:58 INFO - Running setup.py (path:/tmp/pip-dDfXGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:58 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)) 15:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:58 INFO - Running setup.py (path:/tmp/pip-bCuFjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:58 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)) 15:51:58 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)) 15:51:58 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)) 15:51:58 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)) 15:51:58 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)) 15:51:58 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)) 15:51:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:58 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 15:51:58 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 15:51:58 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 15:51:58 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 15:51:58 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 15:51:58 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 15:52:00 INFO - Downloading blessings-1.6.tar.gz 15:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:00 INFO - Installing collected packages: blessings 15:52:00 INFO - Running setup.py install for blessings 15:52:00 INFO - Successfully installed blessings 15:52:00 INFO - Cleaning up... 15:52:00 INFO - Return code: 0 15:52:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:00 INFO - Reading from file tmpfile_stdout 15:52:00 INFO - Current package versions: 15:52:00 INFO - argparse == 1.2.1 15:52:00 INFO - blessings == 1.6 15:52:00 INFO - blobuploader == 1.2.4 15:52:00 INFO - docopt == 0.6.1 15:52:00 INFO - manifestparser == 1.1 15:52:00 INFO - mozInstall == 1.12 15:52:00 INFO - mozcrash == 0.17 15:52:00 INFO - mozdebug == 0.1 15:52:00 INFO - mozdevice == 0.48 15:52:00 INFO - mozfile == 1.2 15:52:00 INFO - mozhttpd == 0.7 15:52:00 INFO - mozinfo == 0.9 15:52:00 INFO - mozleak == 0.1 15:52:00 INFO - mozlog == 3.1 15:52:00 INFO - moznetwork == 0.27 15:52:00 INFO - mozprocess == 0.22 15:52:00 INFO - mozprofile == 0.28 15:52:00 INFO - mozrunner == 6.11 15:52:00 INFO - mozscreenshot == 0.1 15:52:00 INFO - mozsystemmonitor == 0.0 15:52:00 INFO - moztest == 0.7 15:52:00 INFO - mozversion == 1.4 15:52:00 INFO - psutil == 3.1.1 15:52:00 INFO - requests == 1.2.3 15:52:00 INFO - wsgiref == 0.1.2 15:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:00 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')]} 15:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:00 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')]} 15:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:00 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:52:00 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 15:52:00 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 15:52:00 INFO - Using env: {'DISPLAY': ':0', 15:52:00 INFO - 'HOME': '/home/cltbld', 15:52:00 INFO - 'LANG': 'en_US.UTF-8', 15:52:00 INFO - 'LANGUAGE': 'en_US:en', 15:52:00 INFO - 'LOGNAME': 'cltbld', 15:52:00 INFO - 'MAIL': '/var/mail/cltbld', 15:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:00 INFO - 'MOZ_NO_REMOTE': '1', 15:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:00 INFO - 'NO_EM_RESTART': '1', 15:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:00 INFO - 'PWD': '/builds/slave/test', 15:52:00 INFO - 'SHELL': '/bin/bash', 15:52:00 INFO - 'SHLVL': '1', 15:52:00 INFO - 'TERM': 'linux', 15:52:00 INFO - 'TMOUT': '86400', 15:52:00 INFO - 'USER': 'cltbld', 15:52:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:00 INFO - '_': '/tools/buildbot/bin/python'} 15:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 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)) 15:52:00 INFO - Cleaning up... 15:52:00 INFO - Return code: 0 15:52:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:00 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')]} 15:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:00 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')]} 15:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:00 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:52:00 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 15:52:00 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 15:52:00 INFO - Using env: {'DISPLAY': ':0', 15:52:00 INFO - 'HOME': '/home/cltbld', 15:52:00 INFO - 'LANG': 'en_US.UTF-8', 15:52:00 INFO - 'LANGUAGE': 'en_US:en', 15:52:00 INFO - 'LOGNAME': 'cltbld', 15:52:00 INFO - 'MAIL': '/var/mail/cltbld', 15:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:00 INFO - 'MOZ_NO_REMOTE': '1', 15:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:00 INFO - 'NO_EM_RESTART': '1', 15:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:00 INFO - 'PWD': '/builds/slave/test', 15:52:00 INFO - 'SHELL': '/bin/bash', 15:52:00 INFO - 'SHLVL': '1', 15:52:00 INFO - 'TERM': 'linux', 15:52:00 INFO - 'TMOUT': '86400', 15:52:00 INFO - 'USER': 'cltbld', 15:52:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:00 INFO - '_': '/tools/buildbot/bin/python'} 15:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:01 INFO - Downloading/unpacking jsonschema 15:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:02 INFO - Downloading/unpacking functools32 (from jsonschema) 15:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:03 INFO - warning: no files found matching '*.txt' 15:52:03 INFO - no previously-included directories found matching 'build' 15:52:03 INFO - no previously-included directories found matching 'dist' 15:52:03 INFO - no previously-included directories found matching '.git*' 15:52:03 INFO - Installing collected packages: jsonschema, functools32 15:52:03 INFO - Running setup.py install for functools32 15:52:03 INFO - warning: no files found matching '*.txt' 15:52:03 INFO - no previously-included directories found matching 'build' 15:52:03 INFO - no previously-included directories found matching 'dist' 15:52:03 INFO - no previously-included directories found matching '.git*' 15:52:03 INFO - Successfully installed jsonschema functools32 15:52:03 INFO - Cleaning up... 15:52:03 INFO - Return code: 0 15:52:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:52:03 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')]} 15:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:03 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')]} 15:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:03 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 0x7f916df5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', '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 15:52:03 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 15:52:03 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 15:52:03 INFO - Using env: {'DISPLAY': ':0', 15:52:03 INFO - 'HOME': '/home/cltbld', 15:52:03 INFO - 'LANG': 'en_US.UTF-8', 15:52:03 INFO - 'LANGUAGE': 'en_US:en', 15:52:03 INFO - 'LOGNAME': 'cltbld', 15:52:03 INFO - 'MAIL': '/var/mail/cltbld', 15:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:03 INFO - 'MOZ_NO_REMOTE': '1', 15:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:03 INFO - 'NO_EM_RESTART': '1', 15:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:03 INFO - 'PWD': '/builds/slave/test', 15:52:03 INFO - 'SHELL': '/bin/bash', 15:52:03 INFO - 'SHLVL': '1', 15:52:03 INFO - 'TERM': 'linux', 15:52:03 INFO - 'TMOUT': '86400', 15:52:03 INFO - 'USER': 'cltbld', 15:52:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:03 INFO - '_': '/tools/buildbot/bin/python'} 15:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:03 INFO - Downloading/unpacking flake8 15:52:03 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 15:52:03 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 15:52:03 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 15:52:03 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 15:52:03 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 15:52:03 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 15:52:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:52:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:52:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:06 INFO - no previously-included directories found matching 'docs/_build' 15:52:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:52:06 INFO - Running setup.py install for pep8 15:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:06 INFO - no previously-included directories found matching 'docs/_build' 15:52:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:52:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:52:06 INFO - Cleaning up... 15:52:06 INFO - Return code: 0 15:52:06 INFO - Running post-action listener: _resource_record_post_action 15:52:06 INFO - Running post-action listener: _start_resource_monitoring 15:52:06 INFO - Starting resource monitoring. 15:52:06 INFO - ##### 15:52:06 INFO - ##### Running install step. 15:52:06 INFO - ##### 15:52:06 INFO - Running pre-action listener: _resource_record_pre_action 15:52:06 INFO - Running main action method: install 15:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:06 INFO - Reading from file tmpfile_stdout 15:52:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:06 INFO - Reading from file tmpfile_stdout 15:52:06 INFO - Output received: 15:52:06 INFO - Usage: mozinstall [options] installer 15:52:06 INFO - Options: 15:52:06 INFO - -h, --help show this help message and exit 15:52:06 INFO - -d DEST, --destination=DEST 15:52:06 INFO - Directory to install application into. [default: 15:52:06 INFO - "/builds/slave/test"] 15:52:06 INFO - --app=APP Application being installed. [default: firefox] 15:52:06 INFO - mkdir: /builds/slave/test/build/application 15:52:06 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'] 15:52:06 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 15:52:22 INFO - Reading from file tmpfile_stdout 15:52:22 INFO - Output received: 15:52:22 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:22 INFO - Running post-action listener: _resource_record_post_action 15:52:22 INFO - ##### 15:52:22 INFO - ##### Running run-tests step. 15:52:22 INFO - ##### 15:52:22 INFO - Running pre-action listener: _resource_record_pre_action 15:52:22 INFO - Running main action method: run_tests 15:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:22 INFO - Python 2.7.3 15:52:22 INFO - Return code: 0 15:52:22 INFO - grabbing minidump binary from tooltool 15:52:22 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')]} 15:52:22 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 0xe5d410>, '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 0xe5e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:22 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 15:52:22 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 15:52:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:22 INFO - Return code: 0 15:52:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:52:23 INFO - Return code: 0 15:52:23 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/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 15:52:23 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/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 15:52:23 INFO - Using env: {'DISPLAY': ':0', 15:52:23 INFO - 'HOME': '/home/cltbld', 15:52:23 INFO - 'LANG': 'en_US.UTF-8', 15:52:23 INFO - 'LANGUAGE': 'en_US:en', 15:52:23 INFO - 'LOGNAME': 'cltbld', 15:52:23 INFO - 'MAIL': '/var/mail/cltbld', 15:52:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:23 INFO - 'MOZ_NO_REMOTE': '1', 15:52:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:23 INFO - 'NO_EM_RESTART': '1', 15:52:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:23 INFO - 'PWD': '/builds/slave/test', 15:52:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:23 INFO - 'SHELL': '/bin/bash', 15:52:23 INFO - 'SHLVL': '1', 15:52:23 INFO - 'TERM': 'linux', 15:52:23 INFO - 'TMOUT': '86400', 15:52:23 INFO - 'USER': 'cltbld', 15:52:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803', 15:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:23 INFO - '_': '/tools/buildbot/bin/python'} 15:52:23 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/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 15:52:23 INFO - mozversion application_buildid: 20160419144541 15:52:23 INFO - mozversion application_changeset: 00bb04b8c9a0495fe026f609b18e09835e49c927 15:52:23 INFO - mozversion application_display_name: Nightly 15:52:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:23 INFO - mozversion application_name: Firefox 15:52:23 INFO - mozversion application_remotingname: firefox 15:52:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:52:23 INFO - mozversion application_vendor: Mozilla 15:52:23 INFO - mozversion application_version: 48.0a1 15:52:23 INFO - mozversion platform_buildid: 20160419144541 15:52:23 INFO - mozversion platform_changeset: 00bb04b8c9a0495fe026f609b18e09835e49c927 15:52:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:52:23 INFO - mozversion platform_version: 48.0a1 15:52:23 INFO - using testdate: 1461106343 15:52:23 INFO - actual date: 1461106343 15:52:23 INFO - starting webserver on 'localhost:37210' 15:52:23 INFO - SUITE-START | Running 2 tests 15:52:23 INFO - TEST-START | dromaeo_css 15:52:23 INFO - operating with platform_type : linux_ 15:52:23 INFO - Initialising browser for dromaeo_css test... 15:52:23 INFO - TEST-INFO | started process 3562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20SCAt/profile http://localhost:37210/getInfo.html) 15:52:28 INFO - PROCESS | 3562 | __metrics Screen width/height:1600/1200 15:52:28 INFO - PROCESS | 3562 | colorDepth:24 15:52:28 INFO - PROCESS | 3562 | Browser inner width/height: 1024/697 15:52:28 INFO - PROCESS | 3562 | __metrics 15:52:29 ERROR - PROCESS | 3562 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:52:29 INFO - TEST-INFO | 3562: exit 0 15:52:29 INFO - Browser initialized. 15:52:29 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:29 INFO - TEST-INFO | started process 3641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20SCAt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:41 INFO - PROCESS | 3641 | RSS: Main: 154763264 15:52:41 INFO - PROCESS | 3641 | 15:53:33 INFO - PROCESS | 3641 | 1461106413485 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] 15:55:44 INFO - PROCESS | 3641 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37210/tests/dromaeo/cssquery-ext.html) 15:55:45 INFO - PROCESS | 3641 | RSS: Main: 236658688 15:55:45 INFO - PROCESS | 3641 | 15:58:48 INFO - PROCESS | 3641 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-ext.html (next: http://localhost:37210/tests/dromaeo/cssquery-jquery.html) 15:58:48 INFO - PROCESS | 3641 | RSS: Main: 242167808 15:58:48 INFO - PROCESS | 3641 | 16:01:51 INFO - PROCESS | 3641 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37210/tests/dromaeo/cssquery-mootools.html) 16:01:51 INFO - PROCESS | 3641 | RSS: Main: 244924416 16:01:51 INFO - PROCESS | 3641 | 16:04:53 INFO - PROCESS | 3641 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37210/tests/dromaeo/cssquery-prototype.html) 16:04:54 INFO - PROCESS | 3641 | RSS: Main: 245014528 16:04:54 INFO - PROCESS | 3641 | 16:07:57 INFO - PROCESS | 3641 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37210/tests/dromaeo/cssquery-yui.html) 16:07:57 INFO - PROCESS | 3641 | RSS: Main: 216104960 16:07:57 INFO - PROCESS | 3641 | 16:11:00 INFO - PROCESS | 3641 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-yui.html (next: http://localhost:37210/tests/dromaeo/cssquery-dojo.html) 16:11:01 INFO - PROCESS | 3641 | RSS: Main: 272089088 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | __start_tp_report 16:11:01 INFO - PROCESS | 3641 | _x_x_mozilla_page_load 16:11:01 INFO - PROCESS | 3641 | _x_x_mozilla_page_load_details 16:11:01 INFO - PROCESS | 3641 | |i|pagename|runs| 16:11:01 INFO - PROCESS | 3641 | |0;dojo.html;2625.855577943213;2672.158270144903;2685.932851678708;2716.1851444566623;2723.959140612891;4509.346144809009;4582.77086145693;4658.650601204906;4674.27548729947;4722.716637001778;4723.409573803275;4763.571278584926;4767.284907263912;4768.1894078006735;4785.976070119653;4241.342591898246;4294.248506511363;4331.0255192581735;4368.737875727451;4414.02891363901;4332.84835030774;4361.302191649337;4377.277749171383;4384.320430333303;4430.689851710382;4159.500859896802;4239.173361194568;4249.80875860587;4299;4330.133973205371;4291.184674911757;4319.956800431987;4320.546342634041;4364.454443194601;4382.364557139197;4237.322028475429;4277.251480990845;4290.01329694169;4306.849260275875;4335.328024156261;4491.550844915515;4559.635229181657;4560.8859778505475;4609.67732258742;4646.1404640141345;4943.629227807929;4948.505149485059;4959.90080198394;4961.70229786214;4985.601151907875;4955.851324460272;4980.377452818398;4981.775820088104;4995;5038.748062596856;4456.6880318377725;4631.722096674143;4633.374494443275;4703.929441058387;4710.646701497401;5147.356580427447;5171.637985341065;5178.689278643218;5181.274621552986;5190.6107041972;4957.3059771632;4964.205727083649;4967.205247160437;4971.1549036663855;4973.204287314013;4858.854234372904;5006.69959802413;5091.287219789232;5091.643584949018;5097.235414687826;4954.9009019819405;4955.430125535538;4956.256561515729;4969.3539839821315;4972.5276098770555;4896.338994235733;4935.777889994887;4935.988122434892;4936.506349365035;4967.975160124249;4167.395727619478;4252.723572967747;4254.489461264668;4254.744715317091;4284.76433796138;3708.5364329458816;3742.3263812513464;3750.474933509311;3751.681107105872;3751.756135851161;4287.056847493546;4289.0992891492515;4292.91414171721;4301.720388174758;4354.608085272341;5062.670926389773;5067.113255180328;5068.847934561969;5075.796968121308;5119.948800511947;4334.696571240046;4355.499117601453;4374.846880359172;4416.977915110404;4425.911481770347;4285.7642829644665;4342.348647702806;4399.296112621965;4442;4446.288593825037;4766.332713420194;4768.165571025057;4771.71369717818;4809.591184749335;4815.22956326986;5008.749562521933;5010.198368261061;5011.574016208663;5023.6985780853265;5059.114654935298;4697.577218050392;4728.810847566059;4764.952350476451;4793.688410253322;4804.0872234275375;4874.731889746098;4889.926651100308;4894.95105048945;4895.04546613407;4941.234108713155;5019.146745053423;5027.572656324253;5028.170351892043;5029.5221953914315;5080.339555857715;4693.483716791082;4788.736619485822;4824.131656301899;4850.05423942342;4872.220444728827;4825.469198388104;4837.395325584302;4848.466668666514;4855.49017353187;4900.436449808318;4596;4757.928631070467;4770.0936822003705;4771.6898401603785;4825.469198388104;4867.659263851497;4909.5090490950615;4910.558049775537;4947.109520286383;4964.503549645006;4746.715197088186;4795.904081918412;4806.7836947336755;4806.927896081492;4857.295692124693 16:11:01 INFO - PROCESS | 3641 | |1;ext.html;610.5939550199117;611.5566214494489;620.9658468784215;622.806929851746;635.5328833307522;32707;33367.16582085449;33412.498812517835;33414.66585334146;33468.83265583675;36271;36886.44670329947;36926.26147477049;36942;36971.26057478849;7504.849903001923;7840.568768717718;7854.7250846220395;7858.960705196495;7870.527768333918;7748.2251774822635;7865.056193256817;7868.134505204423;7869.409794265424;7878.369730421553;7885.8028549286155;7947.841043179133;7954.125046244909;7957.562334071624;7962.52224866507;7842.41181911356;7876.05487341517;7900;7914.564698941556;7920;7787.688492460295;7892.56590887501;7893.96053019737;7906.130325664172;7906.486078404885;34255.82872085624;34399;34562.48156277658;34590.65409345925;34620.307593848236;3208.7433005359517;3375.4093033719;3410.36908171989;3819.5034645496185;3826.1199924017355;25151.748482515122;25599.104031359;25929.262114373025;25976;26125.608115878276;3451.758376913617;3517.155882588186;3518.8416521256604;3537.770044947096;3697.8890633281044;165364;167209;167298;167723.99999999878;167803;51207;51332.48667513352;51490.74254628778;51623.48376516262;52203.21695174575;56362.43637563572;59112;59129;59333.70333148307;59386.70306648439;14255.78616320756;14463.349149288308;14463.638409039648;14466.132032078109;14481.565553033426;10227.7443063924;10564.260501764802;10933.835992460119;10938.179636527293;10954.726131846608;15243.16162611067;17601.471955841345;18189.272429102686;18215.908920455313;18281.81718182828;6781.694823732944;6948;6970.337817907291;6993.860122797516;7186.209516953131;872.358816270041;902.0979020979021;938.7653086728318;988.1304452082122;1021.4739409204266;26396.60405093925;27881.30296742557;28065.859670701517;28315.292117696812;28456.28859278493;997.9272282296561;1071.9142468602492;1094.6168840905777;1103.3214573037524;1138.4933704501418;14672.559823205322;14691.11853288806;14726.63183420423;15090.773638395432;15122.435638327044;324558;325064;329478;329543;332473;48387;49114.508854911706;49241.26138107931;49363;49368.50631493711;1232.9815052774215;1275.0373468031578;1276.5914907229596;1290.832191815058;1300.811382349554;26071.73928260693;27523;27636.170914872586;27659.308517287227;27948.86025569859;43237.78381108074;43302.133957321304;43797.78101109474;43801.86773851727;43819;316888;317103;317153;319300;320625;22360.217392391187;24921.875390622932;24970.250892473254;25240.242792716246;25638.359041024123;35697;36611;36674.44988325124;36948.076298091684;36993;29894.69723598875;33741;34194.14514637154;34847;38141.809290953366;33874.3225135491;34161;34431.31137377188;34665.82667086648;34783.652163478044;33925.83037084799;33927.32145357128;33953.66046339604;34287.65712342845;34330;29744.256393590334;31162;31183;31385.215369615944;31516.212094697818;23784.286471405885;23863;23866.52266954686;23985.76014239905;24304.149354772497 16:11:01 INFO - PROCESS | 3641 | |2;jquery.html;377.8450835157585;384.5234300286898;385.961403859614;388.65603940512636;396.4509154820576;16069.196540172989;17323.047232402212;17404.042777647224;17582.912085439555;17620.383286584973;16126.677466450665;16734.16329183542;16902.1548922554;16954.745678814797;17271.740923886122;5070.391553013635;5298.36419629645;5332.226827110087;5337.572994160477;5342.0651386007485;3580.4629305604108;5796.188533605298;6139.2325959255095;6160.045192995093;6165.506759459233;6005.819825405223;6087.360827113156;6089.056196289582;6113.388661133896;6114.144019837227;5882.76468941244;6015;6033.818985430444;6037.577369584131;6048.879022419549;3348.7321014318795;3555.6622120898473;3557.6975957043683;4205;5367.704776237305;19071.427857164308;19547.804521954884;19843.30548430798;19868.205271789113;19879.10544025508;1916.6645836978612;2005.962054216818;2078.9168433262653;2119.5548934723724;2213.2917466410754;12432.440540175714;12728.554500592434;12736.80894786579;12888.80666789999;13225.933870330588;1803.1525183163892;1811.7916439609482;1817.1102053863965;1843.6865732825452;1852.4998250472297;70143.64928175327;70166.64916675435;71250.2874971254;71367;72969.6351518239;9465.43207407544;9534.90465095354;9830.21358291335;9892.80214395708;9959;13637.454501820015;13797.51708690191;13805.723885522233;13809.654758631115;13809.861901380858;7360.742374016883;7421.814454638569;7474.850502990019;7574.962125189449;7637.5035622684345;7135.536190147727;7185.6047917364;7193;7289.271072892669;7315.634218289064;6151.630902145886;6234.5635805494085;6251.74993000284;6275.780347687809;6348.1430006949395;1612.2664187794526;1669.607642204081;1762.6739053275185;1798.721198214279;1802.1710013393724;818.3902992270796;870.9477431354139;968.3995922527937;994.9701508954743;1000.229823036258;15840;16046.67906641884;16541.421050263183;16685.165741712866;18008.819911800714;902.5893218585528;956.7512446763892;969.1568335548118;973.2603221551672;981.8919918808925;9923.950380248198;10117.595296188218;10161.745956351151;10183.18534517237;10188.286819922534;382857;408341.9989601267;409479;412824;415051;69379.3062069383;69710.65144674244;70758.29241707516;71417.64291178511;72265.2773472269;949.1884438804723;999.0758548342753;999.1806718490768;1002.4035698759227;1002.5739060899089;14886.288076870866;15712;15898;15945.8405415949;16170.434034808724;30811.383772324876;30872.84563577168;33579;33759.96160345482;35471.64528354786;44783.77608111939;45039.54960450353;45128.548714512435;45252.09495810131;45574;7711.575863327571;8004.51972881629;8032.076311224284;8057.315128214167;8129.634166462405;7639.694412223671;8554.27288680469;11154.776904462027;11472.426378681199;11695.590654327058;6859.162523213411;7415.443841712001;8747.475151490931;9047.864282035905;10114.140298074451;9875.358101723365;9961.203103751828;9962.850557241502;10061.144802691853;10559.366438013743;10119.443430611387;10136.543855526666;10147.391156530632;10185.185185185019;10630.30902991303;7419.888701669372;7452.366548843409;7541.396688265036;7798.298153166243;7812.453128280966;7737.92262077372;9742.31803773729;9784.951075244579;10014.399136051568;10177.287589868638 16:11:01 INFO - PROCESS | 3641 | |3;mootools.html;1261.7791886419875;1425.550951450293;1473.6315921019745;1604.646977664914;1805.9097045147748;6687.899681504781;7544.811379715503;7770.766876993699;7772.727954521592;7775.961120194405;7719.150893401721;7860.803479912991;7867;7867.488613240135;7868.213178682129;1889.4048374761906;1937.7771556270998;2235.2065016919005;2264.6829443877828;2293.266154830455;2309.5265470578493;2331.813454923602;2334.323046316566;2335.4978679583887;2336.5910965581043;2277.87471689057;2289.05004423165;2311.0640190722784;2311.15642790382;2311.445253139243;1874.587590730044;2047.9795202048012;2136.0708091980036;2192.0355043780687;2199.549092436047;2240.9327720168258;2264.1622599638076;2264.8980795864227;2268.2288022072576;2268.500929795459;7602.0877494700435;7729.381649468029;7731.381489480828;7738.7678369649;7749.186335434754;4630.166570017395;4783.067301876135;4783.258594917758;4801.111794318027;4803.471618122004;3056.19010962093;3059.1587313488744;3111.859966301522;3137.8744850206194;3140.7173354398215;925.8287216864901;932.4125800745487;935.4761333653177;954.88063992001;957.0525180071749;10540.999999999924;10543.051125398752;10560.94719526405;10576.52405641748;10580.78838423235;4417.2269852775635;4426.800793964279;4459;4518.164139634178;4519.502854685982;9001.639934402681;9064.093590640883;9079.137481939206;9085.409448385833;9085.863712044325;4808.519148085234;4821.614270858323;4825.758712064383;4845.53967373099;4858.902821943541;3775.169462718198;4295.613394794484;4439.822407103744;4443.955560444419;4462.486814016364;3699.79651119191;3754.4931434256027;3809.904752381213;3835.884923452301;3881.8059097045034;1254.711416374239;1259.8614152443224;1261.6467389131058;1269.6698858296909;1276.7510335484676;792.0297635396709;837.417994493821;868.4268382867277;881.5107615273585;898.2993265253114;5272.420033796279;5375.3280839895015;5401.783928642811;5447.5641948644015;5520.006398848246;434.2617550164733;436.3846975764157;436.7314101827353;918.6738707758783;925.7596616188839;3523.242502861897;3586.5337506124038;3675.467057276733;3682.834272457746;3685.0971511979737;9312.906870931203;9616.23070154386;9763.414195148314;9775.51122443875;9801.509924503745;9674.903250967542;9687.66093186735;9701.805963880683;9704.805903881883;9718.465484398284;7268.200497945222;7460.179380268166;7461.1419686735635;7464.514806537558;7477.7008919643695;5486.286782718381;5497.780088796563;5517.282753242052;5578.748956296895;5649;8784.648614055366;8785.297176226015;8828.337874659555;8840.823183536422;8891.822163556822;8763.079876612865;8819.691310804092;8943.821123577622;9076.455412675261;9083.863742043743;5965.970170149121;6799.11611490503;6889.483288753263;7034.2965703429245;7069.116360454943;7585.355244804254;7622.847543049219;7676.846463070819;7701.383889288732;7709.4603377763015;6673.232578253563;6854.691538880663;6884;6911;7042.859142817218;6617.503687223574;6675.0654908313845;6838.5213035089055;6883.827904302432;6943.132108486439;6283.5601507895835;6321.683915804283;6387.361263873576;6398.71205795731;6399.200099987502;4514.074614703912;4522.5929666330185;4574;4594.862154135381;4627.444706635225;4873.9025219496125;4874.926876096933;4887;4979.751012449436;5031.798728050837 16:11:01 INFO - PROCESS | 3641 | |4;prototype.html;312.6092384519349;319.2752451934109;326.3179953896357;326.41082845463944;328.5121594432269;4587.655925805561;4694.577488026077;4926.11329960607;4984.401871775383;4987.650864439491;4884.267359896008;4894.216925291954;4958.0579689858905;4980.078685443195;5006.849794506162;3946.2304850554083;3958.1396743530495;3962.742421742592;3966.8809935701975;3979.621935916083;3711.42472916697;3804.1440675847853;3958.5051868516434;3965.3655415133585;3968.5634580196156;3945.644891959723;3948.1708841143395;3952.407138929155;3960.7623542587394;3965.5241371035518;3910.335243008695;3911.471951286568;3929.7052721046034;3938.7833669148185;3940.290747665419;3511.262634846685;3514.3147086318177;3514.3498452786316;3517.384457719889;3521.418965870628;4513.7517436540975;4744.122337367598;4751.71489710615;4772.928406073912;4797.688150270221;4399.604035636776;4412.24991751403;4437.778111094464;4446.577575130357;4459.487158976727;5248.6588371755715;5250.7112108834;5251.264822924793;5256.106461901486;5259.316288882459;3621.076625460517;3695.427208782616;3704.203596226824;3722.3485889969147;3728.9627103728885;5202.609804264695;5247.34408198979;5424.430434804328;5436.510714035716;5451.427600101972;3811.3901775715754;3814.6185381461632;3831.904202394907;3837.002379381381;3837.0791010157363;3860.8262628181237;3864.7874366909527;3870.825812838429;3878.2243551289853;3882.378819388884;4410;4413.249747542925;4415.315626077963;4416.1609294233995;4429.734215947054;5023.874403139951;5189.299444574934;5193.584513238932;5193.766280517386;5197.194434862602;1314.7830607949581;1336.251699048536;1338.919664820114;1342.06726325205;1346.4344975110478;883.6862913665685;902.9953503222835;915.2494954137543;923.4274749655257;924.2236521322121;4604.332371806069;4633.397658304399;4634.884127896829;4634.999999999933;4636.953630463652;5377.085895397791;5388.407275199725;5395.973020134953;5405.405405405402;5406.864828379244;4411.889702757392;4632.69887457321;4632.97683511587;4652.906941861212;4661.137689527448;2881.5965764792945;2890.5375139977505;2901.302737898311;2902.2889392099073;2903.0419961413104;5190.688558686491;5200.5059519345605;5201.895962080737;5210.687358758487;5210.713410762444;5335.279737235501;5563.749631266522;5568.331800184003;5578.442155784389;5585.972070139705;5163.896722065613;5165.767540460688;5183.870403239949;5187.507186817246;5193.350831146106;5423;5428.56571474289;5447.400785913625;5452;5459.918101228564;5069.7718602662235;5329.600279978939;5337.519623233928;5353.143497040455;5365.409804921377;4930.852074437773;5049.697018178921;5204.2193670948145;5218.608604354613;5242.318498595158;3802.980985095057;3803.2203398303836;3815.904602384963;3815.980920095382;3820.331441997695;5475.06923822959;5476.726163691879;5481.3970463248215;5483.698396588066;5489.149181876655;5005.974970125126;5196.896062078662;5229.555487783581;5257.237700533325;5264.394594621667;5177.663451875616;5181.145111056633;5190.740462976912;5191.506806853494;5203.531682148625;5120.129577971679;5130;5130.743462826769;5150.613703972292;5152.433232344514;5062.367204099488;5239.44985776488;5240.71176085319;5248.7665398630525;5253.579713622978;5083.38999320084;5093.592512598909;5096.923546146737;5113.207452844815;5116.897662046664 16:11:01 INFO - PROCESS | 3641 | |5;yui.html;748.9400847932166;762.2606072110051;762.3786613909663;768.9760658670505;772.8492943875947;12001.579944701938;12344.691382715437;12385.876141238585;12394.132410731252;12395.6901077473;12886.420111095;12940.741185176314;12977;12985.74028519429;13042.087053906207;635.698043429372;785.8231897823001;802.5224991130283;814.0516298512226;814.4665244265016;801.6753214947926;805.2229598437507;808.2442915873647;808.5957021489255;808.8503626829026;859.6260626627405;865.3380164174412;865.6277800545763;866.0603245478663;866.0906048648925;664.4983037806426;833.829065041665;857.6655104509247;861.0313397427893;861.7414775567336;624.2415465209792;624.4848000399688;625.4808508937571;625.987480250397;626.5301024231826;12853.16454430459;12878.034147438886;12879.227246365248;12912.289824059673;12921.353932303347;12683.365831708377;13260.270685112315;13307.334633268298;13327.866721332759;13758.93120534401;10106.696799096038;10408.843867341995;10585.311954722918;10823.350598964087;10852.620158294421;3345.5985281766343;3389.881354152593;3417.7436692247934;3430.77699949505;3439.7076248518906;49782.50217497851;49874.501254987714;50303.74848125736;50435;50677.23984140241;9533.332666713264;9660.227181825438;9864.457454840052;9886.950565247127;9946.403215807075;16819.990800552005;16864.915675421544;16950;17013.659726805396;17019.149042547822;6658.667066646648;6674.299198584175;6758.121444212221;6759;6882.965585172042;3649.671529562352;3736.75711078779;3750.2748735581395;3773.6226377362595;3800.486934263839;2733.439644872796;2814.5637426198973;2821.7601503871992;2824.2939265183704;2831.320483084045;445.44319600499375;514.3596222702685;529.1454301303368;536.6779932040822;537.2290762755381;499.0268975497794;575.3757173466752;583.9678817665069;624.6002558362652;640.1422094393535;7411.777646670501;7448.255174482509;7520.435967302475;7585.6965721370525;7780.377569794403;567.4750855458767;597.3548567547039;598.2223109957039;601.2034054877305;603.405645439242;3684.244729830378;3693.8891833245048;3764.5106136202116;3862.7102967277565;3907.1208977979727;54427;56622.43377566172;56679.71660141755;56737;57863;49326.26010609844;49577.50422495801;49638;50053;50681.746591266805;44608.55391446044;45329.54670453319;45801;46282.84292892637;46590.5340946593;7380.1512826023545;7489.66296516669;7696.923030769621;7789.493682910593;8053.436259461781;26020.73979260183;26233.73766262313;27227.59158612662;27489.31276718018;27509.86245068762;29269.707302926698;34426.65573344234;36283.637163628024;36354.636453635125;37442.62557374391;10395.532201051123;10405.323653962469;10470.790584188426;10815.621453249098;10998.395088270221;12183.512659493521;12296.139270250997;12340.938295308466;12615.432305546088;12999.350032498149;11014.118870490502;11072.335659860435;11486.425678716198;11647.359395233343;12009.75980480368;10788.676339709822;10882.836757448486;10989.725256868642;10993.945030274797;11435;11148.331100134017;11416.657500275005;11434.542618295174;11779.587714429954;11830.822537662114;9692.545079572998;9795.9020409795;10037.69886903394;10054.19566434698;10120.392776433437;9819;9980.301378903407;10098.293119481566;10098.385369143503;10100.062851043074 16:11:01 INFO - PROCESS | 3641 | __end_tp_report 16:11:01 INFO - PROCESS | 3641 | __start_cc_report 16:11:01 INFO - PROCESS | 3641 | _x_x_mozilla_cycle_collect,939 16:11:01 INFO - PROCESS | 3641 | __end_cc_report 16:11:01 INFO - PROCESS | 3641 | __startTimestamp1461107461207__endTimestamp 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | ------- Summary: start ------- 16:11:01 INFO - PROCESS | 3641 | Number of tests: 6 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | [#0] dojo.html Cycles:165 Average:4625.52 Median:4768.19 stddev:474.47 (10.0%) stddev-sans-first:449.25 16:11:01 INFO - PROCESS | 3641 | Values: 2625.9 2672.2 2685.9 2716.2 2724.0 4509.3 4582.8 4658.7 4674.3 4722.7 4723.4 4763.6 4767.3 4768.2 4786.0 4241.3 4294.2 4331.0 4368.7 4414.0 4332.8 4361.3 4377.3 4384.3 4430.7 4159.5 4239.2 4249.8 4299.0 4330.1 4291.2 4320.0 4320.5 4364.5 4382.4 4237.3 4277.3 4290.0 4306.8 4335.3 4491.6 4559.6 4560.9 4609.7 4646.1 4943.6 4948.5 4959.9 4961.7 4985.6 4955.9 4980.4 4981.8 4995.0 5038.7 4456.7 4631.7 4633.4 4703.9 4710.6 5147.4 5171.6 5178.7 5181.3 5190.6 4957.3 4964.2 4967.2 4971.2 4973.2 4858.9 5006.7 5091.3 5091.6 5097.2 4954.9 4955.4 4956.3 4969.4 4972.5 4896.3 4935.8 4936.0 4936.5 4968.0 4167.4 4252.7 4254.5 4254.7 4284.8 3708.5 3742.3 3750.5 3751.7 3751.8 4287.1 4289.1 4292.9 4301.7 4354.6 5062.7 5067.1 5068.8 5075.8 5119.9 4334.7 4355.5 4374.8 4417.0 4425.9 4285.8 4342.3 4399.3 4442.0 4446.3 4766.3 4768.2 4771.7 4809.6 4815.2 5008.7 5010.2 5011.6 5023.7 5059.1 4697.6 4728.8 4765.0 4793.7 4804.1 4874.7 4889.9 4895.0 4895.0 4941.2 5019.1 5027.6 5028.2 5029.5 5080.3 4693.5 4788.7 4824.1 4850.1 4872.2 4825.5 4837.4 4848.5 4855.5 4900.4 4596.0 4757.9 4770.1 4771.7 4825.5 4867.7 4909.5 4910.6 4947.1 4964.5 4746.7 4795.9 4806.8 4806.9 4857.3 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | [#1] ext.html Cycles:180 Average:42654.88 Median:34224.99 stddev:73975.21 (216.1%) stddev-sans-first:74115.38 16:11:01 INFO - PROCESS | 3641 | Values: 610.6 611.6 621.0 622.8 635.5 32707.0 33367.2 33412.5 33414.7 33468.8 36271.0 36886.4 36926.3 36942.0 36971.3 7504.8 7840.6 7854.7 7859.0 7870.5 7748.2 7865.1 7868.1 7869.4 7878.4 7885.8 7947.8 7954.1 7957.6 7962.5 7842.4 7876.1 7900.0 7914.6 7920.0 7787.7 7892.6 7894.0 7906.1 7906.5 34255.8 34399.0 34562.5 34590.7 34620.3 3208.7 3375.4 3410.4 3819.5 3826.1 25151.7 25599.1 25929.3 25976.0 26125.6 3451.8 3517.2 3518.8 3537.8 3697.9 165364.0 167209.0 167298.0 167724.0 167803.0 51207.0 51332.5 51490.7 51623.5 52203.2 56362.4 59112.0 59129.0 59333.7 59386.7 14255.8 14463.3 14463.6 14466.1 14481.6 10227.7 10564.3 10933.8 10938.2 10954.7 15243.2 17601.5 18189.3 18215.9 18281.8 6781.7 6948.0 6970.3 6993.9 7186.2 872.4 902.1 938.8 988.1 1021.5 26396.6 27881.3 28065.9 28315.3 28456.3 997.9 1071.9 1094.6 1103.3 1138.5 14672.6 14691.1 14726.6 15090.8 15122.4 324558.0 325064.0 329478.0 329543.0 332473.0 48387.0 49114.5 49241.3 49363.0 49368.5 1233.0 1275.0 1276.6 1290.8 1300.8 26071.7 27523.0 27636.2 27659.3 27948.9 43237.8 43302.1 43797.8 43801.9 43819.0 316888.0 317103.0 317153.0 319300.0 320625.0 22360.2 24921.9 24970.3 25240.2 25638.4 35697.0 36611.0 36674.4 36948.1 36993.0 29894.7 33741.0 34194.1 34847.0 38141.8 33874.3 34161.0 34431.3 34665.8 34783.7 33925.8 33927.3 33953.7 34287.7 34330.0 29744.3 31162.0 31183.0 31385.2 31516.2 23784.3 23863.0 23866.5 23985.8 24304.1 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | [#2] jquery.html Cycles:180 Average:24411.33 Median:44911.66 stddev:66732.18 (148.6%) stddev-sans-first:66894.98 16:11:01 INFO - PROCESS | 3641 | Values: 377.8 384.5 386.0 388.7 396.5 16069.2 17323.0 17404.0 17582.9 17620.4 16126.7 16734.2 16902.2 16954.7 17271.7 5070.4 5298.4 5332.2 5337.6 5342.1 3580.5 5796.2 6139.2 6160.0 6165.5 6005.8 6087.4 6089.1 6113.4 6114.1 5882.8 6015.0 6033.8 6037.6 6048.9 3348.7 3555.7 3557.7 4205.0 5367.7 19071.4 19547.8 19843.3 19868.2 19879.1 1916.7 2006.0 2078.9 2119.6 2213.3 12432.4 12728.6 12736.8 12888.8 13225.9 1803.2 1811.8 1817.1 1843.7 1852.5 70143.6 70166.6 71250.3 71367.0 72969.6 9465.4 9534.9 9830.2 9892.8 9959.0 13637.5 13797.5 13805.7 13809.7 13809.9 7360.7 7421.8 7474.9 7575.0 7637.5 7135.5 7185.6 7193.0 7289.3 7315.6 6151.6 6234.6 6251.7 6275.8 6348.1 1612.3 1669.6 1762.7 1798.7 1802.2 818.4 870.9 968.4 995.0 1000.2 15840.0 16046.7 16541.4 16685.2 18008.8 902.6 956.8 969.2 973.3 981.9 9924.0 10117.6 10161.7 10183.2 10188.3 382857.0 408342.0 409479.0 412824.0 415051.0 69379.3 69710.7 70758.3 71417.6 72265.3 949.2 999.1 999.2 1002.4 1002.6 14886.3 15712.0 15898.0 15945.8 16170.4 30811.4 30872.8 33579.0 33760.0 35471.6 44783.8 45039.5 45128.5 45252.1 45574.0 7711.6 8004.5 8032.1 8057.3 8129.6 7639.7 8554.3 11154.8 11472.4 11695.6 6859.2 7415.4 8747.5 9047.9 10114.1 9875.4 9961.2 9962.9 10061.1 10559.4 10119.4 10136.5 10147.4 10185.2 10630.3 7419.9 7452.4 7541.4 7798.3 7812.5 7737.9 9742.3 9785.0 10014.4 10177.3 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | [#3] mootools.html Cycles:180 Average:5202.34 Median:5424.67 stddev:2859.65 (52.7%) stddev-sans-first:2852.33 16:11:01 INFO - PROCESS | 3641 | Values: 1261.8 1425.6 1473.6 1604.6 1805.9 6687.9 7544.8 7770.8 7772.7 7776.0 7719.2 7860.8 7867.0 7867.5 7868.2 1889.4 1937.8 2235.2 2264.7 2293.3 2309.5 2331.8 2334.3 2335.5 2336.6 2277.9 2289.1 2311.1 2311.2 2311.4 1874.6 2048.0 2136.1 2192.0 2199.5 2240.9 2264.2 2264.9 2268.2 2268.5 7602.1 7729.4 7731.4 7738.8 7749.2 4630.2 4783.1 4783.3 4801.1 4803.5 3056.2 3059.2 3111.9 3137.9 3140.7 925.8 932.4 935.5 954.9 957.1 10541.0 10543.1 10560.9 10576.5 10580.8 4417.2 4426.8 4459.0 4518.2 4519.5 9001.6 9064.1 9079.1 9085.4 9085.9 4808.5 4821.6 4825.8 4845.5 4858.9 3775.2 4295.6 4439.8 4444.0 4462.5 3699.8 3754.5 3809.9 3835.9 3881.8 1254.7 1259.9 1261.6 1269.7 1276.8 792.0 837.4 868.4 881.5 898.3 5272.4 5375.3 5401.8 5447.6 5520.0 434.3 436.4 436.7 918.7 925.8 3523.2 3586.5 3675.5 3682.8 3685.1 9312.9 9616.2 9763.4 9775.5 9801.5 9674.9 9687.7 9701.8 9704.8 9718.5 7268.2 7460.2 7461.1 7464.5 7477.7 5486.3 5497.8 5517.3 5578.7 5649.0 8784.6 8785.3 8828.3 8840.8 8891.8 8763.1 8819.7 8943.8 9076.5 9083.9 5966.0 6799.1 6889.5 7034.3 7069.1 7585.4 7622.8 7676.8 7701.4 7709.5 6673.2 6854.7 6884.0 6911.0 7042.9 6617.5 6675.1 6838.5 6883.8 6943.1 6283.6 6321.7 6387.4 6398.7 6399.2 4514.1 4522.6 4574.0 4594.9 4627.4 4873.9 4874.9 4887.0 4979.8 5031.8 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | [#4] prototype.html Cycles:180 Average:4353.30 Median:4944.46 stddev:1256.78 (25.4%) stddev-sans-first:1223.16 16:11:01 INFO - PROCESS | 3641 | Values: 312.6 319.3 326.3 326.4 328.5 4587.7 4694.6 4926.1 4984.4 4987.7 4884.3 4894.2 4958.1 4980.1 5006.8 3946.2 3958.1 3962.7 3966.9 3979.6 3711.4 3804.1 3958.5 3965.4 3968.6 3945.6 3948.2 3952.4 3960.8 3965.5 3910.3 3911.5 3929.7 3938.8 3940.3 3511.3 3514.3 3514.3 3517.4 3521.4 4513.8 4744.1 4751.7 4772.9 4797.7 4399.6 4412.2 4437.8 4446.6 4459.5 5248.7 5250.7 5251.3 5256.1 5259.3 3621.1 3695.4 3704.2 3722.3 3729.0 5202.6 5247.3 5424.4 5436.5 5451.4 3811.4 3814.6 3831.9 3837.0 3837.1 3860.8 3864.8 3870.8 3878.2 3882.4 4410.0 4413.2 4415.3 4416.2 4429.7 5023.9 5189.3 5193.6 5193.8 5197.2 1314.8 1336.3 1338.9 1342.1 1346.4 883.7 903.0 915.2 923.4 924.2 4604.3 4633.4 4634.9 4635.0 4637.0 5377.1 5388.4 5396.0 5405.4 5406.9 4411.9 4632.7 4633.0 4652.9 4661.1 2881.6 2890.5 2901.3 2902.3 2903.0 5190.7 5200.5 5201.9 5210.7 5210.7 5335.3 5563.7 5568.3 5578.4 5586.0 5163.9 5165.8 5183.9 5187.5 5193.4 5423.0 5428.6 5447.4 5452.0 5459.9 5069.8 5329.6 5337.5 5353.1 5365.4 4930.9 5049.7 5204.2 5218.6 5242.3 3803.0 3803.2 3815.9 3816.0 3820.3 5475.1 5476.7 5481.4 5483.7 5489.1 5006.0 5196.9 5229.6 5257.2 5264.4 5177.7 5181.1 5190.7 5191.5 5203.5 5120.1 5130.0 5130.7 5150.6 5152.4 5062.4 5239.4 5240.7 5248.8 5253.6 5083.4 5093.6 5096.9 5113.2 5116.9 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - PROCESS | 3641 | [#5] yui.html Cycles:180 Average:13102.85 Median:2176.28 stddev:15199.58 (698.4%) stddev-sans-first:15213.91 16:11:01 INFO - PROCESS | 3641 | Values: 748.9 762.3 762.4 769.0 772.8 12001.6 12344.7 12385.9 12394.1 12395.7 12886.4 12940.7 12977.0 12985.7 13042.1 635.7 785.8 802.5 814.1 814.5 801.7 805.2 808.2 808.6 808.9 859.6 865.3 865.6 866.1 866.1 664.5 833.8 857.7 861.0 861.7 624.2 624.5 625.5 626.0 626.5 12853.2 12878.0 12879.2 12912.3 12921.4 12683.4 13260.3 13307.3 13327.9 13758.9 10106.7 10408.8 10585.3 10823.4 10852.6 3345.6 3389.9 3417.7 3430.8 3439.7 49782.5 49874.5 50303.7 50435.0 50677.2 9533.3 9660.2 9864.5 9887.0 9946.4 16820.0 16864.9 16950.0 17013.7 17019.1 6658.7 6674.3 6758.1 6759.0 6883.0 3649.7 3736.8 3750.3 3773.6 3800.5 2733.4 2814.6 2821.8 2824.3 2831.3 445.4 514.4 529.1 536.7 537.2 499.0 575.4 584.0 624.6 640.1 7411.8 7448.3 7520.4 7585.7 7780.4 567.5 597.4 598.2 601.2 603.4 3684.2 3693.9 3764.5 3862.7 3907.1 54427.0 56622.4 56679.7 56737.0 57863.0 49326.3 49577.5 49638.0 50053.0 50681.7 44608.6 45329.5 45801.0 46282.8 46590.5 7380.2 7489.7 7696.9 7789.5 8053.4 26020.7 26233.7 27227.6 27489.3 27509.9 29269.7 34426.7 36283.6 36354.6 37442.6 10395.5 10405.3 10470.8 10815.6 10998.4 12183.5 12296.1 12340.9 12615.4 12999.4 11014.1 11072.3 11486.4 11647.4 12009.8 10788.7 10882.8 10989.7 10993.9 11435.0 11148.3 11416.7 11434.5 11779.6 11830.8 9692.5 9795.9 10037.7 10054.2 10120.4 9819.0 9980.3 10098.3 10098.4 10100.1 16:11:01 INFO - PROCESS | 3641 | -------- Summary: end -------- 16:11:01 INFO - PROCESS | 3641 | 16:11:01 INFO - TEST-INFO | 3641: exit 0 16:11:01 INFO - TEST-OK | dromaeo_css | took 1118162ms 16:11:01 INFO - TEST-START | kraken 16:11:01 INFO - operating with platform_type : linux_ 16:11:01 INFO - Initialising browser for kraken test... 16:11:01 INFO - TEST-INFO | started process 3830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKDftJJ/profile http://localhost:37210/getInfo.html) 16:11:06 INFO - PROCESS | 3830 | __metrics Screen width/height:1600/1200 16:11:06 INFO - PROCESS | 3830 | colorDepth:24 16:11:06 INFO - PROCESS | 3830 | Browser inner width/height: 1024/697 16:11:06 INFO - PROCESS | 3830 | __metrics 16:11:07 ERROR - PROCESS | 3830 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:11:08 INFO - TEST-INFO | 3830: exit 0 16:11:08 INFO - Browser initialized. 16:11:08 INFO - Running cycle 1/1 for kraken test... 16:11:08 INFO - TEST-INFO | started process 3909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKDftJJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:19 INFO - PROCESS | 3909 | RSS: Main: 155271168 16:11:19 INFO - PROCESS | 3909 | 16:11:22 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:23 INFO - PROCESS | 3909 | RSS: Main: 209866752 16:11:23 INFO - PROCESS | 3909 | 16:11:26 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-dft) 16:11:26 INFO - PROCESS | 3909 | RSS: Main: 196149248 16:11:26 INFO - PROCESS | 3909 | 16:11:30 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-fft) 16:11:30 INFO - PROCESS | 3909 | RSS: Main: 266244096 16:11:30 INFO - PROCESS | 3909 | 16:11:32 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-oscillator) 16:11:33 INFO - PROCESS | 3909 | RSS: Main: 174997504 16:11:33 INFO - PROCESS | 3909 | 16:11:35 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:36 INFO - PROCESS | 3909 | RSS: Main: 179179520 16:11:36 INFO - PROCESS | 3909 | 16:11:39 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37210/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:40 INFO - PROCESS | 3909 | RSS: Main: 215105536 16:11:40 INFO - PROCESS | 3909 | 16:11:43 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37210/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:44 INFO - PROCESS | 3909 | RSS: Main: 215818240 16:11:44 INFO - PROCESS | 3909 | 16:11:47 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37210/tests/kraken/driver.html?testName=json-parse-financial) 16:11:47 INFO - PROCESS | 3909 | RSS: Main: 215523328 16:11:47 INFO - PROCESS | 3909 | 16:11:49 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:49 INFO - PROCESS | 3909 | RSS: Main: 201404416 16:11:49 INFO - PROCESS | 3909 | 16:11:51 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:52 INFO - PROCESS | 3909 | RSS: Main: 206188544 16:11:52 INFO - PROCESS | 3909 | 16:11:54 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:55 INFO - PROCESS | 3909 | RSS: Main: 219537408 16:11:55 INFO - PROCESS | 3909 | 16:11:57 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:58 INFO - PROCESS | 3909 | RSS: Main: 225251328 16:11:58 INFO - PROCESS | 3909 | 16:12:01 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:02 INFO - PROCESS | 3909 | RSS: Main: 220114944 16:12:02 INFO - PROCESS | 3909 | 16:12:03 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37210/tests/kraken/driver.html?testName=ai-astar) 16:12:04 INFO - PROCESS | 3909 | RSS: Main: 283480064 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | __start_tp_report 16:12:04 INFO - PROCESS | 3909 | _x_x_mozilla_page_load 16:12:04 INFO - PROCESS | 3909 | _x_x_mozilla_page_load_details 16:12:04 INFO - PROCESS | 3909 | |i|pagename|runs| 16:12:04 INFO - PROCESS | 3909 | |0;ai-astar;111;112;107;111;112;113;101;111;111;112 16:12:04 INFO - PROCESS | 3909 | |1;audio-beat-detection;162;132;158;186;134;160;161;140;196;139 16:12:04 INFO - PROCESS | 3909 | |2;audio-dft;161;162;161;163;162;163;162;161;161;161 16:12:04 INFO - PROCESS | 3909 | |3;audio-fft;73;74;106;112;75;76;73;118;110;73 16:12:04 INFO - PROCESS | 3909 | |4;audio-oscillator;93;93;147;94;94;93;139;93;94;148 16:12:04 INFO - PROCESS | 3909 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;116;117;117 16:12:04 INFO - PROCESS | 3909 | |6;imaging-darkroom;146;145;146;145;147;146;145;147;148;147 16:12:04 INFO - PROCESS | 3909 | |7;imaging-desaturate;95;95;94;95;94;95;94;94;94;95 16:12:04 INFO - PROCESS | 3909 | |8;json-parse-financial;63;63;63;63;64;64;63;80;61;65 16:12:04 INFO - PROCESS | 3909 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;65;65 16:12:04 INFO - PROCESS | 3909 | |10;stanford-crypto-aes;86;78;78;78;79;78;80;79;79;79 16:12:04 INFO - PROCESS | 3909 | |11;stanford-crypto-ccm;134;131;136;132;129;130;130;130;163;133 16:12:04 INFO - PROCESS | 3909 | |12;stanford-crypto-pbkdf2;176;176;174;175;170;175;171;171;176;172 16:12:04 INFO - PROCESS | 3909 | |13;stanford-crypto-sha256-iterative;72;71;71;73;71;71;73;72;71;71 16:12:04 INFO - PROCESS | 3909 | __end_tp_report 16:12:04 INFO - PROCESS | 3909 | __start_cc_report 16:12:04 INFO - PROCESS | 3909 | _x_x_mozilla_cycle_collect,1901 16:12:04 INFO - PROCESS | 3909 | __end_cc_report 16:12:04 INFO - PROCESS | 3909 | __startTimestamp1461107524150__endTimestamp 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | ------- Summary: start ------- 16:12:04 INFO - PROCESS | 3909 | Number of tests: 14 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:3.57 (3.2%) stddev-sans-first:3.77 16:12:04 INFO - PROCESS | 3909 | Values: 111.0 112.0 107.0 111.0 112.0 113.0 101.0 111.0 111.0 112.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:160.50 stddev:21.55 (13.4%) stddev-sans-first:22.77 16:12:04 INFO - PROCESS | 3909 | Values: 162.0 132.0 158.0 186.0 134.0 160.0 161.0 140.0 196.0 139.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 16:12:04 INFO - PROCESS | 3909 | Values: 161.0 162.0 161.0 163.0 162.0 163.0 162.0 161.0 161.0 161.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#3] audio-fft Cycles:10 Average:89.00 Median:73.00 stddev:19.60 (26.9%) stddev-sans-first:19.92 16:12:04 INFO - PROCESS | 3909 | Values: 73.0 74.0 106.0 112.0 75.0 76.0 73.0 118.0 110.0 73.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.00 stddev:24.86 (26.7%) stddev-sans-first:25.71 16:12:04 INFO - PROCESS | 3909 | Values: 93.0 93.0 147.0 94.0 94.0 93.0 139.0 93.0 94.0 148.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:12:04 INFO - PROCESS | 3909 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 16:12:04 INFO - PROCESS | 3909 | Values: 146.0 145.0 146.0 145.0 147.0 146.0 145.0 147.0 148.0 147.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:12:04 INFO - PROCESS | 3909 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:63.50 stddev:5.40 (8.5%) stddev-sans-first:5.69 16:12:04 INFO - PROCESS | 3909 | Values: 63.0 63.0 63.0 63.0 64.0 64.0 63.0 80.0 61.0 65.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:12:04 INFO - PROCESS | 3909 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.41 (3.1%) stddev-sans-first:0.71 16:12:04 INFO - PROCESS | 3909 | Values: 86.0 78.0 78.0 78.0 79.0 78.0 80.0 79.0 79.0 79.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:132.50 stddev:10.14 (7.7%) stddev-sans-first:10.75 16:12:04 INFO - PROCESS | 3909 | Values: 134.0 131.0 136.0 132.0 129.0 130.0 130.0 130.0 163.0 133.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:175.00 stddev:2.37 (1.4%) stddev-sans-first:2.35 16:12:04 INFO - PROCESS | 3909 | Values: 176.0 176.0 174.0 175.0 170.0 175.0 171.0 171.0 176.0 172.0 16:12:04 INFO - PROCESS | 3909 | 16:12:04 INFO - PROCESS | 3909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 16:12:04 INFO - PROCESS | 3909 | Values: 72.0 71.0 71.0 73.0 71.0 71.0 73.0 72.0 71.0 71.0 16:12:04 INFO - PROCESS | 3909 | -------- Summary: end -------- 16:12:04 INFO - PROCESS | 3909 | 16:12:05 INFO - TEST-INFO | 3909: exit 0 16:12:05 INFO - TEST-OK | kraken | took 63277ms 16:12:05 INFO - SUITE-END | took 1181s 16:12:05 INFO - Completed test suite (00:19:41) 16:12:05 INFO - javascript benchmark 16:12:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.855577943213, 2672.158270144903, 2685.932851678708, 2716.1851444566623, 2723.959140612891, 4509.346144809009, 4582.77086145693, 4658.650601204906, 4674.27548729947, 4722.716637001778, 4723.409573803275, 4763.571278584926, 4767.284907263912, 4768.1894078006735, 4785.976070119653, 4241.342591898246, 4294.248506511363, 4331.0255192581735, 4368.737875727451, 4414.02891363901, 4332.84835030774, 4361.302191649337, 4377.277749171383, 4384.320430333303, 4430.689851710382, 4159.500859896802, 4239.173361194568, 4249.80875860587, 4299.0, 4330.133973205371, 4291.184674911757, 4319.956800431987, 4320.546342634041, 4364.454443194601, 4382.364557139197, 4237.322028475429, 4277.251480990845, 4290.01329694169, 4306.849260275875, 4335.328024156261, 4491.550844915515, 4559.635229181657, 4560.8859778505475, 4609.67732258742, 4646.1404640141345, 4943.629227807929, 4948.505149485059, 4959.90080198394, 4961.70229786214, 4985.601151907875, 4955.851324460272, 4980.377452818398, 4981.775820088104, 4995.0, 5038.748062596856, 4456.6880318377725, 4631.722096674143, 4633.374494443275, 4703.929441058387, 4710.646701497401, 5147.356580427447, 5171.637985341065, 5178.689278643218, 5181.274621552986, 5190.6107041972, 4957.3059771632, 4964.205727083649, 4967.205247160437, 4971.1549036663855, 4973.204287314013, 4858.854234372904, 5006.69959802413, 5091.287219789232, 5091.643584949018, 5097.235414687826, 4954.9009019819405, 4955.430125535538, 4956.256561515729, 4969.3539839821315, 4972.5276098770555, 4896.338994235733, 4935.777889994887, 4935.988122434892, 4936.506349365035, 4967.975160124249, 4167.395727619478, 4252.723572967747, 4254.489461264668, 4254.744715317091, 4284.76433796138, 3708.5364329458816, 3742.3263812513464, 3750.474933509311, 3751.681107105872, 3751.756135851161, 4287.056847493546, 4289.0992891492515, 4292.91414171721, 4301.720388174758, 4354.608085272341, 5062.670926389773, 5067.113255180328, 5068.847934561969, 5075.796968121308, 5119.948800511947, 4334.696571240046, 4355.499117601453, 4374.846880359172, 4416.977915110404, 4425.911481770347, 4285.7642829644665, 4342.348647702806, 4399.296112621965, 4442.0, 4446.288593825037, 4766.332713420194, 4768.165571025057, 4771.71369717818, 4809.591184749335, 4815.22956326986, 5008.749562521933, 5010.198368261061, 5011.574016208663, 5023.6985780853265, 5059.114654935298, 4697.577218050392, 4728.810847566059, 4764.952350476451, 4793.688410253322, 4804.0872234275375, 4874.731889746098, 4889.926651100308, 4894.95105048945, 4895.04546613407, 4941.234108713155, 5019.146745053423, 5027.572656324253, 5028.170351892043, 5029.5221953914315, 5080.339555857715, 4693.483716791082, 4788.736619485822, 4824.131656301899, 4850.05423942342, 4872.220444728827, 4825.469198388104, 4837.395325584302, 4848.466668666514, 4855.49017353187, 4900.436449808318, 4596.0, 4757.928631070467, 4770.0936822003705, 4771.6898401603785, 4825.469198388104, 4867.659263851497, 4909.5090490950615, 4910.558049775537, 4947.109520286383, 4964.503549645006, 4746.715197088186, 4795.904081918412, 4806.7836947336755, 4806.927896081492, 4857.295692124693], "value": 4596.339710696495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.5939550199117, 611.5566214494489, 620.9658468784215, 622.806929851746, 635.5328833307522, 32707.0, 33367.16582085449, 33412.498812517835, 33414.66585334146, 33468.83265583675, 36271.0, 36886.44670329947, 36926.26147477049, 36942.0, 36971.26057478849, 7504.849903001923, 7840.568768717718, 7854.7250846220395, 7858.960705196495, 7870.527768333918, 7748.2251774822635, 7865.056193256817, 7868.134505204423, 7869.409794265424, 7878.369730421553, 7885.8028549286155, 7947.841043179133, 7954.125046244909, 7957.562334071624, 7962.52224866507, 7842.41181911356, 7876.05487341517, 7900.0, 7914.564698941556, 7920.0, 7787.688492460295, 7892.56590887501, 7893.96053019737, 7906.130325664172, 7906.486078404885, 34255.82872085624, 34399.0, 34562.48156277658, 34590.65409345925, 34620.307593848236, 3208.7433005359517, 3375.4093033719, 3410.36908171989, 3819.5034645496185, 3826.1199924017355, 25151.748482515122, 25599.104031359, 25929.262114373025, 25976.0, 26125.608115878276, 3451.758376913617, 3517.155882588186, 3518.8416521256604, 3537.770044947096, 3697.8890633281044, 165364.0, 167209.0, 167298.0, 167723.99999999878, 167803.0, 51207.0, 51332.48667513352, 51490.74254628778, 51623.48376516262, 52203.21695174575, 56362.43637563572, 59112.0, 59129.0, 59333.70333148307, 59386.70306648439, 14255.78616320756, 14463.349149288308, 14463.638409039648, 14466.132032078109, 14481.565553033426, 10227.7443063924, 10564.260501764802, 10933.835992460119, 10938.179636527293, 10954.726131846608, 15243.16162611067, 17601.471955841345, 18189.272429102686, 18215.908920455313, 18281.81718182828, 6781.694823732944, 6948.0, 6970.337817907291, 6993.860122797516, 7186.209516953131, 872.358816270041, 902.0979020979021, 938.7653086728318, 988.1304452082122, 1021.4739409204266, 26396.60405093925, 27881.30296742557, 28065.859670701517, 28315.292117696812, 28456.28859278493, 997.9272282296561, 1071.9142468602492, 1094.6168840905777, 1103.3214573037524, 1138.4933704501418, 14672.559823205322, 14691.11853288806, 14726.63183420423, 15090.773638395432, 15122.435638327044, 324558.0, 325064.0, 329478.0, 329543.0, 332473.0, 48387.0, 49114.508854911706, 49241.26138107931, 49363.0, 49368.50631493711, 1232.9815052774215, 1275.0373468031578, 1276.5914907229596, 1290.832191815058, 1300.811382349554, 26071.73928260693, 27523.0, 27636.170914872586, 27659.308517287227, 27948.86025569859, 43237.78381108074, 43302.133957321304, 43797.78101109474, 43801.86773851727, 43819.0, 316888.0, 317103.0, 317153.0, 319300.0, 320625.0, 22360.217392391187, 24921.875390622932, 24970.250892473254, 25240.242792716246, 25638.359041024123, 35697.0, 36611.0, 36674.44988325124, 36948.076298091684, 36993.0, 29894.69723598875, 33741.0, 34194.14514637154, 34847.0, 38141.809290953366, 33874.3225135491, 34161.0, 34431.31137377188, 34665.82667086648, 34783.652163478044, 33925.83037084799, 33927.32145357128, 33953.66046339604, 34287.65712342845, 34330.0, 29744.256393590334, 31162.0, 31183.0, 31385.215369615944, 31516.212094697818, 23784.286471405885, 23863.0, 23866.52266954686, 23985.76014239905, 24304.149354772497], "value": 17040.34467045335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.8450835157585, 384.5234300286898, 385.961403859614, 388.65603940512636, 396.4509154820576, 16069.196540172989, 17323.047232402212, 17404.042777647224, 17582.912085439555, 17620.383286584973, 16126.677466450665, 16734.16329183542, 16902.1548922554, 16954.745678814797, 17271.740923886122, 5070.391553013635, 5298.36419629645, 5332.226827110087, 5337.572994160477, 5342.0651386007485, 3580.4629305604108, 5796.188533605298, 6139.2325959255095, 6160.045192995093, 6165.506759459233, 6005.819825405223, 6087.360827113156, 6089.056196289582, 6113.388661133896, 6114.144019837227, 5882.76468941244, 6015.0, 6033.818985430444, 6037.577369584131, 6048.879022419549, 3348.7321014318795, 3555.6622120898473, 3557.6975957043683, 4205.0, 5367.704776237305, 19071.427857164308, 19547.804521954884, 19843.30548430798, 19868.205271789113, 19879.10544025508, 1916.6645836978612, 2005.962054216818, 2078.9168433262653, 2119.5548934723724, 2213.2917466410754, 12432.440540175714, 12728.554500592434, 12736.80894786579, 12888.80666789999, 13225.933870330588, 1803.1525183163892, 1811.7916439609482, 1817.1102053863965, 1843.6865732825452, 1852.4998250472297, 70143.64928175327, 70166.64916675435, 71250.2874971254, 71367.0, 72969.6351518239, 9465.43207407544, 9534.90465095354, 9830.21358291335, 9892.80214395708, 9959.0, 13637.454501820015, 13797.51708690191, 13805.723885522233, 13809.654758631115, 13809.861901380858, 7360.742374016883, 7421.814454638569, 7474.850502990019, 7574.962125189449, 7637.5035622684345, 7135.536190147727, 7185.6047917364, 7193.0, 7289.271072892669, 7315.634218289064, 6151.630902145886, 6234.5635805494085, 6251.74993000284, 6275.780347687809, 6348.1430006949395, 1612.2664187794526, 1669.607642204081, 1762.6739053275185, 1798.721198214279, 1802.1710013393724, 818.3902992270796, 870.9477431354139, 968.3995922527937, 994.9701508954743, 1000.229823036258, 15840.0, 16046.67906641884, 16541.421050263183, 16685.165741712866, 18008.819911800714, 902.5893218585528, 956.7512446763892, 969.1568335548118, 973.2603221551672, 981.8919918808925, 9923.950380248198, 10117.595296188218, 10161.745956351151, 10183.18534517237, 10188.286819922534, 382857.0, 408341.9989601267, 409479.0, 412824.0, 415051.0, 69379.3062069383, 69710.65144674244, 70758.29241707516, 71417.64291178511, 72265.2773472269, 949.1884438804723, 999.0758548342753, 999.1806718490768, 1002.4035698759227, 1002.5739060899089, 14886.288076870866, 15712.0, 15898.0, 15945.8405415949, 16170.434034808724, 30811.383772324876, 30872.84563577168, 33579.0, 33759.96160345482, 35471.64528354786, 44783.77608111939, 45039.54960450353, 45128.548714512435, 45252.09495810131, 45574.0, 7711.575863327571, 8004.51972881629, 8032.076311224284, 8057.315128214167, 8129.634166462405, 7639.694412223671, 8554.27288680469, 11154.776904462027, 11472.426378681199, 11695.590654327058, 6859.162523213411, 7415.443841712001, 8747.475151490931, 9047.864282035905, 10114.140298074451, 9875.358101723365, 9961.203103751828, 9962.850557241502, 10061.144802691853, 10559.366438013743, 10119.443430611387, 10136.543855526666, 10147.391156530632, 10185.185185185019, 10630.30902991303, 7419.888701669372, 7452.366548843409, 7541.396688265036, 7798.298153166243, 7812.453128280966, 7737.92262077372, 9742.31803773729, 9784.951075244579, 10014.399136051568, 10177.287589868638], "value": 8312.874524904251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.7791886419875, 1425.550951450293, 1473.6315921019745, 1604.646977664914, 1805.9097045147748, 6687.899681504781, 7544.811379715503, 7770.766876993699, 7772.727954521592, 7775.961120194405, 7719.150893401721, 7860.803479912991, 7867.0, 7867.488613240135, 7868.213178682129, 1889.4048374761906, 1937.7771556270998, 2235.2065016919005, 2264.6829443877828, 2293.266154830455, 2309.5265470578493, 2331.813454923602, 2334.323046316566, 2335.4978679583887, 2336.5910965581043, 2277.87471689057, 2289.05004423165, 2311.0640190722784, 2311.15642790382, 2311.445253139243, 1874.587590730044, 2047.9795202048012, 2136.0708091980036, 2192.0355043780687, 2199.549092436047, 2240.9327720168258, 2264.1622599638076, 2264.8980795864227, 2268.2288022072576, 2268.500929795459, 7602.0877494700435, 7729.381649468029, 7731.381489480828, 7738.7678369649, 7749.186335434754, 4630.166570017395, 4783.067301876135, 4783.258594917758, 4801.111794318027, 4803.471618122004, 3056.19010962093, 3059.1587313488744, 3111.859966301522, 3137.8744850206194, 3140.7173354398215, 925.8287216864901, 932.4125800745487, 935.4761333653177, 954.88063992001, 957.0525180071749, 10540.999999999924, 10543.051125398752, 10560.94719526405, 10576.52405641748, 10580.78838423235, 4417.2269852775635, 4426.800793964279, 4459.0, 4518.164139634178, 4519.502854685982, 9001.639934402681, 9064.093590640883, 9079.137481939206, 9085.409448385833, 9085.863712044325, 4808.519148085234, 4821.614270858323, 4825.758712064383, 4845.53967373099, 4858.902821943541, 3775.169462718198, 4295.613394794484, 4439.822407103744, 4443.955560444419, 4462.486814016364, 3699.79651119191, 3754.4931434256027, 3809.904752381213, 3835.884923452301, 3881.8059097045034, 1254.711416374239, 1259.8614152443224, 1261.6467389131058, 1269.6698858296909, 1276.7510335484676, 792.0297635396709, 837.417994493821, 868.4268382867277, 881.5107615273585, 898.2993265253114, 5272.420033796279, 5375.3280839895015, 5401.783928642811, 5447.5641948644015, 5520.006398848246, 434.2617550164733, 436.3846975764157, 436.7314101827353, 918.6738707758783, 925.7596616188839, 3523.242502861897, 3586.5337506124038, 3675.467057276733, 3682.834272457746, 3685.0971511979737, 9312.906870931203, 9616.23070154386, 9763.414195148314, 9775.51122443875, 9801.509924503745, 9674.903250967542, 9687.66093186735, 9701.805963880683, 9704.805903881883, 9718.465484398284, 7268.200497945222, 7460.179380268166, 7461.1419686735635, 7464.514806537558, 7477.7008919643695, 5486.286782718381, 5497.780088796563, 5517.282753242052, 5578.748956296895, 5649.0, 8784.648614055366, 8785.297176226015, 8828.337874659555, 8840.823183536422, 8891.822163556822, 8763.079876612865, 8819.691310804092, 8943.821123577622, 9076.455412675261, 9083.863742043743, 5965.970170149121, 6799.11611490503, 6889.483288753263, 7034.2965703429245, 7069.116360454943, 7585.355244804254, 7622.847543049219, 7676.846463070819, 7701.383889288732, 7709.4603377763015, 6673.232578253563, 6854.691538880663, 6884.0, 6911.0, 7042.859142817218, 6617.503687223574, 6675.0654908313845, 6838.5213035089055, 6883.827904302432, 6943.132108486439, 6283.5601507895835, 6321.683915804283, 6387.361263873576, 6398.71205795731, 6399.200099987502, 4514.074614703912, 4522.5929666330185, 4574.0, 4594.862154135381, 4627.444706635225, 4873.9025219496125, 4874.926876096933, 4887.0, 4979.751012449436, 5031.798728050837], "value": 4186.42195412993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6092384519349, 319.2752451934109, 326.3179953896357, 326.41082845463944, 328.5121594432269, 4587.655925805561, 4694.577488026077, 4926.11329960607, 4984.401871775383, 4987.650864439491, 4884.267359896008, 4894.216925291954, 4958.0579689858905, 4980.078685443195, 5006.849794506162, 3946.2304850554083, 3958.1396743530495, 3962.742421742592, 3966.8809935701975, 3979.621935916083, 3711.42472916697, 3804.1440675847853, 3958.5051868516434, 3965.3655415133585, 3968.5634580196156, 3945.644891959723, 3948.1708841143395, 3952.407138929155, 3960.7623542587394, 3965.5241371035518, 3910.335243008695, 3911.471951286568, 3929.7052721046034, 3938.7833669148185, 3940.290747665419, 3511.262634846685, 3514.3147086318177, 3514.3498452786316, 3517.384457719889, 3521.418965870628, 4513.7517436540975, 4744.122337367598, 4751.71489710615, 4772.928406073912, 4797.688150270221, 4399.604035636776, 4412.24991751403, 4437.778111094464, 4446.577575130357, 4459.487158976727, 5248.6588371755715, 5250.7112108834, 5251.264822924793, 5256.106461901486, 5259.316288882459, 3621.076625460517, 3695.427208782616, 3704.203596226824, 3722.3485889969147, 3728.9627103728885, 5202.609804264695, 5247.34408198979, 5424.430434804328, 5436.510714035716, 5451.427600101972, 3811.3901775715754, 3814.6185381461632, 3831.904202394907, 3837.002379381381, 3837.0791010157363, 3860.8262628181237, 3864.7874366909527, 3870.825812838429, 3878.2243551289853, 3882.378819388884, 4410.0, 4413.249747542925, 4415.315626077963, 4416.1609294233995, 4429.734215947054, 5023.874403139951, 5189.299444574934, 5193.584513238932, 5193.766280517386, 5197.194434862602, 1314.7830607949581, 1336.251699048536, 1338.919664820114, 1342.06726325205, 1346.4344975110478, 883.6862913665685, 902.9953503222835, 915.2494954137543, 923.4274749655257, 924.2236521322121, 4604.332371806069, 4633.397658304399, 4634.884127896829, 4634.999999999933, 4636.953630463652, 5377.085895397791, 5388.407275199725, 5395.973020134953, 5405.405405405402, 5406.864828379244, 4411.889702757392, 4632.69887457321, 4632.97683511587, 4652.906941861212, 4661.137689527448, 2881.5965764792945, 2890.5375139977505, 2901.302737898311, 2902.2889392099073, 2903.0419961413104, 5190.688558686491, 5200.5059519345605, 5201.895962080737, 5210.687358758487, 5210.713410762444, 5335.279737235501, 5563.749631266522, 5568.331800184003, 5578.442155784389, 5585.972070139705, 5163.896722065613, 5165.767540460688, 5183.870403239949, 5187.507186817246, 5193.350831146106, 5423.0, 5428.56571474289, 5447.400785913625, 5452.0, 5459.918101228564, 5069.7718602662235, 5329.600279978939, 5337.519623233928, 5353.143497040455, 5365.409804921377, 4930.852074437773, 5049.697018178921, 5204.2193670948145, 5218.608604354613, 5242.318498595158, 3802.980985095057, 3803.2203398303836, 3815.904602384963, 3815.980920095382, 3820.331441997695, 5475.06923822959, 5476.726163691879, 5481.3970463248215, 5483.698396588066, 5489.149181876655, 5005.974970125126, 5196.896062078662, 5229.555487783581, 5257.237700533325, 5264.394594621667, 5177.663451875616, 5181.145111056633, 5190.740462976912, 5191.506806853494, 5203.531682148625, 5120.129577971679, 5130.0, 5130.743462826769, 5150.613703972292, 5152.433232344514, 5062.367204099488, 5239.44985776488, 5240.71176085319, 5248.7665398630525, 5253.579713622978, 5083.38999320084, 5093.592512598909, 5096.923546146737, 5113.207452844815, 5116.897662046664], "value": 3958.7128315687883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.9400847932166, 762.2606072110051, 762.3786613909663, 768.9760658670505, 772.8492943875947, 12001.579944701938, 12344.691382715437, 12385.876141238585, 12394.132410731252, 12395.6901077473, 12886.420111095, 12940.741185176314, 12977.0, 12985.74028519429, 13042.087053906207, 635.698043429372, 785.8231897823001, 802.5224991130283, 814.0516298512226, 814.4665244265016, 801.6753214947926, 805.2229598437507, 808.2442915873647, 808.5957021489255, 808.8503626829026, 859.6260626627405, 865.3380164174412, 865.6277800545763, 866.0603245478663, 866.0906048648925, 664.4983037806426, 833.829065041665, 857.6655104509247, 861.0313397427893, 861.7414775567336, 624.2415465209792, 624.4848000399688, 625.4808508937571, 625.987480250397, 626.5301024231826, 12853.16454430459, 12878.034147438886, 12879.227246365248, 12912.289824059673, 12921.353932303347, 12683.365831708377, 13260.270685112315, 13307.334633268298, 13327.866721332759, 13758.93120534401, 10106.696799096038, 10408.843867341995, 10585.311954722918, 10823.350598964087, 10852.620158294421, 3345.5985281766343, 3389.881354152593, 3417.7436692247934, 3430.77699949505, 3439.7076248518906, 49782.50217497851, 49874.501254987714, 50303.74848125736, 50435.0, 50677.23984140241, 9533.332666713264, 9660.227181825438, 9864.457454840052, 9886.950565247127, 9946.403215807075, 16819.990800552005, 16864.915675421544, 16950.0, 17013.659726805396, 17019.149042547822, 6658.667066646648, 6674.299198584175, 6758.121444212221, 6759.0, 6882.965585172042, 3649.671529562352, 3736.75711078779, 3750.2748735581395, 3773.6226377362595, 3800.486934263839, 2733.439644872796, 2814.5637426198973, 2821.7601503871992, 2824.2939265183704, 2831.320483084045, 445.44319600499375, 514.3596222702685, 529.1454301303368, 536.6779932040822, 537.2290762755381, 499.0268975497794, 575.3757173466752, 583.9678817665069, 624.6002558362652, 640.1422094393535, 7411.777646670501, 7448.255174482509, 7520.435967302475, 7585.6965721370525, 7780.377569794403, 567.4750855458767, 597.3548567547039, 598.2223109957039, 601.2034054877305, 603.405645439242, 3684.244729830378, 3693.8891833245048, 3764.5106136202116, 3862.7102967277565, 3907.1208977979727, 54427.0, 56622.43377566172, 56679.71660141755, 56737.0, 57863.0, 49326.26010609844, 49577.50422495801, 49638.0, 50053.0, 50681.746591266805, 44608.55391446044, 45329.54670453319, 45801.0, 46282.84292892637, 46590.5340946593, 7380.1512826023545, 7489.66296516669, 7696.923030769621, 7789.493682910593, 8053.436259461781, 26020.73979260183, 26233.73766262313, 27227.59158612662, 27489.31276718018, 27509.86245068762, 29269.707302926698, 34426.65573344234, 36283.637163628024, 36354.636453635125, 37442.62557374391, 10395.532201051123, 10405.323653962469, 10470.790584188426, 10815.621453249098, 10998.395088270221, 12183.512659493521, 12296.139270250997, 12340.938295308466, 12615.432305546088, 12999.350032498149, 11014.118870490502, 11072.335659860435, 11486.425678716198, 11647.359395233343, 12009.75980480368, 10788.676339709822, 10882.836757448486, 10989.725256868642, 10993.945030274797, 11435.0, 11148.331100134017, 11416.657500275005, 11434.542618295174, 11779.587714429954, 11830.822537662114, 9692.545079572998, 9795.9020409795, 10037.69886903394, 10054.19566434698, 10120.392776433437, 9819.0, 9980.301378903407, 10098.293119481566, 10098.385369143503, 10100.062851043074], "value": 6010.512022200737, "unit": "score"}], "name": "dromaeo_css", "value": 6338.689820046241, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 107.0, 111.0, 112.0, 113.0, 101.0, 111.0, 111.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 158.0, 186.0, 134.0, 160.0, 161.0, 140.0, 196.0, 139.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 163.0, 162.0, 163.0, 162.0, 161.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 106.0, 112.0, 75.0, 76.0, 73.0, 118.0, 110.0, 73.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 147.0, 94.0, 94.0, 93.0, 139.0, 93.0, 94.0, 148.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 147.0, 148.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 80.0, 61.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 78.0, 78.0, 79.0, 78.0, 80.0, 79.0, 79.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 136.0, 132.0, 129.0, 130.0, 130.0, 130.0, 163.0, 133.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 174.0, 175.0, 170.0, 175.0, 171.0, 171.0, 176.0, 172.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 73.0, 71.0, 71.0, 73.0, 72.0, 71.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1572.3999999999999, "alertThreshold": 2.0}]} 16:12:05 INFO - Return code: 0 16:12:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:12:05 ERROR - # TBPL SUCCESS # 16:12:05 INFO - Running post-action listener: _resource_record_post_action 16:12:05 INFO - Running post-run listener: _resource_record_post_run 16:12:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517591040; Read time: 8; Write time: 443212 16:12:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234369024; Read time: 0; Write time: 269748 16:12:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283222016; Read time: 8; Write time: 173464 16:12:06 INFO - Running post-run listener: _upload_blobber_files 16:12:06 INFO - Blob upload gear active. 16:12:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:06 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 16:12:06 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'] 16:12:06 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 16:12:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:07 INFO - (blobuploader) - INFO - Done attempting. 16:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:08 INFO - (blobuploader) - INFO - Done attempting. 16:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:08 INFO - Return code: 0 16:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c43a9c5e522b7d2268c864b87d9ca34f5715f913d16a139b050a2b8b52cddc28647ebe4c87672ba19d03854b31c33b844351abbc0493815bb75916ddb557c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116359a28e70179ddc8810cee83cf0b0f2f99348629acdc971556253437529d7f5bd92728bd64d12f0699359c0d93de867e23e70c5e213dba3532d7e77609dfe"} 16:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:08 INFO - Contents: 16:12:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c43a9c5e522b7d2268c864b87d9ca34f5715f913d16a139b050a2b8b52cddc28647ebe4c87672ba19d03854b31c33b844351abbc0493815bb75916ddb557c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116359a28e70179ddc8810cee83cf0b0f2f99348629acdc971556253437529d7f5bd92728bd64d12f0699359c0d93de867e23e70c5e213dba3532d7e77609dfe"} 16:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:08 INFO - Copying logs to upload dir... 16:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.410952 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-19 16:12:08.453727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 16:12:08.457560) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803 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/8c43a9c5e522b7d2268c864b87d9ca34f5715f913d16a139b050a2b8b52cddc28647ebe4c87672ba19d03854b31c33b844351abbc0493815bb75916ddb557c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116359a28e70179ddc8810cee83cf0b0f2f99348629acdc971556253437529d7f5bd92728bd64d12f0699359c0d93de867e23e70c5e213dba3532d7e77609dfe"} build_url:https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/LYnrts4SRK2PpxxFhS-iqg/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/8c43a9c5e522b7d2268c864b87d9ca34f5715f913d16a139b050a2b8b52cddc28647ebe4c87672ba19d03854b31c33b844351abbc0493815bb75916ddb557c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116359a28e70179ddc8810cee83cf0b0f2f99348629acdc971556253437529d7f5bd92728bd64d12f0699359c0d93de867e23e70c5e213dba3532d7e77609dfe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 16:12:08.482585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 16:12:08.482908) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461104246.355190-232701803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 16:12:08.565928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 16:12:08.566266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 16:12:08.566583) ========= ========= Total master_lag: 0.17 =========