builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1461845753.39 results: success (0) buildid: 20160428023628 builduid: 1206159eb0c84c32b3f0a11aa250b022 revision: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:53.388085) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:53.388929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-28 05:15:53.389224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-28 05:15:55.033592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:55.033878) ========= 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=af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 05:15:55-- 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% 145M=0s 2016-04-28 05:15:55 (145 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.538730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:55.585545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:55.585885) ========= 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=af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:55.635976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-28 05:15:55.636541) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 14952428292c90aa00c28fdfb1f1e79bd8257ce2 --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 14952428292c90aa00c28fdfb1f1e79bd8257ce2 --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=af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 05:15:55,764 truncating revision to first 12 chars 2016-04-28 05:15:55,764 Setting DEBUG logging. 2016-04-28 05:15:55,764 attempt 1/10 2016-04-28 05:15:55,764 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/14952428292c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 05:15:58,589 unpacking tar archive at: fx-team-14952428292c/testing/mozharness/ program finished with exit code 0 elapsedTime=3.107831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-28 05:15:58.757684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:58.757992) ========= script_repo_revision: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:58.758376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:58.758652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:15:58.768536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-28 05:15:58.768857) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:58 INFO - MultiFileLogger online at 20160428 05:15:58 in /builds/slave/test 05:15:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:15:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:58 INFO - {'append_to_log': False, 05:15:58 INFO - 'base_work_dir': '/builds/slave/test', 05:15:58 INFO - 'blob_upload_branch': 'Fx-Team', 05:15:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:58 INFO - 'branch': 'Fx-Team', 05:15:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:58 INFO - 'config_files': ('talos/linux_config.py',), 05:15:58 INFO - 'default_actions': ('clobber', 05:15:58 INFO - 'read-buildbot-config', 05:15:58 INFO - 'download-and-extract', 05:15:58 INFO - 'populate-webroot', 05:15:58 INFO - 'create-virtualenv', 05:15:58 INFO - 'install', 05:15:58 INFO - 'run-tests'), 05:15:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:58 INFO - 'download_minidump_stackwalk': True, 05:15:58 INFO - 'download_symbols': 'ondemand', 05:15:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:58 INFO - 'installer_path': 'installer.exe', 05:15:58 INFO - 'log_level': 'info', 05:15:58 INFO - 'log_name': 'talos', 05:15:58 INFO - 'log_to_console': True, 05:15:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:58 INFO - 'opt_config_files': (), 05:15:58 INFO - 'pip_index': False, 05:15:58 INFO - 'sps_profile': False, 05:15:58 INFO - 'sps_profile_interval': 0, 05:15:58 INFO - 'suite': 'dromaeojs', 05:15:58 INFO - 'system_bits': '32', 05:15:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:58 INFO - 'title': 'talos-linux64-ix-020', 05:15:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:58 INFO - 'use_talos_json': True, 05:15:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:58 INFO - 'work_dir': 'build'} 05:15:58 INFO - ##### 05:15:58 INFO - ##### Running clobber step. 05:15:58 INFO - ##### 05:15:58 INFO - Running pre-action listener: _resource_record_pre_action 05:15:58 INFO - Running main action method: clobber 05:15:58 INFO - rmtree: /builds/slave/test/build 05:15:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:59 INFO - Running post-action listener: _resource_record_post_action 05:15:59 INFO - ##### 05:15:59 INFO - ##### Running read-buildbot-config step. 05:15:59 INFO - ##### 05:15:59 INFO - Running pre-action listener: _resource_record_pre_action 05:15:59 INFO - Running main action method: read_buildbot_config 05:15:59 INFO - Using buildbot properties: 05:15:59 INFO - { 05:15:59 INFO - "project": "", 05:15:59 INFO - "product": "firefox", 05:15:59 INFO - "script_repo_revision": "production", 05:15:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:15:59 INFO - "repository": "", 05:15:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:15:59 INFO - "buildid": "20160428023628", 05:15:59 INFO - "pgo_build": "True", 05:15:59 INFO - "basedir": "/builds/slave/test", 05:15:59 INFO - "buildnumber": 1118, 05:15:59 INFO - "slavename": "talos-linux64-ix-020", 05:15:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:59 INFO - "platform": "ubuntu64_hw", 05:15:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:15:59 INFO - "branch": "fx-team", 05:15:59 INFO - "repo_path": "integration/fx-team", 05:15:59 INFO - "revision": "14952428292c90aa00c28fdfb1f1e79bd8257ce2", 05:15:59 INFO - "stage_platform": "linux64-pgo", 05:15:59 INFO - "builduid": "1206159eb0c84c32b3f0a11aa250b022", 05:15:59 INFO - "slavebuilddir": "test" 05:15:59 INFO - } 05:15:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:15:59 INFO - Running post-action listener: _resource_record_post_action 05:15:59 INFO - ##### 05:15:59 INFO - ##### Running download-and-extract step. 05:15:59 INFO - ##### 05:15:59 INFO - Running pre-action listener: _resource_record_pre_action 05:15:59 INFO - Running main action method: download_and_extract 05:15:59 INFO - mkdir: /builds/slave/test/build/tests 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:02 INFO - Downloaded 1361 bytes. 05:16:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:16:02 INFO - Using the following test package requirements: 05:16:02 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'jsshell-linux-x86_64.zip'], 05:16:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:02 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:02 INFO - https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:23 INFO - Downloaded 23860887 bytes. 05:16:23 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'] 05:16:23 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 05:16:24 INFO - Return code: 0 05:16:24 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 05:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:24 INFO - https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:32 INFO - Downloaded 23860887 bytes. 05:16:32 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'] 05:16:32 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 05:16:33 INFO - Return code: 0 05:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:33 INFO - https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:36 INFO - Downloaded 10840145 bytes. 05:16:36 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'] 05:16:36 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 05:16:36 INFO - Return code: 0 05:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:36 INFO - https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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 05:16:43 INFO - Downloaded 58342743 bytes. 05:16:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:43 INFO - mkdir: /builds/slave/test/properties 05:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:43 INFO - Contents: 05:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - Running post-action listener: set_extra_try_arguments 05:16:44 INFO - ##### 05:16:44 INFO - ##### Running populate-webroot step. 05:16:44 INFO - ##### 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: populate_webroot 05:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:44 INFO - '--tppagecycles', 05:16:44 INFO - '7'], 05:16:44 INFO - 'tests': ['tsvgm']}}, 05:16:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['damp', 'tps']}, 05:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['damp', 'tps']}, 05:16:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['dromaeo_dom']}, 05:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tsvgx', 05:16:44 INFO - 'tsvgr_opacity', 05:16:44 INFO - 'tart', 05:16:44 INFO - 'tscrollx', 05:16:44 INFO - 'cart']}, 05:16:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:44 INFO - 'tsvgr_opacity', 05:16:44 INFO - 'tart', 05:16:44 INFO - 'tscrollx', 05:16:44 INFO - 'cart']}, 05:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tp5o']}, 05:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['tp5o']}, 05:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s', 05:16:44 INFO - '--xperf_path', 05:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:44 INFO - 'tests': ['tp5n']}, 05:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--xperf_path', 05:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:44 INFO - 'tests': ['tp5n']}}, 05:16:44 INFO - 'talos.zip': {'path': '', 05:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - ##### 05:16:44 INFO - ##### Running create-virtualenv step. 05:16:44 INFO - ##### 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: create_virtualenv 05:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:44 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 05:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:44 INFO - Using real prefix '/usr' 05:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:47 INFO - Installing pip.................done. 05:16:47 INFO - Return code: 0 05:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:16: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', 'pip>=1.5'] in /builds/slave/test/build 05:16: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 pip>=1.5 05:16:47 INFO - Using env: {'DISPLAY': ':0', 05:16:47 INFO - 'HOME': '/home/cltbld', 05:16:47 INFO - 'LANG': 'en_US.UTF-8', 05:16:47 INFO - 'LANGUAGE': 'en_US:en', 05:16:47 INFO - 'LOGNAME': 'cltbld', 05:16:47 INFO - 'MAIL': '/var/mail/cltbld', 05:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:47 INFO - 'MOZ_NO_REMOTE': '1', 05:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:47 INFO - 'NO_EM_RESTART': '1', 05:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:47 INFO - 'PWD': '/builds/slave/test', 05:16:47 INFO - 'SHELL': '/bin/bash', 05:16:47 INFO - 'SHLVL': '1', 05:16:47 INFO - 'TERM': 'linux', 05:16:47 INFO - 'TMOUT': '86400', 05:16:47 INFO - 'USER': 'cltbld', 05:16:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:47 INFO - '_': '/tools/buildbot/bin/python'} 05:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:47 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 05:16:47 INFO - Cleaning up... 05:16:47 INFO - Return code: 0 05:16:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', '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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:16: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16: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 psutil>=0.7.1 05:16:47 INFO - Using env: {'DISPLAY': ':0', 05:16:47 INFO - 'HOME': '/home/cltbld', 05:16:47 INFO - 'LANG': 'en_US.UTF-8', 05:16:47 INFO - 'LANGUAGE': 'en_US:en', 05:16:47 INFO - 'LOGNAME': 'cltbld', 05:16:47 INFO - 'MAIL': '/var/mail/cltbld', 05:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:47 INFO - 'MOZ_NO_REMOTE': '1', 05:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:47 INFO - 'NO_EM_RESTART': '1', 05:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:47 INFO - 'PWD': '/builds/slave/test', 05:16:47 INFO - 'SHELL': '/bin/bash', 05:16:47 INFO - 'SHLVL': '1', 05:16:47 INFO - 'TERM': 'linux', 05:16:47 INFO - 'TMOUT': '86400', 05:16:47 INFO - 'USER': 'cltbld', 05:16:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:47 INFO - '_': '/tools/buildbot/bin/python'} 05:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:47 INFO - Downloading/unpacking psutil>=0.7.1 05:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:50 INFO - Installing collected packages: psutil 05:16:50 INFO - Running setup.py install for psutil 05:16:50 INFO - building 'psutil._psutil_linux' extension 05:16:50 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 05:16:50 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 05:16:50 INFO - building 'psutil._psutil_posix' extension 05:16:50 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 05:16:50 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 05:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:50 INFO - Successfully installed psutil 05:16:50 INFO - Cleaning up... 05:16:50 INFO - Return code: 0 05:16:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', '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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:16: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:16: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 mozsystemmonitor==0.0.0 05:16:50 INFO - Using env: {'DISPLAY': ':0', 05:16:50 INFO - 'HOME': '/home/cltbld', 05:16:50 INFO - 'LANG': 'en_US.UTF-8', 05:16:50 INFO - 'LANGUAGE': 'en_US:en', 05:16:50 INFO - 'LOGNAME': 'cltbld', 05:16:50 INFO - 'MAIL': '/var/mail/cltbld', 05:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:50 INFO - 'MOZ_NO_REMOTE': '1', 05:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:50 INFO - 'NO_EM_RESTART': '1', 05:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:50 INFO - 'PWD': '/builds/slave/test', 05:16:50 INFO - 'SHELL': '/bin/bash', 05:16:50 INFO - 'SHLVL': '1', 05:16:50 INFO - 'TERM': 'linux', 05:16:50 INFO - 'TMOUT': '86400', 05:16:50 INFO - 'USER': 'cltbld', 05:16:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:50 INFO - '_': '/tools/buildbot/bin/python'} 05:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:53 INFO - Installing collected packages: mozsystemmonitor 05:16:53 INFO - Running setup.py install for mozsystemmonitor 05:16:53 INFO - Successfully installed mozsystemmonitor 05:16:53 INFO - Cleaning up... 05:16:53 INFO - Return code: 0 05:16:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:53 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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:16:53 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 05:16:53 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 05:16:53 INFO - Using env: {'DISPLAY': ':0', 05:16:53 INFO - 'HOME': '/home/cltbld', 05:16:53 INFO - 'LANG': 'en_US.UTF-8', 05:16:53 INFO - 'LANGUAGE': 'en_US:en', 05:16:53 INFO - 'LOGNAME': 'cltbld', 05:16:53 INFO - 'MAIL': '/var/mail/cltbld', 05:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:53 INFO - 'MOZ_NO_REMOTE': '1', 05:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:53 INFO - 'NO_EM_RESTART': '1', 05:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:53 INFO - 'PWD': '/builds/slave/test', 05:16:53 INFO - 'SHELL': '/bin/bash', 05:16:53 INFO - 'SHLVL': '1', 05:16:53 INFO - 'TERM': 'linux', 05:16:53 INFO - 'TMOUT': '86400', 05:16:53 INFO - 'USER': 'cltbld', 05:16:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:53 INFO - '_': '/tools/buildbot/bin/python'} 05:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:56 INFO - Downloading docopt-0.6.1.tar.gz 05:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:56 INFO - Running setup.py install for blobuploader 05:16:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:56 INFO - Running setup.py install for requests 05:16:57 INFO - Running setup.py install for docopt 05:16:57 INFO - Successfully installed blobuploader requests docopt 05:16:57 INFO - Cleaning up... 05:16:57 INFO - Return code: 0 05:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:57 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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:16:57 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 05:16:57 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 05:16:57 INFO - Using env: {'DISPLAY': ':0', 05:16:57 INFO - 'HOME': '/home/cltbld', 05:16:57 INFO - 'LANG': 'en_US.UTF-8', 05:16:57 INFO - 'LANGUAGE': 'en_US:en', 05:16:57 INFO - 'LOGNAME': 'cltbld', 05:16:57 INFO - 'MAIL': '/var/mail/cltbld', 05:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:57 INFO - 'MOZ_NO_REMOTE': '1', 05:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:57 INFO - 'NO_EM_RESTART': '1', 05:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:57 INFO - 'PWD': '/builds/slave/test', 05:16:57 INFO - 'SHELL': '/bin/bash', 05:16:57 INFO - 'SHLVL': '1', 05:16:57 INFO - 'TERM': 'linux', 05:16:57 INFO - 'TMOUT': '86400', 05:16:57 INFO - 'USER': 'cltbld', 05:16:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:57 INFO - '_': '/tools/buildbot/bin/python'} 05:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:57 INFO - Running setup.py (path:/tmp/pip-fM0oKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:57 INFO - Running setup.py (path:/tmp/pip-dKrON6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:57 INFO - Running setup.py (path:/tmp/pip-MQLa2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:57 INFO - Running setup.py (path:/tmp/pip-SngWA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:57 INFO - Running setup.py (path:/tmp/pip-jyPPDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:57 INFO - Running setup.py (path:/tmp/pip-HCDbmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:58 INFO - Running setup.py (path:/tmp/pip-bM26vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:58 INFO - Running setup.py (path:/tmp/pip-XFJiK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:58 INFO - Running setup.py (path:/tmp/pip-oy_VFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:58 INFO - Running setup.py (path:/tmp/pip-3CNIlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:58 INFO - Running setup.py (path:/tmp/pip-4d24dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:58 INFO - Running setup.py (path:/tmp/pip-CzA1J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:58 INFO - Running setup.py (path:/tmp/pip-Dz0lJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:58 INFO - Running setup.py (path:/tmp/pip-grqkAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:58 INFO - Running setup.py (path:/tmp/pip-9uO_t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:58 INFO - Running setup.py (path:/tmp/pip-vaTBtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:58 INFO - Running setup.py (path:/tmp/pip-SFT7IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:58 INFO - Running setup.py install for manifestparser 05:16:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozcrash 05:16:58 INFO - Running setup.py install for mozdebug 05:16:59 INFO - Running setup.py install for mozdevice 05:16:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Running setup.py install for mozfile 05:16:59 INFO - Running setup.py install for mozhttpd 05:16:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Running setup.py install for mozinfo 05:16:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Running setup.py install for mozInstall 05:16:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Running setup.py install for mozleak 05:16:59 INFO - Running setup.py install for mozlog 05:16:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Running setup.py install for moznetwork 05:16:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Running setup.py install for mozprocess 05:17:00 INFO - Running setup.py install for mozprofile 05:17:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:00 INFO - Running setup.py install for mozrunner 05:17:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:00 INFO - Running setup.py install for mozscreenshot 05:17:00 INFO - Running setup.py install for moztest 05:17:00 INFO - Running setup.py install for mozversion 05:17:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:00 INFO - Cleaning up... 05:17:00 INFO - Return code: 0 05:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:17:00 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 05:17:00 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 05:17:00 INFO - Using env: {'DISPLAY': ':0', 05:17:00 INFO - 'HOME': '/home/cltbld', 05:17:00 INFO - 'LANG': 'en_US.UTF-8', 05:17:00 INFO - 'LANGUAGE': 'en_US:en', 05:17:00 INFO - 'LOGNAME': 'cltbld', 05:17:00 INFO - 'MAIL': '/var/mail/cltbld', 05:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:00 INFO - 'MOZ_NO_REMOTE': '1', 05:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:00 INFO - 'NO_EM_RESTART': '1', 05:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:00 INFO - 'PWD': '/builds/slave/test', 05:17:00 INFO - 'SHELL': '/bin/bash', 05:17:00 INFO - 'SHLVL': '1', 05:17:00 INFO - 'TERM': 'linux', 05:17:00 INFO - 'TMOUT': '86400', 05:17:00 INFO - 'USER': 'cltbld', 05:17:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:00 INFO - '_': '/tools/buildbot/bin/python'} 05:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:00 INFO - Running setup.py (path:/tmp/pip-p8zZi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:00 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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:00 INFO - Running setup.py (path:/tmp/pip-gFXmYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:00 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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:00 INFO - Running setup.py (path:/tmp/pip-MVRnY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:01 INFO - Running setup.py (path:/tmp/pip-c0PoRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:01 INFO - Running setup.py (path:/tmp/pip-M7DCHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:01 INFO - Running setup.py (path:/tmp/pip-oN8f30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:01 INFO - Running setup.py (path:/tmp/pip-kzcEnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:01 INFO - Running setup.py (path:/tmp/pip-HyAIix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:01 INFO - Running setup.py (path:/tmp/pip-vJwnW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:01 INFO - Running setup.py (path:/tmp/pip-sShgnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:01 INFO - Running setup.py (path:/tmp/pip-nh7om6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:01 INFO - Running setup.py (path:/tmp/pip-BR2UTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:01 INFO - Running setup.py (path:/tmp/pip-zEcPUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:01 INFO - Running setup.py (path:/tmp/pip-YO0DF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:01 INFO - Running setup.py (path:/tmp/pip-I3pSkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:01 INFO - Running setup.py (path:/tmp/pip-TgoFvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:01 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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:01 INFO - Running setup.py (path:/tmp/pip-qs5uaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:02 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)) 05:17:02 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)) 05:17:02 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)) 05:17:02 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)) 05:17:02 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)) 05:17:02 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)) 05:17:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:04 INFO - Downloading blessings-1.6.tar.gz 05:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:04 INFO - Installing collected packages: blessings 05:17:04 INFO - Running setup.py install for blessings 05:17:04 INFO - Successfully installed blessings 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:04 INFO - Reading from file tmpfile_stdout 05:17:04 INFO - Current package versions: 05:17:04 INFO - argparse == 1.2.1 05:17:04 INFO - blessings == 1.6 05:17:04 INFO - blobuploader == 1.2.4 05:17:04 INFO - docopt == 0.6.1 05:17:04 INFO - manifestparser == 1.1 05:17:04 INFO - mozInstall == 1.12 05:17:04 INFO - mozcrash == 0.17 05:17:04 INFO - mozdebug == 0.1 05:17:04 INFO - mozdevice == 0.48 05:17:04 INFO - mozfile == 1.2 05:17:04 INFO - mozhttpd == 0.7 05:17:04 INFO - mozinfo == 0.9 05:17:04 INFO - mozleak == 0.1 05:17:04 INFO - mozlog == 3.1 05:17:04 INFO - moznetwork == 0.27 05:17:04 INFO - mozprocess == 0.22 05:17:04 INFO - mozprofile == 0.28 05:17:04 INFO - mozrunner == 6.11 05:17:04 INFO - mozscreenshot == 0.1 05:17:04 INFO - mozsystemmonitor == 0.0 05:17:04 INFO - moztest == 0.7 05:17:04 INFO - mozversion == 1.4 05:17:04 INFO - psutil == 3.1.1 05:17:04 INFO - requests == 1.2.3 05:17:04 INFO - wsgiref == 0.1.2 05:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:04 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')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:17:04 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 05:17:04 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 05:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 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)) 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:04 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')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:17:04 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 05:17:04 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 05:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:05 INFO - Downloading/unpacking jsonschema 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17:07 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 05:17:07 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 05:17:07 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 05:17:07 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 05:17:07 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 05:17:07 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 05:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:07 INFO - warning: no files found matching '*.txt' 05:17:07 INFO - no previously-included directories found matching 'build' 05:17:07 INFO - no previously-included directories found matching 'dist' 05:17:07 INFO - no previously-included directories found matching '.git*' 05:17:07 INFO - Installing collected packages: jsonschema, functools32 05:17:07 INFO - Running setup.py install for functools32 05:17:07 INFO - warning: no files found matching '*.txt' 05:17:07 INFO - no previously-included directories found matching 'build' 05:17:07 INFO - no previously-included directories found matching 'dist' 05:17:07 INFO - no previously-included directories found matching '.git*' 05:17:07 INFO - Successfully installed jsonschema functools32 05:17:07 INFO - Cleaning up... 05:17:07 INFO - Return code: 0 05:17:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 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 0x7ff49b90af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', '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 05:17:07 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 05:17:07 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 05:17:07 INFO - Using env: {'DISPLAY': ':0', 05:17:07 INFO - 'HOME': '/home/cltbld', 05:17:07 INFO - 'LANG': 'en_US.UTF-8', 05:17:07 INFO - 'LANGUAGE': 'en_US:en', 05:17:07 INFO - 'LOGNAME': 'cltbld', 05:17:07 INFO - 'MAIL': '/var/mail/cltbld', 05:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:07 INFO - 'MOZ_NO_REMOTE': '1', 05:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:07 INFO - 'NO_EM_RESTART': '1', 05:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:07 INFO - 'PWD': '/builds/slave/test', 05:17:07 INFO - 'SHELL': '/bin/bash', 05:17:07 INFO - 'SHLVL': '1', 05:17:07 INFO - 'TERM': 'linux', 05:17:07 INFO - 'TMOUT': '86400', 05:17:07 INFO - 'USER': 'cltbld', 05:17:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:07 INFO - '_': '/tools/buildbot/bin/python'} 05:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:08 INFO - Downloading/unpacking flake8 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:10 INFO - no previously-included directories found matching 'docs/_build' 05:17:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:10 INFO - Running setup.py install for pep8 05:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:12 INFO - no previously-included directories found matching 'docs/_build' 05:17:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Running post-action listener: _resource_record_post_action 05:17:12 INFO - Running post-action listener: _start_resource_monitoring 05:17:12 INFO - Starting resource monitoring. 05:17:12 INFO - ##### 05:17:12 INFO - ##### Running install step. 05:17:12 INFO - ##### 05:17:12 INFO - Running pre-action listener: _resource_record_pre_action 05:17:12 INFO - Running main action method: install 05:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Output received: 05:17:12 INFO - Usage: mozinstall [options] installer 05:17:12 INFO - Options: 05:17:12 INFO - -h, --help show this help message and exit 05:17:12 INFO - -d DEST, --destination=DEST 05:17:12 INFO - Directory to install application into. [default: 05:17:12 INFO - "/builds/slave/test"] 05:17:12 INFO - --app=APP Application being installed. [default: firefox] 05:17:12 INFO - mkdir: /builds/slave/test/build/application 05:17:12 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'] 05:17:12 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 05:17:29 INFO - Reading from file tmpfile_stdout 05:17:29 INFO - Output received: 05:17:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:29 INFO - Running post-action listener: _resource_record_post_action 05:17:29 INFO - ##### 05:17:29 INFO - ##### Running run-tests step. 05:17:29 INFO - ##### 05:17:29 INFO - Running pre-action listener: _resource_record_pre_action 05:17:29 INFO - Running main action method: run_tests 05:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:29 INFO - Python 2.7.3 05:17:29 INFO - Return code: 0 05:17:29 INFO - grabbing minidump binary from tooltool 05:17:29 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')]} 05:17:29 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 0x1cf9810>, '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 0x1cfa710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:29 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 05:17:29 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 05:17:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:29 INFO - Return code: 0 05:17:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:30 INFO - Return code: 0 05:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 05:17:30 INFO - Using env: {'DISPLAY': ':0', 05:17:30 INFO - 'HOME': '/home/cltbld', 05:17:30 INFO - 'LANG': 'en_US.UTF-8', 05:17:30 INFO - 'LANGUAGE': 'en_US:en', 05:17:30 INFO - 'LOGNAME': 'cltbld', 05:17:30 INFO - 'MAIL': '/var/mail/cltbld', 05:17:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:30 INFO - 'MOZ_NO_REMOTE': '1', 05:17:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:30 INFO - 'NO_EM_RESTART': '1', 05:17:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:30 INFO - 'PWD': '/builds/slave/test', 05:17:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:30 INFO - 'SHELL': '/bin/bash', 05:17:30 INFO - 'SHLVL': '1', 05:17:30 INFO - 'TERM': 'linux', 05:17:30 INFO - 'TMOUT': '86400', 05:17:30 INFO - 'USER': 'cltbld', 05:17:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731', 05:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:30 INFO - '_': '/tools/buildbot/bin/python'} 05:17:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:17:30 INFO - mozversion application_buildid: 20160428023628 05:17:30 INFO - mozversion application_changeset: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 05:17:30 INFO - mozversion application_display_name: Nightly 05:17:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:30 INFO - mozversion application_name: Firefox 05:17:30 INFO - mozversion application_remotingname: firefox 05:17:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:30 INFO - mozversion application_vendor: Mozilla 05:17:30 INFO - mozversion application_version: 48.0a1 05:17:30 INFO - mozversion platform_buildid: 20160428023628 05:17:30 INFO - mozversion platform_changeset: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 05:17:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:30 INFO - mozversion platform_version: 48.0a1 05:17:30 INFO - using testdate: 1461845850 05:17:30 INFO - actual date: 1461845850 05:17:30 INFO - starting webserver on 'localhost:55067' 05:17:30 INFO - SUITE-START | Running 2 tests 05:17:30 INFO - TEST-START | dromaeo_css 05:17:30 INFO - operating with platform_type : linux_ 05:17:30 INFO - Initialising browser for dromaeo_css test... 05:17:30 INFO - TEST-INFO | started process 15763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoh2a1M/profile http://localhost:55067/getInfo.html) 05:17:34 INFO - PROCESS | 15763 | __metrics Screen width/height:1600/1200 05:17:34 INFO - PROCESS | 15763 | colorDepth:24 05:17:34 INFO - PROCESS | 15763 | Browser inner width/height: 1024/697 05:17:34 INFO - PROCESS | 15763 | __metrics 05:17:36 ERROR - PROCESS | 15763 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:37 INFO - TEST-INFO | 15763: exit 0 05:17:37 INFO - Browser initialized. 05:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:37 INFO - TEST-INFO | started process 15847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoh2a1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:48 INFO - PROCESS | 15847 | RSS: Main: 154382336 05:17:48 INFO - PROCESS | 15847 | 05:18:39 INFO - PROCESS | 15847 | 1461845919871 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] 05:20:47 INFO - PROCESS | 15847 | Cycle 1(1): loaded http://localhost:55067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55067/tests/dromaeo/cssquery-ext.html) 05:20:48 INFO - PROCESS | 15847 | RSS: Main: 238149632 05:20:48 INFO - PROCESS | 15847 | 05:23:50 INFO - PROCESS | 15847 | Cycle 1(1): loaded http://localhost:55067/tests/dromaeo/cssquery-ext.html (next: http://localhost:55067/tests/dromaeo/cssquery-jquery.html) 05:23:51 INFO - PROCESS | 15847 | RSS: Main: 233140224 05:23:51 INFO - PROCESS | 15847 | 05:26:53 INFO - PROCESS | 15847 | Cycle 1(1): loaded http://localhost:55067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55067/tests/dromaeo/cssquery-mootools.html) 05:26:53 INFO - PROCESS | 15847 | RSS: Main: 232431616 05:26:53 INFO - PROCESS | 15847 | 05:29:55 INFO - PROCESS | 15847 | Cycle 1(1): loaded http://localhost:55067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55067/tests/dromaeo/cssquery-prototype.html) 05:29:56 INFO - PROCESS | 15847 | RSS: Main: 225140736 05:29:56 INFO - PROCESS | 15847 | 05:32:59 INFO - PROCESS | 15847 | Cycle 1(1): loaded http://localhost:55067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55067/tests/dromaeo/cssquery-yui.html) 05:32:59 INFO - PROCESS | 15847 | RSS: Main: 224788480 05:32:59 INFO - PROCESS | 15847 | 05:36:01 INFO - PROCESS | 15847 | Cycle 1(1): loaded http://localhost:55067/tests/dromaeo/cssquery-yui.html (next: http://localhost:55067/tests/dromaeo/cssquery-dojo.html) 05:36:02 INFO - PROCESS | 15847 | RSS: Main: 269328384 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | __start_tp_report 05:36:02 INFO - PROCESS | 15847 | _x_x_mozilla_page_load 05:36:02 INFO - PROCESS | 15847 | _x_x_mozilla_page_load_details 05:36:02 INFO - PROCESS | 15847 | |i|pagename|runs| 05:36:02 INFO - PROCESS | 15847 | |0;dojo.html;3129.2489802447412;3141.827199504029;3175.237942893706;3176.063061396888;3206.9679303206967;5261.210818377245;5312.335958005249;5313.57491400688;5354.955783622196;5409.80984183479;5340.572754179666;5408.4050754416985;5438.102713052342;5438.755256013479;5451.618386712932;4754.9286760698615;4802.351682522858;4873.366462359888;4920;4964.329815474919;4872.537108974641;4892.535209155142;4899.363082799249;4919.0899683558655;4925.694690906913;4719.716816990975;4806.255030470283;4848.927266091011;4883.194272944996;4908.7300198489065;4906.386701662293;4918.803247870081;4923.458419573844;4924.162892308316;4983.078130545824;4850.175470170079;4892;4906.484819094015;4913.189323761575;4939.333190019337;5205.167173252262;5281.39263984639;5346.866328341784;5377.247185394048;5382.1657643065;5575.303087114111;5619.241402410663;5633.40849210831;5635.126555383922;5636.323641163046;5561.63849349791;5657.264555607745;5672.858178545569;5674.716264186774;5678.545716342683;5229.08491014071;5284.445133260991;5291.232771248186;5296.3909150447425;5305.708186049805;5836.299644042742;5846.1230815377185;5846.766129354864;5878.470937615635;5896.3219229788265;5619.100943848965;5635.492805647511;5643.379228284967;5644.491995720323;5645.2096706461125;5517;5594.580406469531;5643.604947653625;5681.943180568224;5692.829215123553;5561.332640083216;5595.104783234663;5600.971995140079;5607.158926161109;5607.243022192033;5468.207109969032;5582.358028826656;5615.354234263112;5627.212190293362;5637.379888212294;4299.806508707115;4318.460192475941;4326.870193894189;4339.804708788112;4357.54245804186;3826.4642949987024;3827.827747751358;3832.3868181091448;3851.730378873452;3868.2650296443585;5281.313429254173;5338.652987555796;5339.492748188916;5339.973300133553;5398.541124004503;5694.060480020833;5754.683492407874;5769.451902069297;5779.479846813723;5833;5274.4198138204765;5313.814016509404;5321.3348331458565;5321.36143662763;5323.1216849219445;4643.674942754043;4695.718256904596;4709.858704238878;4730.645201609893;4767.237242041257;5868.559858010666;5869.236999190163;5885.941140588539;5916.526677865761;5941.762329506858;5711.9714401428555;5715.114157305624;5727.427257274239;5729.9713501432225;5734.913976290276;5790.623609465371;5821.79623713168;5867.471927526543;5872.853178670567;5899.115132730125;5570.972145139248;5598.356189038313;5604.467575580314;5604.719764011702;5654.067078932095;5628.493435590816;5629.521490673339;5663.66018038919;5675.829725108253;5677.517411019944;5417.810376636957;5532.474414930575;5543.223948647274;5614.438556144353;5638.520725738358;5529.225908372911;5534.640248383842;5540.279763630702;5545.944540554543;5547.916781248366;5425.050616142081;5433.9184912225555;5433.972830135982;5475.123980163155;5481.287432633732;5438.972805135949;5455.427180146027;5589.608727389043;5603.495685388335;5620.831375058755;5445;5452.045891968969;5452.645578037414;5458.918116228339;5500.559955203494 05:36:02 INFO - PROCESS | 15847 | |1;ext.html;587.7795826565039;628.258654787351;630.5428564290889;640.5132099604302;646.282626284824;38173.618263817356;39580.208395832065;39651.206975860536;39665.80167099164;39674;45047.77476112623;45816.312755308696;46151.30773038407;46183.07633847321;46190;8812.295016398688;9113.179813816756;9114.635414583408;9117.088291170896;9118.726438206864;8904.73285801427;9090.272778177763;9091.772705682377;9123.178913897747;9127.087291270853;9081.137291957286;9145.542722863831;9156.03861594533;9161.03809100045;9174.357794954356;9048.909510904905;9053.09469053096;9092.954535227347;9118.58966346516;9122.452652840817;8929.910700892973;9048.502332371718;9049.411788233743;9053.77365565866;9055.501947392891;42318.15363692709;42856.78571607122;42859;42967.57032429667;43042.78478607587;3457.170279133015;3603.72972027099;4014.2372949139863;4070.816813243411;4156.521999970012;32275.83862080698;32582.567618743953;32693.346133077444;32696.509552356732;33235.50146747801;4238.279492486285;4277.315629499265;4292.377605247221;4321.589449002371;4327.221100201962;332129;334859.32570337236;337156;337491;337737;59986.10020849691;60694.99999999912;60831.39168608346;60911.69544152251;60923.390766092656;51210.48789512132;56344.718276408355;57913.4208657908;58140.12789808156;63894.680526598;16647.583810404594;16833.663326733396;16841.326346945985;16845.663086738197;16852.83147168537;11955.940220298842;13528.526501572398;13582.932085339708;13626.454941802216;13630.182189068688;17470.912645436692;17846.732299015526;17932.282708691768;17976.460706178834;17997.7300340495;6458.838529036718;6561.573497722633;6585.407313341822;6681.498887583353;6815.250322464525;1000.2498126405196;1017.0947856407803;1056.746380868586;1109.5617231193794;1113.4877956140103;30104.548431773543;30340.69659303423;30757.384852303276;32765.344693106006;33050.504242436386;1147.9311241325547;1174.301290732013;1193.3198077096145;1233.586748439283;1290.0518119182582;17231.741523877154;17423.73864392035;17633.911830440764;17674.646507069785;17696.380626678005;493765;495634;496828;498029;500593;58708.706456467444;59106.40893591095;59175.40824591699;59179;59183;1264.0393301091237;1279.2899940533093;1327.402668799025;1370.6436326555167;1405.2973513243378;28512.287192819516;29567.408651827274;30850.38299233958;32945.83527082445;33512.49731254082;47118;47361.52638473709;47459.28811067906;47470.28794568015;47532.7623361881;291689;294455;294496;294581;296349;31392.686073138975;37889.43165852459;38761.80619096886;39075.609243907194;39370.6062939367;46017.76991115023;47345.76327118342;47351.28973065476;47707.52292477031;47810;39862.800685996386;39950.400743988284;40315.798421007705;40364.49881413057;40761.184776303715;39746.40380394238;40352.3947140799;40476;40517.59482405138;41461.79269103635;39362;39620;40661.59338406578;40786.388204176365;40835.79582102071;33376.332473350885;34943.301133977686;35317.646823532465;35830.82084589561;35911.281774363844;27130;27448.429936701006;27528.449431011668;27781.08298628615;27885.581716273868 05:36:02 INFO - PROCESS | 15847 | |2;jquery.html;380.77724531149295;385.17764572637446;392.6230818414322;400.6594394764451;412.9545749967503;14658;15464.84535154648;17753.556161095978;18273.634527309445;18390.172442240113;14276.857231427683;17468.475945721617;17711.114444277766;17755.20101595428;17795.110244487787;5554.2779438672915;5617.691026993513;5672.489475947164;5676.460736230051;5750.769969201227;4057.1885622875398;5481.314835645544;5622.690752008638;5646.632968857011;6016.097585362187;6208.410201030895;6221.502279817604;6253.312135665074;6266.091416744569;6268.404501572343;6154.753809847623;6171.321154672983;6180.536459765513;6341.841453963688;6361.68191590421;5572.219889215513;5576.71735500833;5578.748956296977;5582.190582365534;5582.190582365575;20968.370948871558;21280.46798830026;21464;21763.455913602127;21974.780252197594;2267.807236384893;2325.5813953488364;2549.8342607730438;2811.817231879921;2945.234239097829;13629.931850340685;13697.726045479134;13717.725645487035;13905.652358691012;14208.715825683428;1923.8268555829902;1966.7934866838918;2021.3430635043524;2048.3752455501067;2054.3734161080865;78507.21492785057;79780.20219797843;80111.19888801154;80411.59794200992;80874.19125808726;9870.30907836459;9971.850422243671;10428.478576071166;10475.52860121281;10579.31234469757;14301;14427.639309017359;14461;14483.637909052359;14489.855101449062;7187;7489.925100749032;7900.407469439815;8124.390670699603;8261.256486916207;7147.605552139988;7194.352508274281;7381.298776616213;7417.554946703215;7553.357964572963;6220.657863817533;6433.356664333529;6442.35576442352;6500.609963402211;6522.771702990467;1848.2422206895108;1856.7493388392395;1862.1806405181676;1878.3519685708409;1908.360699165795;455.9977200113978;468.1760102220117;903.4241566465829;1016.6340117557673;1076.2573824061528;10850.457477126112;11092.778144437067;11096;11109.944450277697;11239.100871930226;469.6946984460128;472.45195573135686;476.44732110752057;477.4223189940142;508.71511953306265;5946.316173640087;6127.2647282325515;6130.78542251028;6138.508919286446;6184.5980011299125;487950;492716;496102;497761;500147;93798.53100734453;97542;98434.5078274604;99179;99179;1049.574922156528;1083.9566417343217;1095.9616413425492;1100.3178029621527;1106.5850306135198;13342.26617536006;15532.30104645271;15574.299156538209;15751.68496630084;15766.605834854221;39017.609823901395;40157.397639034854;40868.59131408648;40947.7952610235;41358.1728365437;38726.80636596799;49999.50000500094;51277.7436112832;53290.73354633202;54441.18338225009;6693.765718199839;7166.498345115792;8014.398920081134;8203.261706446448;8383.03595086573;12574.434150463068;12917.418716157608;13053.608391748263;13064.673383165116;13380.799288010492;11493.885061149282;11562.595309164475;11602.767944640891;11720.94139529331;11744.29534227949;11254.268472549258;11504.791996840211;11516.82724759146;11599.6520104397;11618.70953226176;11506.252093613888;11593.768124637292;11753.412329383325;11867.287962722265;11871;8000.51996880189;8191.426600138171;8406.579671016547;8479.236868681848;8683.088275730957;8534.573271336532;10545.841812372973;11616.361100139573;11960.940195298968;11995.82006269924 05:36:02 INFO - PROCESS | 15847 | |3;mootools.html;1344.9865501344984;1489.672272100138;1511.1235483419619;1628.7719719239308;1770.575061985123;7227.747028853991;8002.559859207741;8127.34981201504;8189.3857960652895;8221.054578723448;7939;8082.91917080829;8092.514449133057;8092.635831387587;8126.3498920086395;2004.4688157638238;2220.922267720634;2229.899654515543;2252.8986195621237;2291.1522736587403;2316.81465482761;2349.3304408243653;2351.9647205291935;2357.49313897512;2358.304300231427;2237.183428048767;2289.954200915989;2295.4605667668084;2298.4139044543617;2302.044651469638;1950.8536859735505;2220.400491867195;2288.485090854561;2296.494771150344;2297.655351697242;2294.369048511656;2307.065638416444;2321.4312493439047;2337.053493335202;2341.5668101401125;7869.8032549186155;7943.841123177504;7945.205479452066;7954.363650907913;7956.880646790245;4842.854714358575;4976.178930476467;4977.800887964477;4988.975055124701;5000.774965126578;3021.214484234115;3034.8027378220345;3108.9533656995163;3217.4047801156626;3237.3687131009465;1029.269218854614;1032.4940779018302;1038.4444322287616;1086.2504871638544;1123.084685980931;11064.889351106467;11194.720131996764;11269.492872820743;11274.267172633834;11318.830217546825;4449.065696203834;4501.909961800746;4544.545545445495;4559.54404559548;4568.657350698711;9771.706848794547;9781.706548803404;9786.804263914824;9799.265055120895;9819.852702209473;4588.2658774596575;5085.46602606721;5150.896982060338;5157.097507936096;5157.922631160535;4599.724016559017;4742.668013239109;4753.35829662998;4763.261694437368;4763.476017638057;3842.442845787345;3872.341701910682;3958.2281455116554;3987.182627561343;3995.6603688686787;1198.7302856857311;1256.1960345378964;1260.602910083321;1266.7339858629791;1294.449858810002;984.886738025122;996.6113215845826;1012.832882574367;1021.3565453764081;1028.3315844701003;5615.831525054255;5719.656820590778;5822.7088645567555;5845.240118784531;5862.618929769551;455.8769132334251;456.38388175962183;456.49557239250817;461.420916749484;473.4768081270147;4001.4998125234347;4168.624823765876;4177.143685544456;4216.9789151054665;4219.198352313112;9763.170130538841;10152.796944061225;10188.643397481053;10259.281850270409;10275.845862312071;10119.59521619127;10148.594056237667;10157.796844063078;10179;10194.43930583825;7460.888086678704;7803.219678032265;7807.141214466405;7814.960925195452;7825;5479.917801232905;5490.121580547093;5711.343195532567;5758.0499217630295;5858.7070646468355;8777.648894044167;8997.775055623662;9226.861597075915;9311.534423278674;9314.301427393108;9208.12522810332;9435.52822358893;9535.38020028696;9567.425954442755;9807.901920980985;6742.831429214309;7090.397316227972;7244.746433874789;7309.744158954411;7452.06849143857;7745.728899488491;7747.845043099219;7749.612519373896;7826.921730782847;7837.255460731221;7055.929440705732;7282.235365286569;7309.5248808827255;7375.188729239672;7431.777046688608;7073.363397294268;7083.716651334095;7185.856282874418;7192.496525243392;7235.819104522429;6494;6511.218653761579;6559.4752419807255;6570.507211959218;6580.374864387875;5050.797968081382;5134.820281290286;5140.974295128501;5173.40505841833;5174.6119041072825;5151.845444636517;5153.742312884416;5167.689938603696;5179.533841954242;5212.739363031757 05:36:02 INFO - PROCESS | 15847 | |4;prototype.html;311.3834607477195;320.754622713624;326.05606768405465;326.27566801700226;326.6798537433316;5043.974780126104;5089.796408143669;5181.300524429201;5237.214417837326;5255.369355677314;5189.844304670856;5203.505666961642;5223.921641175385;5227.451117632641;5233.241180028894;4057.3711074783455;4068.572799856002;4070.2876996525565;4076.103257283408;4081.1225586498895;3885.057471264368;3898.5126859142606;4070.633642972132;4088.9386659200136;4093.9181216375655;4022.9597704023026;4031.1736094100784;4057.756534607933;4070.8778736637946;4073.2668119738437;4030.1536677297654;4030.5364883038533;4041.595840415964;4041.97979010106;4044.1911617676287;3519.7008254298416;3571.2857428514403;3580.498730177751;3583.104223944014;3589.192431702872;5035.622328325354;5038.39539255288;5058.241263810458;5065.569426598743;5076.771545280471;4556.567126123046;4580.381648477446;4598.977005114953;4600.861974140781;4609.308603709437;5155.484451554852;5321.308229930123;5332.600054995852;5340.421917315369;5355.946440535584;3913.4521167036637;3914.354131568288;3940.0937784309767;3947.3092208863336;3949.4273330367223;5540.695261760601;5548.223248745179;5560.804427048204;5568.331800183963;5586.413426590231;3990.68074554035;4008.6793056555407;4009.0979529605606;4013.8595149169637;4019.577944315805;3737.4580685800406;3973.4635824163947;3994.9201015980098;3998.8800335989968;4043.6950937965075;4562.931556026662;4564.7032942858605;4577.130345234461;4578.404807375086;4589;5396.136618141157;5440;5457.372402173801;5459.454054594588;5480.862978425571;1364.836219653628;1378.5381897064394;1408.845027047024;1411.4283715095403;1442.463776078473;951.7573018880141;959.6593209410698;970.7186513801855;974.7368210583103;976.2482888176206;5500.559955203574;5515.862103447365;5524.397924601901;5530.585206109477;5542.085555883315;5869.148973398918;5886.8822623547285;5888.9705551472825;5891.440313170242;5906.616069955439;5392.892142157135;5485.259489968803;5510.256115424367;5528.253685752452;5555.638883472561;3122.2818751686787;3123.7813353065067;3124;3144.9685503145133;3159.3887117569743;5874.412558744177;6046.486048685823;6088.939110608926;6096.744204644221;6097;5970.761169553256;6010.128531362928;6013.428724271187;6030.547708921848;6034.1853849730605;6028.668423236676;6062.848428789315;6068.21113255274;6076.3316035236085;6106.816795496142;5779.566532510163;5873.089671100986;5896.17453556511;5908.497777688945;5923.111533269872;5805.448482394166;5811.56413269015;5821.912671309849;5832.445917637818;5846.444587764156;5518.862028449321;6009.338972712911;6031.366706495754;6050.364711705383;6070.605410648293;3868.2650296443585;3894.493715817039;3914.64768170866;3920.725549211642;3931.76409415436;5353.306218709078;5469.972650136724;5643.181738647955;5647.887042259214;5666.206731057573;5456.181572764117;5493.92868390676;5501.037318469172;5516.200150978166;5518.227448157341;5206.505381988705;5429.5656347492895;5486.149646804752;5493.681516435947;5522.2544956430365;5345.492178243061;5371.811986580451;5419.430959749169;5423.864403389947;5432;5467.835964921059;5486.231927530069;5496.203050557567;5521.641093329082;5576.33084029919;5205.947940520698;5374.677519348852;5401.162819762943;5406.432324606017;5428.59285553593 05:36:02 INFO - PROCESS | 15847 | |5;yui.html;714.9821254468637;747.6859718918054;763.8205021819875;782.194339829975;785.1755656560609;12129.272243665375;12212.93893530531;12244.510219591217;12248.693782655428;12250.326232057234;10943.45282735864;10958.397288149148;11002.50488728007;11008.834867476975;11010.944945275283;681.8943063825116;701.2496628607392;791.4143533785016;798.3692882622751;798.9680412783482;797.103258833812;802.835418739157;803.2088392932985;804.5172896262254;804.6499772598938;853.1468531468531;854.218390172991;854.3378881366929;855.6534603485599;857.3055824781916;714.4534431160166;813.3452570680599;816.1145157504116;824.3240542754943;833.262562632072;600.4505877122427;601.1523751510349;601.1703848688825;611.2298503885092;626.4236902050125;12060.758784824255;12086.093542984312;12096.697582560419;12097.092718046182;12115.091368147425;10799.190060745397;11886.465109070112;12307.93846030773;12358.196717213352;12713;10380.32527885685;10461.215408844368;10522.31604945676;10726.19553533488;10798.190135739851;3625.111847597329;3625.347437461256;3645.708343332527;3662.1943172502006;3685.631436856293;54622.453775462534;55572.44427555713;56648.43351566473;56963;57045.42954570443;9551.320230295867;9618.807623847624;9689.806203876024;9736.95131524338;9865.704028879145;17618.119094045247;17667.38164164248;17678.381256655954;17703.55741106457;17733.46799596014;7362.5214361066355;7398.852022959618;7423.109226892808;7489.700411983568;7683.346915512132;4106.281400754856;4155.127423241092;4327.17783621111;4347.195768782785;4355.847545335898;3040.7567394608377;3113.579666745006;3113.844307784602;3114.361555881039;3115.5638210650527;520.7734635433599;531.9441458646786;573.9311282646025;601.5578549765919;622.1072760588479;666.7666316789182;711.4095300900241;715.8926161075881;718.2817182817183;729.5513259345464;8585.141485851489;8807.69173078952;8985.910140898508;9035.548222588845;9070.455772653662;622.6793201501231;660.2638058564665;687.6630451078935;702.2415790945767;713.3356911933922;4213.47331583552;4237.279662457328;4273.35899615054;4371.344298355209;4457.487388950312;68681;68936;70519.94220086702;70620.2937970624;71416;59782;59980.70009649924;60033;61224;61741.38258617446;54715.45284547183;55007.72496137574;55040.72479637576;55447;55518.72240638771;8192.877106843283;8236.752897413087;8369.66521339164;8375.32997360222;8511.91488085136;35821.28357432889;36423.81788091043;36443.08892277714;36784.63215367812;37442.251154976206;49581.25628115653;50610.49389506205;50630;50687.49312506828;50707;11436.656900293005;11500.137489688474;11527.884721153017;11776.352300623548;11820.113491488344;11271.830922536004;11763.117766167401;11952.58165964187;11995.820062698893;12181.817272741093;9948.835690322314;10772.461376931278;11931.105167112328;12387.380630968595;13024.674383140497;11408.657740267805;11713.180077394842;12111.454984525893;12143.271403715453;12168.148229623841;11990.460429280529;12098.818517722417;12286.262824230575;12459.377031148588;12468.127231093737;10055.849162262719;10293.845592316271;10344.448552556525;10726;11012.229143959847;10360.637377691744;10653.573857045942;10693.679189624323;10704.464776761286;10741.946290268812 05:36:02 INFO - PROCESS | 15847 | __end_tp_report 05:36:02 INFO - PROCESS | 15847 | __start_cc_report 05:36:02 INFO - PROCESS | 15847 | _x_x_mozilla_cycle_collect,970 05:36:02 INFO - PROCESS | 15847 | __end_cc_report 05:36:02 INFO - PROCESS | 15847 | __startTimestamp1461846962187__endTimestamp 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | ------- Summary: start ------- 05:36:02 INFO - PROCESS | 15847 | Number of tests: 6 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | [#0] dojo.html Cycles:165 Average:5275.31 Median:5452.65 stddev:587.47 (10.8%) stddev-sans-first:564.64 05:36:02 INFO - PROCESS | 15847 | Values: 3129.2 3141.8 3175.2 3176.1 3207.0 5261.2 5312.3 5313.6 5355.0 5409.8 5340.6 5408.4 5438.1 5438.8 5451.6 4754.9 4802.4 4873.4 4920.0 4964.3 4872.5 4892.5 4899.4 4919.1 4925.7 4719.7 4806.3 4848.9 4883.2 4908.7 4906.4 4918.8 4923.5 4924.2 4983.1 4850.2 4892.0 4906.5 4913.2 4939.3 5205.2 5281.4 5346.9 5377.2 5382.2 5575.3 5619.2 5633.4 5635.1 5636.3 5561.6 5657.3 5672.9 5674.7 5678.5 5229.1 5284.4 5291.2 5296.4 5305.7 5836.3 5846.1 5846.8 5878.5 5896.3 5619.1 5635.5 5643.4 5644.5 5645.2 5517.0 5594.6 5643.6 5681.9 5692.8 5561.3 5595.1 5601.0 5607.2 5607.2 5468.2 5582.4 5615.4 5627.2 5637.4 4299.8 4318.5 4326.9 4339.8 4357.5 3826.5 3827.8 3832.4 3851.7 3868.3 5281.3 5338.7 5339.5 5340.0 5398.5 5694.1 5754.7 5769.5 5779.5 5833.0 5274.4 5313.8 5321.3 5321.4 5323.1 4643.7 4695.7 4709.9 4730.6 4767.2 5868.6 5869.2 5885.9 5916.5 5941.8 5712.0 5715.1 5727.4 5730.0 5734.9 5790.6 5821.8 5867.5 5872.9 5899.1 5571.0 5598.4 5604.5 5604.7 5654.1 5628.5 5629.5 5663.7 5675.8 5677.5 5417.8 5532.5 5543.2 5614.4 5638.5 5529.2 5534.6 5540.3 5545.9 5547.9 5425.1 5433.9 5434.0 5475.1 5481.3 5439.0 5455.4 5589.6 5603.5 5620.8 5445.0 5452.0 5452.6 5458.9 5500.6 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | [#1] ext.html Cycles:180 Average:54805.93 Median:40420.25 stddev:101885.34 (252.1%) stddev-sans-first:102089.83 05:36:02 INFO - PROCESS | 15847 | Values: 587.8 628.3 630.5 640.5 646.3 38173.6 39580.2 39651.2 39665.8 39674.0 45047.8 45816.3 46151.3 46183.1 46190.0 8812.3 9113.2 9114.6 9117.1 9118.7 8904.7 9090.3 9091.8 9123.2 9127.1 9081.1 9145.5 9156.0 9161.0 9174.4 9048.9 9053.1 9093.0 9118.6 9122.5 8929.9 9048.5 9049.4 9053.8 9055.5 42318.2 42856.8 42859.0 42967.6 43042.8 3457.2 3603.7 4014.2 4070.8 4156.5 32275.8 32582.6 32693.3 32696.5 33235.5 4238.3 4277.3 4292.4 4321.6 4327.2 332129.0 334859.3 337156.0 337491.0 337737.0 59986.1 60695.0 60831.4 60911.7 60923.4 51210.5 56344.7 57913.4 58140.1 63894.7 16647.6 16833.7 16841.3 16845.7 16852.8 11955.9 13528.5 13582.9 13626.5 13630.2 17470.9 17846.7 17932.3 17976.5 17997.7 6458.8 6561.6 6585.4 6681.5 6815.3 1000.2 1017.1 1056.7 1109.6 1113.5 30104.5 30340.7 30757.4 32765.3 33050.5 1147.9 1174.3 1193.3 1233.6 1290.1 17231.7 17423.7 17633.9 17674.6 17696.4 493765.0 495634.0 496828.0 498029.0 500593.0 58708.7 59106.4 59175.4 59179.0 59183.0 1264.0 1279.3 1327.4 1370.6 1405.3 28512.3 29567.4 30850.4 32945.8 33512.5 47118.0 47361.5 47459.3 47470.3 47532.8 291689.0 294455.0 294496.0 294581.0 296349.0 31392.7 37889.4 38761.8 39075.6 39370.6 46017.8 47345.8 47351.3 47707.5 47810.0 39862.8 39950.4 40315.8 40364.5 40761.2 39746.4 40352.4 40476.0 40517.6 41461.8 39362.0 39620.0 40661.6 40786.4 40835.8 33376.3 34943.3 35317.6 35830.8 35911.3 27130.0 27448.4 27528.4 27781.1 27885.6 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | [#2] jquery.html Cycles:180 Average:28429.89 Median:22107.29 stddev:81713.04 (369.6%) stddev-sans-first:81915.12 05:36:02 INFO - PROCESS | 15847 | Values: 380.8 385.2 392.6 400.7 413.0 14658.0 15464.8 17753.6 18273.6 18390.2 14276.9 17468.5 17711.1 17755.2 17795.1 5554.3 5617.7 5672.5 5676.5 5750.8 4057.2 5481.3 5622.7 5646.6 6016.1 6208.4 6221.5 6253.3 6266.1 6268.4 6154.8 6171.3 6180.5 6341.8 6361.7 5572.2 5576.7 5578.7 5582.2 5582.2 20968.4 21280.5 21464.0 21763.5 21974.8 2267.8 2325.6 2549.8 2811.8 2945.2 13629.9 13697.7 13717.7 13905.7 14208.7 1923.8 1966.8 2021.3 2048.4 2054.4 78507.2 79780.2 80111.2 80411.6 80874.2 9870.3 9971.9 10428.5 10475.5 10579.3 14301.0 14427.6 14461.0 14483.6 14489.9 7187.0 7489.9 7900.4 8124.4 8261.3 7147.6 7194.4 7381.3 7417.6 7553.4 6220.7 6433.4 6442.4 6500.6 6522.8 1848.2 1856.7 1862.2 1878.4 1908.4 456.0 468.2 903.4 1016.6 1076.3 10850.5 11092.8 11096.0 11109.9 11239.1 469.7 472.5 476.4 477.4 508.7 5946.3 6127.3 6130.8 6138.5 6184.6 487950.0 492716.0 496102.0 497761.0 500147.0 93798.5 97542.0 98434.5 99179.0 99179.0 1049.6 1084.0 1096.0 1100.3 1106.6 13342.3 15532.3 15574.3 15751.7 15766.6 39017.6 40157.4 40868.6 40947.8 41358.2 38726.8 49999.5 51277.7 53290.7 54441.2 6693.8 7166.5 8014.4 8203.3 8383.0 12574.4 12917.4 13053.6 13064.7 13380.8 11493.9 11562.6 11602.8 11720.9 11744.3 11254.3 11504.8 11516.8 11599.7 11618.7 11506.3 11593.8 11753.4 11867.3 11871.0 8000.5 8191.4 8406.6 8479.2 8683.1 8534.6 10545.8 11616.4 11960.9 11995.8 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | [#3] mootools.html Cycles:180 Average:5457.23 Median:4983.39 stddev:3017.24 (60.5%) stddev-sans-first:3009.87 05:36:02 INFO - PROCESS | 15847 | Values: 1345.0 1489.7 1511.1 1628.8 1770.6 7227.7 8002.6 8127.3 8189.4 8221.1 7939.0 8082.9 8092.5 8092.6 8126.3 2004.5 2220.9 2229.9 2252.9 2291.2 2316.8 2349.3 2352.0 2357.5 2358.3 2237.2 2290.0 2295.5 2298.4 2302.0 1950.9 2220.4 2288.5 2296.5 2297.7 2294.4 2307.1 2321.4 2337.1 2341.6 7869.8 7943.8 7945.2 7954.4 7956.9 4842.9 4976.2 4977.8 4989.0 5000.8 3021.2 3034.8 3109.0 3217.4 3237.4 1029.3 1032.5 1038.4 1086.3 1123.1 11064.9 11194.7 11269.5 11274.3 11318.8 4449.1 4501.9 4544.5 4559.5 4568.7 9771.7 9781.7 9786.8 9799.3 9819.9 4588.3 5085.5 5150.9 5157.1 5157.9 4599.7 4742.7 4753.4 4763.3 4763.5 3842.4 3872.3 3958.2 3987.2 3995.7 1198.7 1256.2 1260.6 1266.7 1294.4 984.9 996.6 1012.8 1021.4 1028.3 5615.8 5719.7 5822.7 5845.2 5862.6 455.9 456.4 456.5 461.4 473.5 4001.5 4168.6 4177.1 4217.0 4219.2 9763.2 10152.8 10188.6 10259.3 10275.8 10119.6 10148.6 10157.8 10179.0 10194.4 7460.9 7803.2 7807.1 7815.0 7825.0 5479.9 5490.1 5711.3 5758.0 5858.7 8777.6 8997.8 9226.9 9311.5 9314.3 9208.1 9435.5 9535.4 9567.4 9807.9 6742.8 7090.4 7244.7 7309.7 7452.1 7745.7 7747.8 7749.6 7826.9 7837.3 7055.9 7282.2 7309.5 7375.2 7431.8 7073.4 7083.7 7185.9 7192.5 7235.8 6494.0 6511.2 6559.5 6570.5 6580.4 5050.8 5134.8 5141.0 5173.4 5174.6 5151.8 5153.7 5167.7 5179.5 5212.7 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | [#4] prototype.html Cycles:180 Average:4657.70 Median:5342.96 stddev:1396.72 (26.1%) stddev-sans-first:1362.01 05:36:02 INFO - PROCESS | 15847 | Values: 311.4 320.8 326.1 326.3 326.7 5044.0 5089.8 5181.3 5237.2 5255.4 5189.8 5203.5 5223.9 5227.5 5233.2 4057.4 4068.6 4070.3 4076.1 4081.1 3885.1 3898.5 4070.6 4088.9 4093.9 4023.0 4031.2 4057.8 4070.9 4073.3 4030.2 4030.5 4041.6 4042.0 4044.2 3519.7 3571.3 3580.5 3583.1 3589.2 5035.6 5038.4 5058.2 5065.6 5076.8 4556.6 4580.4 4599.0 4600.9 4609.3 5155.5 5321.3 5332.6 5340.4 5355.9 3913.5 3914.4 3940.1 3947.3 3949.4 5540.7 5548.2 5560.8 5568.3 5586.4 3990.7 4008.7 4009.1 4013.9 4019.6 3737.5 3973.5 3994.9 3998.9 4043.7 4562.9 4564.7 4577.1 4578.4 4589.0 5396.1 5440.0 5457.4 5459.5 5480.9 1364.8 1378.5 1408.8 1411.4 1442.5 951.8 959.7 970.7 974.7 976.2 5500.6 5515.9 5524.4 5530.6 5542.1 5869.1 5886.9 5889.0 5891.4 5906.6 5392.9 5485.3 5510.3 5528.3 5555.6 3122.3 3123.8 3124.0 3145.0 3159.4 5874.4 6046.5 6088.9 6096.7 6097.0 5970.8 6010.1 6013.4 6030.5 6034.2 6028.7 6062.8 6068.2 6076.3 6106.8 5779.6 5873.1 5896.2 5908.5 5923.1 5805.4 5811.6 5821.9 5832.4 5846.4 5518.9 6009.3 6031.4 6050.4 6070.6 3868.3 3894.5 3914.6 3920.7 3931.8 5353.3 5470.0 5643.2 5647.9 5666.2 5456.2 5493.9 5501.0 5516.2 5518.2 5206.5 5429.6 5486.1 5493.7 5522.3 5345.5 5371.8 5419.4 5423.9 5432.0 5467.8 5486.2 5496.2 5521.6 5576.3 5205.9 5374.7 5401.2 5406.4 5428.6 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - PROCESS | 15847 | [#5] yui.html Cycles:180 Average:15030.24 Median:50620.25 stddev:18905.62 (37.3%) stddev-sans-first:18928.10 05:36:02 INFO - PROCESS | 15847 | Values: 715.0 747.7 763.8 782.2 785.2 12129.3 12212.9 12244.5 12248.7 12250.3 10943.5 10958.4 11002.5 11008.8 11010.9 681.9 701.2 791.4 798.4 799.0 797.1 802.8 803.2 804.5 804.6 853.1 854.2 854.3 855.7 857.3 714.5 813.3 816.1 824.3 833.3 600.5 601.2 601.2 611.2 626.4 12060.8 12086.1 12096.7 12097.1 12115.1 10799.2 11886.5 12307.9 12358.2 12713.0 10380.3 10461.2 10522.3 10726.2 10798.2 3625.1 3625.3 3645.7 3662.2 3685.6 54622.5 55572.4 56648.4 56963.0 57045.4 9551.3 9618.8 9689.8 9737.0 9865.7 17618.1 17667.4 17678.4 17703.6 17733.5 7362.5 7398.9 7423.1 7489.7 7683.3 4106.3 4155.1 4327.2 4347.2 4355.8 3040.8 3113.6 3113.8 3114.4 3115.6 520.8 531.9 573.9 601.6 622.1 666.8 711.4 715.9 718.3 729.6 8585.1 8807.7 8985.9 9035.5 9070.5 622.7 660.3 687.7 702.2 713.3 4213.5 4237.3 4273.4 4371.3 4457.5 68681.0 68936.0 70519.9 70620.3 71416.0 59782.0 59980.7 60033.0 61224.0 61741.4 54715.5 55007.7 55040.7 55447.0 55518.7 8192.9 8236.8 8369.7 8375.3 8511.9 35821.3 36423.8 36443.1 36784.6 37442.3 49581.3 50610.5 50630.0 50687.5 50707.0 11436.7 11500.1 11527.9 11776.4 11820.1 11271.8 11763.1 11952.6 11995.8 12181.8 9948.8 10772.5 11931.1 12387.4 13024.7 11408.7 11713.2 12111.5 12143.3 12168.1 11990.5 12098.8 12286.3 12459.4 12468.1 10055.8 10293.8 10344.4 10726.0 11012.2 10360.6 10653.6 10693.7 10704.5 10741.9 05:36:02 INFO - PROCESS | 15847 | -------- Summary: end -------- 05:36:02 INFO - PROCESS | 15847 | 05:36:02 INFO - TEST-INFO | 15847: exit 0 05:36:02 INFO - TEST-OK | dromaeo_css | took 1112630ms 05:36:02 INFO - TEST-START | kraken 05:36:02 INFO - operating with platform_type : linux_ 05:36:02 INFO - Initialising browser for kraken test... 05:36:02 INFO - TEST-INFO | started process 16029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpArZHUW/profile http://localhost:55067/getInfo.html) 05:36:07 INFO - PROCESS | 16029 | __metrics Screen width/height:1600/1200 05:36:07 INFO - PROCESS | 16029 | colorDepth:24 05:36:07 INFO - PROCESS | 16029 | Browser inner width/height: 1024/697 05:36:07 INFO - PROCESS | 16029 | __metrics 05:36:08 ERROR - PROCESS | 16029 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:36:08 INFO - TEST-INFO | 16029: exit 0 05:36:08 INFO - Browser initialized. 05:36:08 INFO - Running cycle 1/1 for kraken test... 05:36:08 INFO - TEST-INFO | started process 16108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpArZHUW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:20 INFO - PROCESS | 16108 | RSS: Main: 153772032 05:36:20 INFO - PROCESS | 16108 | 05:36:23 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55067/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:24 INFO - PROCESS | 16108 | RSS: Main: 209928192 05:36:24 INFO - PROCESS | 16108 | 05:36:26 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55067/tests/kraken/driver.html?testName=audio-dft) 05:36:27 INFO - PROCESS | 16108 | RSS: Main: 195256320 05:36:27 INFO - PROCESS | 16108 | 05:36:30 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55067/tests/kraken/driver.html?testName=audio-fft) 05:36:31 INFO - PROCESS | 16108 | RSS: Main: 265965568 05:36:31 INFO - PROCESS | 16108 | 05:36:33 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55067/tests/kraken/driver.html?testName=audio-oscillator) 05:36:33 INFO - PROCESS | 16108 | RSS: Main: 173719552 05:36:33 INFO - PROCESS | 16108 | 05:36:35 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:36 INFO - PROCESS | 16108 | RSS: Main: 177799168 05:36:36 INFO - PROCESS | 16108 | 05:36:39 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55067/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:40 INFO - PROCESS | 16108 | RSS: Main: 213528576 05:36:40 INFO - PROCESS | 16108 | 05:36:43 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55067/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:44 INFO - PROCESS | 16108 | RSS: Main: 214110208 05:36:44 INFO - PROCESS | 16108 | 05:36:46 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55067/tests/kraken/driver.html?testName=json-parse-financial) 05:36:47 INFO - PROCESS | 16108 | RSS: Main: 214921216 05:36:47 INFO - PROCESS | 16108 | 05:36:48 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:49 INFO - PROCESS | 16108 | RSS: Main: 201007104 05:36:49 INFO - PROCESS | 16108 | 05:36:51 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:51 INFO - PROCESS | 16108 | RSS: Main: 203096064 05:36:51 INFO - PROCESS | 16108 | 05:36:53 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:54 INFO - PROCESS | 16108 | RSS: Main: 215195648 05:36:54 INFO - PROCESS | 16108 | 05:36:57 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:57 INFO - PROCESS | 16108 | RSS: Main: 223891456 05:36:57 INFO - PROCESS | 16108 | 05:37:00 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:01 INFO - PROCESS | 16108 | RSS: Main: 219377664 05:37:01 INFO - PROCESS | 16108 | 05:37:02 INFO - PROCESS | 16108 | Cycle 1(1): loaded http://localhost:55067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55067/tests/kraken/driver.html?testName=ai-astar) 05:37:03 INFO - PROCESS | 16108 | RSS: Main: 284041216 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | __start_tp_report 05:37:03 INFO - PROCESS | 16108 | _x_x_mozilla_page_load 05:37:03 INFO - PROCESS | 16108 | _x_x_mozilla_page_load_details 05:37:03 INFO - PROCESS | 16108 | |i|pagename|runs| 05:37:03 INFO - PROCESS | 16108 | |0;ai-astar;109;111;107;113;113;111;100;111;111;110 05:37:03 INFO - PROCESS | 16108 | |1;audio-beat-detection;156;128;155;188;136;164;159;132;185;128 05:37:03 INFO - PROCESS | 16108 | |2;audio-dft;161;160;161;159;161;162;162;161;161;160 05:37:03 INFO - PROCESS | 16108 | |3;audio-fft;76;76;106;111;73;76;73;122;106;76 05:37:03 INFO - PROCESS | 16108 | |4;audio-oscillator;93;93;153;94;92;94;142;94;93;153 05:37:03 INFO - PROCESS | 16108 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 05:37:03 INFO - PROCESS | 16108 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;148 05:37:03 INFO - PROCESS | 16108 | |7;imaging-desaturate;94;94;95;96;94;95;95;95;94;95 05:37:03 INFO - PROCESS | 16108 | |8;json-parse-financial;58;57;56;56;57;57;57;72;55;55 05:37:03 INFO - PROCESS | 16108 | |9;json-stringify-tinderbox;63;63;63;63;62;63;62;63;63;62 05:37:03 INFO - PROCESS | 16108 | |10;stanford-crypto-aes;83;75;76;74;77;77;76;78;78;85 05:37:03 INFO - PROCESS | 16108 | |11;stanford-crypto-ccm;124;125;125;129;121;131;123;121;163;133 05:37:03 INFO - PROCESS | 16108 | |12;stanford-crypto-pbkdf2;169;166;170;165;167;167;166;173;166;170 05:37:03 INFO - PROCESS | 16108 | |13;stanford-crypto-sha256-iterative;69;68;71;71;69;68;69;68;68;68 05:37:03 INFO - PROCESS | 16108 | __end_tp_report 05:37:03 INFO - PROCESS | 16108 | __start_cc_report 05:37:03 INFO - PROCESS | 16108 | _x_x_mozilla_cycle_collect,1623 05:37:03 INFO - PROCESS | 16108 | __end_cc_report 05:37:03 INFO - PROCESS | 16108 | __startTimestamp1461847023100__endTimestamp 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | ------- Summary: start ------- 05:37:03 INFO - PROCESS | 16108 | Number of tests: 14 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.81 (3.4%) stddev-sans-first:4.03 05:37:03 INFO - PROCESS | 16108 | Values: 109.0 111.0 107.0 113.0 113.0 111.0 100.0 111.0 111.0 110.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:157.50 stddev:22.11 (14.0%) stddev-sans-first:23.42 05:37:03 INFO - PROCESS | 16108 | Values: 156.0 128.0 155.0 188.0 136.0 164.0 159.0 132.0 185.0 128.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:37:03 INFO - PROCESS | 16108 | Values: 161.0 160.0 161.0 159.0 161.0 162.0 162.0 161.0 161.0 160.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#3] audio-fft Cycles:10 Average:89.50 Median:74.50 stddev:19.25 (25.8%) stddev-sans-first:19.79 05:37:03 INFO - PROCESS | 16108 | Values: 76.0 76.0 106.0 111.0 73.0 76.0 73.0 122.0 106.0 76.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.25 (29.3%) stddev-sans-first:28.19 05:37:03 INFO - PROCESS | 16108 | Values: 93.0 93.0 153.0 94.0 92.0 94.0 142.0 94.0 93.0 153.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:37:03 INFO - PROCESS | 16108 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.95 (0.7%) stddev-sans-first:1.00 05:37:03 INFO - PROCESS | 16108 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 148.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:37:03 INFO - PROCESS | 16108 | Values: 94.0 94.0 95.0 96.0 94.0 95.0 95.0 95.0 94.0 95.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:5.01 (8.8%) stddev-sans-first:5.32 05:37:03 INFO - PROCESS | 16108 | Values: 58.0 57.0 56.0 56.0 57.0 57.0 57.0 72.0 55.0 55.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:37:03 INFO - PROCESS | 16108 | Values: 63.0 63.0 63.0 63.0 62.0 63.0 62.0 63.0 63.0 62.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.50 stddev:3.48 (4.5%) stddev-sans-first:3.16 05:37:03 INFO - PROCESS | 16108 | Values: 83.0 75.0 76.0 74.0 77.0 77.0 76.0 78.0 78.0 85.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:127.00 stddev:12.45 (9.8%) stddev-sans-first:13.04 05:37:03 INFO - PROCESS | 16108 | Values: 124.0 125.0 125.0 129.0 121.0 131.0 123.0 121.0 163.0 133.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:2.51 (1.5%) stddev-sans-first:2.64 05:37:03 INFO - PROCESS | 16108 | Values: 169.0 166.0 170.0 165.0 167.0 167.0 166.0 173.0 166.0 170.0 05:37:03 INFO - PROCESS | 16108 | 05:37:03 INFO - PROCESS | 16108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 05:37:03 INFO - PROCESS | 16108 | Values: 69.0 68.0 71.0 71.0 69.0 68.0 69.0 68.0 68.0 68.0 05:37:03 INFO - PROCESS | 16108 | -------- Summary: end -------- 05:37:03 INFO - PROCESS | 16108 | 05:37:04 INFO - TEST-INFO | 16108: exit 0 05:37:04 INFO - TEST-OK | kraken | took 61231ms 05:37:04 INFO - SUITE-END | took 1173s 05:37:04 INFO - Completed test suite (00:19:33) 05:37:04 INFO - javascript benchmark 05:37:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.2489802447412, 3141.827199504029, 3175.237942893706, 3176.063061396888, 3206.9679303206967, 5261.210818377245, 5312.335958005249, 5313.57491400688, 5354.955783622196, 5409.80984183479, 5340.572754179666, 5408.4050754416985, 5438.102713052342, 5438.755256013479, 5451.618386712932, 4754.9286760698615, 4802.351682522858, 4873.366462359888, 4920.0, 4964.329815474919, 4872.537108974641, 4892.535209155142, 4899.363082799249, 4919.0899683558655, 4925.694690906913, 4719.716816990975, 4806.255030470283, 4848.927266091011, 4883.194272944996, 4908.7300198489065, 4906.386701662293, 4918.803247870081, 4923.458419573844, 4924.162892308316, 4983.078130545824, 4850.175470170079, 4892.0, 4906.484819094015, 4913.189323761575, 4939.333190019337, 5205.167173252262, 5281.39263984639, 5346.866328341784, 5377.247185394048, 5382.1657643065, 5575.303087114111, 5619.241402410663, 5633.40849210831, 5635.126555383922, 5636.323641163046, 5561.63849349791, 5657.264555607745, 5672.858178545569, 5674.716264186774, 5678.545716342683, 5229.08491014071, 5284.445133260991, 5291.232771248186, 5296.3909150447425, 5305.708186049805, 5836.299644042742, 5846.1230815377185, 5846.766129354864, 5878.470937615635, 5896.3219229788265, 5619.100943848965, 5635.492805647511, 5643.379228284967, 5644.491995720323, 5645.2096706461125, 5517.0, 5594.580406469531, 5643.604947653625, 5681.943180568224, 5692.829215123553, 5561.332640083216, 5595.104783234663, 5600.971995140079, 5607.158926161109, 5607.243022192033, 5468.207109969032, 5582.358028826656, 5615.354234263112, 5627.212190293362, 5637.379888212294, 4299.806508707115, 4318.460192475941, 4326.870193894189, 4339.804708788112, 4357.54245804186, 3826.4642949987024, 3827.827747751358, 3832.3868181091448, 3851.730378873452, 3868.2650296443585, 5281.313429254173, 5338.652987555796, 5339.492748188916, 5339.973300133553, 5398.541124004503, 5694.060480020833, 5754.683492407874, 5769.451902069297, 5779.479846813723, 5833.0, 5274.4198138204765, 5313.814016509404, 5321.3348331458565, 5321.36143662763, 5323.1216849219445, 4643.674942754043, 4695.718256904596, 4709.858704238878, 4730.645201609893, 4767.237242041257, 5868.559858010666, 5869.236999190163, 5885.941140588539, 5916.526677865761, 5941.762329506858, 5711.9714401428555, 5715.114157305624, 5727.427257274239, 5729.9713501432225, 5734.913976290276, 5790.623609465371, 5821.79623713168, 5867.471927526543, 5872.853178670567, 5899.115132730125, 5570.972145139248, 5598.356189038313, 5604.467575580314, 5604.719764011702, 5654.067078932095, 5628.493435590816, 5629.521490673339, 5663.66018038919, 5675.829725108253, 5677.517411019944, 5417.810376636957, 5532.474414930575, 5543.223948647274, 5614.438556144353, 5638.520725738358, 5529.225908372911, 5534.640248383842, 5540.279763630702, 5545.944540554543, 5547.916781248366, 5425.050616142081, 5433.9184912225555, 5433.972830135982, 5475.123980163155, 5481.287432633732, 5438.972805135949, 5455.427180146027, 5589.608727389043, 5603.495685388335, 5620.831375058755, 5445.0, 5452.045891968969, 5452.645578037414, 5458.918116228339, 5500.559955203494], "value": 5236.71639754594, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7795826565039, 628.258654787351, 630.5428564290889, 640.5132099604302, 646.282626284824, 38173.618263817356, 39580.208395832065, 39651.206975860536, 39665.80167099164, 39674.0, 45047.77476112623, 45816.312755308696, 46151.30773038407, 46183.07633847321, 46190.0, 8812.295016398688, 9113.179813816756, 9114.635414583408, 9117.088291170896, 9118.726438206864, 8904.73285801427, 9090.272778177763, 9091.772705682377, 9123.178913897747, 9127.087291270853, 9081.137291957286, 9145.542722863831, 9156.03861594533, 9161.03809100045, 9174.357794954356, 9048.909510904905, 9053.09469053096, 9092.954535227347, 9118.58966346516, 9122.452652840817, 8929.910700892973, 9048.502332371718, 9049.411788233743, 9053.77365565866, 9055.501947392891, 42318.15363692709, 42856.78571607122, 42859.0, 42967.57032429667, 43042.78478607587, 3457.170279133015, 3603.72972027099, 4014.2372949139863, 4070.816813243411, 4156.521999970012, 32275.83862080698, 32582.567618743953, 32693.346133077444, 32696.509552356732, 33235.50146747801, 4238.279492486285, 4277.315629499265, 4292.377605247221, 4321.589449002371, 4327.221100201962, 332129.0, 334859.32570337236, 337156.0, 337491.0, 337737.0, 59986.10020849691, 60694.99999999912, 60831.39168608346, 60911.69544152251, 60923.390766092656, 51210.48789512132, 56344.718276408355, 57913.4208657908, 58140.12789808156, 63894.680526598, 16647.583810404594, 16833.663326733396, 16841.326346945985, 16845.663086738197, 16852.83147168537, 11955.940220298842, 13528.526501572398, 13582.932085339708, 13626.454941802216, 13630.182189068688, 17470.912645436692, 17846.732299015526, 17932.282708691768, 17976.460706178834, 17997.7300340495, 6458.838529036718, 6561.573497722633, 6585.407313341822, 6681.498887583353, 6815.250322464525, 1000.2498126405196, 1017.0947856407803, 1056.746380868586, 1109.5617231193794, 1113.4877956140103, 30104.548431773543, 30340.69659303423, 30757.384852303276, 32765.344693106006, 33050.504242436386, 1147.9311241325547, 1174.301290732013, 1193.3198077096145, 1233.586748439283, 1290.0518119182582, 17231.741523877154, 17423.73864392035, 17633.911830440764, 17674.646507069785, 17696.380626678005, 493765.0, 495634.0, 496828.0, 498029.0, 500593.0, 58708.706456467444, 59106.40893591095, 59175.40824591699, 59179.0, 59183.0, 1264.0393301091237, 1279.2899940533093, 1327.402668799025, 1370.6436326555167, 1405.2973513243378, 28512.287192819516, 29567.408651827274, 30850.38299233958, 32945.83527082445, 33512.49731254082, 47118.0, 47361.52638473709, 47459.28811067906, 47470.28794568015, 47532.7623361881, 291689.0, 294455.0, 294496.0, 294581.0, 296349.0, 31392.686073138975, 37889.43165852459, 38761.80619096886, 39075.609243907194, 39370.6062939367, 46017.76991115023, 47345.76327118342, 47351.28973065476, 47707.52292477031, 47810.0, 39862.800685996386, 39950.400743988284, 40315.798421007705, 40364.49881413057, 40761.184776303715, 39746.40380394238, 40352.3947140799, 40476.0, 40517.59482405138, 41461.79269103635, 39362.0, 39620.0, 40661.59338406578, 40786.388204176365, 40835.79582102071, 33376.332473350885, 34943.301133977686, 35317.646823532465, 35830.82084589561, 35911.281774363844, 27130.0, 27448.429936701006, 27528.449431011668, 27781.08298628615, 27885.581716273868], "value": 19983.373725206886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.77724531149295, 385.17764572637446, 392.6230818414322, 400.6594394764451, 412.9545749967503, 14658.0, 15464.84535154648, 17753.556161095978, 18273.634527309445, 18390.172442240113, 14276.857231427683, 17468.475945721617, 17711.114444277766, 17755.20101595428, 17795.110244487787, 5554.2779438672915, 5617.691026993513, 5672.489475947164, 5676.460736230051, 5750.769969201227, 4057.1885622875398, 5481.314835645544, 5622.690752008638, 5646.632968857011, 6016.097585362187, 6208.410201030895, 6221.502279817604, 6253.312135665074, 6266.091416744569, 6268.404501572343, 6154.753809847623, 6171.321154672983, 6180.536459765513, 6341.841453963688, 6361.68191590421, 5572.219889215513, 5576.71735500833, 5578.748956296977, 5582.190582365534, 5582.190582365575, 20968.370948871558, 21280.46798830026, 21464.0, 21763.455913602127, 21974.780252197594, 2267.807236384893, 2325.5813953488364, 2549.8342607730438, 2811.817231879921, 2945.234239097829, 13629.931850340685, 13697.726045479134, 13717.725645487035, 13905.652358691012, 14208.715825683428, 1923.8268555829902, 1966.7934866838918, 2021.3430635043524, 2048.3752455501067, 2054.3734161080865, 78507.21492785057, 79780.20219797843, 80111.19888801154, 80411.59794200992, 80874.19125808726, 9870.30907836459, 9971.850422243671, 10428.478576071166, 10475.52860121281, 10579.31234469757, 14301.0, 14427.639309017359, 14461.0, 14483.637909052359, 14489.855101449062, 7187.0, 7489.925100749032, 7900.407469439815, 8124.390670699603, 8261.256486916207, 7147.605552139988, 7194.352508274281, 7381.298776616213, 7417.554946703215, 7553.357964572963, 6220.657863817533, 6433.356664333529, 6442.35576442352, 6500.609963402211, 6522.771702990467, 1848.2422206895108, 1856.7493388392395, 1862.1806405181676, 1878.3519685708409, 1908.360699165795, 455.9977200113978, 468.1760102220117, 903.4241566465829, 1016.6340117557673, 1076.2573824061528, 10850.457477126112, 11092.778144437067, 11096.0, 11109.944450277697, 11239.100871930226, 469.6946984460128, 472.45195573135686, 476.44732110752057, 477.4223189940142, 508.71511953306265, 5946.316173640087, 6127.2647282325515, 6130.78542251028, 6138.508919286446, 6184.5980011299125, 487950.0, 492716.0, 496102.0, 497761.0, 500147.0, 93798.53100734453, 97542.0, 98434.5078274604, 99179.0, 99179.0, 1049.574922156528, 1083.9566417343217, 1095.9616413425492, 1100.3178029621527, 1106.5850306135198, 13342.26617536006, 15532.30104645271, 15574.299156538209, 15751.68496630084, 15766.605834854221, 39017.609823901395, 40157.397639034854, 40868.59131408648, 40947.7952610235, 41358.1728365437, 38726.80636596799, 49999.50000500094, 51277.7436112832, 53290.73354633202, 54441.18338225009, 6693.765718199839, 7166.498345115792, 8014.398920081134, 8203.261706446448, 8383.03595086573, 12574.434150463068, 12917.418716157608, 13053.608391748263, 13064.673383165116, 13380.799288010492, 11493.885061149282, 11562.595309164475, 11602.767944640891, 11720.94139529331, 11744.29534227949, 11254.268472549258, 11504.791996840211, 11516.82724759146, 11599.6520104397, 11618.70953226176, 11506.252093613888, 11593.768124637292, 11753.412329383325, 11867.287962722265, 11871.0, 8000.51996880189, 8191.426600138171, 8406.579671016547, 8479.236868681848, 8683.088275730957, 8534.573271336532, 10545.841812372973, 11616.361100139573, 11960.940195298968, 11995.82006269924], "value": 8654.061571291593, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.9865501344984, 1489.672272100138, 1511.1235483419619, 1628.7719719239308, 1770.575061985123, 7227.747028853991, 8002.559859207741, 8127.34981201504, 8189.3857960652895, 8221.054578723448, 7939.0, 8082.91917080829, 8092.514449133057, 8092.635831387587, 8126.3498920086395, 2004.4688157638238, 2220.922267720634, 2229.899654515543, 2252.8986195621237, 2291.1522736587403, 2316.81465482761, 2349.3304408243653, 2351.9647205291935, 2357.49313897512, 2358.304300231427, 2237.183428048767, 2289.954200915989, 2295.4605667668084, 2298.4139044543617, 2302.044651469638, 1950.8536859735505, 2220.400491867195, 2288.485090854561, 2296.494771150344, 2297.655351697242, 2294.369048511656, 2307.065638416444, 2321.4312493439047, 2337.053493335202, 2341.5668101401125, 7869.8032549186155, 7943.841123177504, 7945.205479452066, 7954.363650907913, 7956.880646790245, 4842.854714358575, 4976.178930476467, 4977.800887964477, 4988.975055124701, 5000.774965126578, 3021.214484234115, 3034.8027378220345, 3108.9533656995163, 3217.4047801156626, 3237.3687131009465, 1029.269218854614, 1032.4940779018302, 1038.4444322287616, 1086.2504871638544, 1123.084685980931, 11064.889351106467, 11194.720131996764, 11269.492872820743, 11274.267172633834, 11318.830217546825, 4449.065696203834, 4501.909961800746, 4544.545545445495, 4559.54404559548, 4568.657350698711, 9771.706848794547, 9781.706548803404, 9786.804263914824, 9799.265055120895, 9819.852702209473, 4588.2658774596575, 5085.46602606721, 5150.896982060338, 5157.097507936096, 5157.922631160535, 4599.724016559017, 4742.668013239109, 4753.35829662998, 4763.261694437368, 4763.476017638057, 3842.442845787345, 3872.341701910682, 3958.2281455116554, 3987.182627561343, 3995.6603688686787, 1198.7302856857311, 1256.1960345378964, 1260.602910083321, 1266.7339858629791, 1294.449858810002, 984.886738025122, 996.6113215845826, 1012.832882574367, 1021.3565453764081, 1028.3315844701003, 5615.831525054255, 5719.656820590778, 5822.7088645567555, 5845.240118784531, 5862.618929769551, 455.8769132334251, 456.38388175962183, 456.49557239250817, 461.420916749484, 473.4768081270147, 4001.4998125234347, 4168.624823765876, 4177.143685544456, 4216.9789151054665, 4219.198352313112, 9763.170130538841, 10152.796944061225, 10188.643397481053, 10259.281850270409, 10275.845862312071, 10119.59521619127, 10148.594056237667, 10157.796844063078, 10179.0, 10194.43930583825, 7460.888086678704, 7803.219678032265, 7807.141214466405, 7814.960925195452, 7825.0, 5479.917801232905, 5490.121580547093, 5711.343195532567, 5758.0499217630295, 5858.7070646468355, 8777.648894044167, 8997.775055623662, 9226.861597075915, 9311.534423278674, 9314.301427393108, 9208.12522810332, 9435.52822358893, 9535.38020028696, 9567.425954442755, 9807.901920980985, 6742.831429214309, 7090.397316227972, 7244.746433874789, 7309.744158954411, 7452.06849143857, 7745.728899488491, 7747.845043099219, 7749.612519373896, 7826.921730782847, 7837.255460731221, 7055.929440705732, 7282.235365286569, 7309.5248808827255, 7375.188729239672, 7431.777046688608, 7073.363397294268, 7083.716651334095, 7185.856282874418, 7192.496525243392, 7235.819104522429, 6494.0, 6511.218653761579, 6559.4752419807255, 6570.507211959218, 6580.374864387875, 5050.797968081382, 5134.820281290286, 5140.974295128501, 5173.40505841833, 5174.6119041072825, 5151.845444636517, 5153.742312884416, 5167.689938603696, 5179.533841954242, 5212.739363031757], "value": 4355.594675139281, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.3834607477195, 320.754622713624, 326.05606768405465, 326.27566801700226, 326.6798537433316, 5043.974780126104, 5089.796408143669, 5181.300524429201, 5237.214417837326, 5255.369355677314, 5189.844304670856, 5203.505666961642, 5223.921641175385, 5227.451117632641, 5233.241180028894, 4057.3711074783455, 4068.572799856002, 4070.2876996525565, 4076.103257283408, 4081.1225586498895, 3885.057471264368, 3898.5126859142606, 4070.633642972132, 4088.9386659200136, 4093.9181216375655, 4022.9597704023026, 4031.1736094100784, 4057.756534607933, 4070.8778736637946, 4073.2668119738437, 4030.1536677297654, 4030.5364883038533, 4041.595840415964, 4041.97979010106, 4044.1911617676287, 3519.7008254298416, 3571.2857428514403, 3580.498730177751, 3583.104223944014, 3589.192431702872, 5035.622328325354, 5038.39539255288, 5058.241263810458, 5065.569426598743, 5076.771545280471, 4556.567126123046, 4580.381648477446, 4598.977005114953, 4600.861974140781, 4609.308603709437, 5155.484451554852, 5321.308229930123, 5332.600054995852, 5340.421917315369, 5355.946440535584, 3913.4521167036637, 3914.354131568288, 3940.0937784309767, 3947.3092208863336, 3949.4273330367223, 5540.695261760601, 5548.223248745179, 5560.804427048204, 5568.331800183963, 5586.413426590231, 3990.68074554035, 4008.6793056555407, 4009.0979529605606, 4013.8595149169637, 4019.577944315805, 3737.4580685800406, 3973.4635824163947, 3994.9201015980098, 3998.8800335989968, 4043.6950937965075, 4562.931556026662, 4564.7032942858605, 4577.130345234461, 4578.404807375086, 4589.0, 5396.136618141157, 5440.0, 5457.372402173801, 5459.454054594588, 5480.862978425571, 1364.836219653628, 1378.5381897064394, 1408.845027047024, 1411.4283715095403, 1442.463776078473, 951.7573018880141, 959.6593209410698, 970.7186513801855, 974.7368210583103, 976.2482888176206, 5500.559955203574, 5515.862103447365, 5524.397924601901, 5530.585206109477, 5542.085555883315, 5869.148973398918, 5886.8822623547285, 5888.9705551472825, 5891.440313170242, 5906.616069955439, 5392.892142157135, 5485.259489968803, 5510.256115424367, 5528.253685752452, 5555.638883472561, 3122.2818751686787, 3123.7813353065067, 3124.0, 3144.9685503145133, 3159.3887117569743, 5874.412558744177, 6046.486048685823, 6088.939110608926, 6096.744204644221, 6097.0, 5970.761169553256, 6010.128531362928, 6013.428724271187, 6030.547708921848, 6034.1853849730605, 6028.668423236676, 6062.848428789315, 6068.21113255274, 6076.3316035236085, 6106.816795496142, 5779.566532510163, 5873.089671100986, 5896.17453556511, 5908.497777688945, 5923.111533269872, 5805.448482394166, 5811.56413269015, 5821.912671309849, 5832.445917637818, 5846.444587764156, 5518.862028449321, 6009.338972712911, 6031.366706495754, 6050.364711705383, 6070.605410648293, 3868.2650296443585, 3894.493715817039, 3914.64768170866, 3920.725549211642, 3931.76409415436, 5353.306218709078, 5469.972650136724, 5643.181738647955, 5647.887042259214, 5666.206731057573, 5456.181572764117, 5493.92868390676, 5501.037318469172, 5516.200150978166, 5518.227448157341, 5206.505381988705, 5429.5656347492895, 5486.149646804752, 5493.681516435947, 5522.2544956430365, 5345.492178243061, 5371.811986580451, 5419.430959749169, 5423.864403389947, 5432.0, 5467.835964921059, 5486.231927530069, 5496.203050557567, 5521.641093329082, 5576.33084029919, 5205.947940520698, 5374.677519348852, 5401.162819762943, 5406.432324606017, 5428.59285553593], "value": 4214.046485393683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.9821254468637, 747.6859718918054, 763.8205021819875, 782.194339829975, 785.1755656560609, 12129.272243665375, 12212.93893530531, 12244.510219591217, 12248.693782655428, 12250.326232057234, 10943.45282735864, 10958.397288149148, 11002.50488728007, 11008.834867476975, 11010.944945275283, 681.8943063825116, 701.2496628607392, 791.4143533785016, 798.3692882622751, 798.9680412783482, 797.103258833812, 802.835418739157, 803.2088392932985, 804.5172896262254, 804.6499772598938, 853.1468531468531, 854.218390172991, 854.3378881366929, 855.6534603485599, 857.3055824781916, 714.4534431160166, 813.3452570680599, 816.1145157504116, 824.3240542754943, 833.262562632072, 600.4505877122427, 601.1523751510349, 601.1703848688825, 611.2298503885092, 626.4236902050125, 12060.758784824255, 12086.093542984312, 12096.697582560419, 12097.092718046182, 12115.091368147425, 10799.190060745397, 11886.465109070112, 12307.93846030773, 12358.196717213352, 12713.0, 10380.32527885685, 10461.215408844368, 10522.31604945676, 10726.19553533488, 10798.190135739851, 3625.111847597329, 3625.347437461256, 3645.708343332527, 3662.1943172502006, 3685.631436856293, 54622.453775462534, 55572.44427555713, 56648.43351566473, 56963.0, 57045.42954570443, 9551.320230295867, 9618.807623847624, 9689.806203876024, 9736.95131524338, 9865.704028879145, 17618.119094045247, 17667.38164164248, 17678.381256655954, 17703.55741106457, 17733.46799596014, 7362.5214361066355, 7398.852022959618, 7423.109226892808, 7489.700411983568, 7683.346915512132, 4106.281400754856, 4155.127423241092, 4327.17783621111, 4347.195768782785, 4355.847545335898, 3040.7567394608377, 3113.579666745006, 3113.844307784602, 3114.361555881039, 3115.5638210650527, 520.7734635433599, 531.9441458646786, 573.9311282646025, 601.5578549765919, 622.1072760588479, 666.7666316789182, 711.4095300900241, 715.8926161075881, 718.2817182817183, 729.5513259345464, 8585.141485851489, 8807.69173078952, 8985.910140898508, 9035.548222588845, 9070.455772653662, 622.6793201501231, 660.2638058564665, 687.6630451078935, 702.2415790945767, 713.3356911933922, 4213.47331583552, 4237.279662457328, 4273.35899615054, 4371.344298355209, 4457.487388950312, 68681.0, 68936.0, 70519.94220086702, 70620.2937970624, 71416.0, 59782.0, 59980.70009649924, 60033.0, 61224.0, 61741.38258617446, 54715.45284547183, 55007.72496137574, 55040.72479637576, 55447.0, 55518.72240638771, 8192.877106843283, 8236.752897413087, 8369.66521339164, 8375.32997360222, 8511.91488085136, 35821.28357432889, 36423.81788091043, 36443.08892277714, 36784.63215367812, 37442.251154976206, 49581.25628115653, 50610.49389506205, 50630.0, 50687.49312506828, 50707.0, 11436.656900293005, 11500.137489688474, 11527.884721153017, 11776.352300623548, 11820.113491488344, 11271.830922536004, 11763.117766167401, 11952.58165964187, 11995.820062698893, 12181.817272741093, 9948.835690322314, 10772.461376931278, 11931.105167112328, 12387.380630968595, 13024.674383140497, 11408.657740267805, 11713.180077394842, 12111.454984525893, 12143.271403715453, 12168.148229623841, 11990.460429280529, 12098.818517722417, 12286.262824230575, 12459.377031148588, 12468.127231093737, 10055.849162262719, 10293.845592316271, 10344.448552556525, 10726.0, 11012.229143959847, 10360.637377691744, 10653.573857045942, 10693.679189624323, 10704.464776761286, 10741.946290268812], "value": 6444.421639392461, "unit": "score"}], "name": "dromaeo_css", "value": 6891.613456759339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 107.0, 113.0, 113.0, 111.0, 100.0, 111.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 155.0, 188.0, 136.0, 164.0, 159.0, 132.0, 185.0, 128.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 161.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 106.0, 111.0, 73.0, 76.0, 73.0, 122.0, 106.0, 76.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 153.0, 94.0, 92.0, 94.0, 142.0, 94.0, 93.0, 153.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 148.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 72.0, 55.0, 55.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 76.0, 74.0, 77.0, 77.0, 76.0, 78.0, 78.0, 85.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 125.0, 129.0, 121.0, 131.0, 123.0, 121.0, 163.0, 133.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 170.0, 165.0, 167.0, 167.0, 166.0, 173.0, 166.0, 170.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 71.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1544.8000000000004, "alertThreshold": 2.0}]} 05:37:04 INFO - Return code: 0 05:37:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:04 ERROR - # TBPL SUCCESS # 05:37:04 INFO - Running post-action listener: _resource_record_post_action 05:37:04 INFO - Running post-run listener: _resource_record_post_run 05:37:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301199360; Read time: 16; Write time: 490932 05:37:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13660160; Read time: 0; Write time: 3324 05:37:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287535104; Read time: 16; Write time: 486872 05:37:05 INFO - Running post-run listener: _upload_blobber_files 05:37:05 INFO - Blob upload gear active. 05:37:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:05 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 05:37:05 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:05 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:06 INFO - (blobuploader) - INFO - Done attempting. 05:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:07 INFO - (blobuploader) - INFO - Done attempting. 05:37:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:07 INFO - Return code: 0 05:37:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05c0408e64084d92d7d1df627d4dab7d31349a366c558e74dbb24d1f1de2c040113aa4c53a8efa20a148822e4ba9eef212a43ddd40cc14ef59b245158ff18a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14f35192eecce076a2110b298752441845fd6b2c668a0c89a9c567c17a1adbdb3ed8d8fd55067f51e4cc8103fc902fd995835ccff687eaf435f9cd2c3c13ef8"} 05:37:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:07 INFO - Contents: 05:37:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05c0408e64084d92d7d1df627d4dab7d31349a366c558e74dbb24d1f1de2c040113aa4c53a8efa20a148822e4ba9eef212a43ddd40cc14ef59b245158ff18a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14f35192eecce076a2110b298752441845fd6b2c668a0c89a9c567c17a1adbdb3ed8d8fd55067f51e4cc8103fc902fd995835ccff687eaf435f9cd2c3c13ef8"} 05:37:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:07 INFO - Copying logs to upload dir... 05:37:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.613788 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-28 05:37:07.410282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:37:07.414456) ========= 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=af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731 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/sha512/05c0408e64084d92d7d1df627d4dab7d31349a366c558e74dbb24d1f1de2c040113aa4c53a8efa20a148822e4ba9eef212a43ddd40cc14ef59b245158ff18a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14f35192eecce076a2110b298752441845fd6b2c668a0c89a9c567c17a1adbdb3ed8d8fd55067f51e4cc8103fc902fd995835ccff687eaf435f9cd2c3c13ef8"} build_url:https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/WDaaFu8QSt-oQEH-r3TCEw/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/sha512/05c0408e64084d92d7d1df627d4dab7d31349a366c558e74dbb24d1f1de2c040113aa4c53a8efa20a148822e4ba9eef212a43ddd40cc14ef59b245158ff18a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14f35192eecce076a2110b298752441845fd6b2c668a0c89a9c567c17a1adbdb3ed8d8fd55067f51e4cc8103fc902fd995835ccff687eaf435f9cd2c3c13ef8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:37:07.440169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:37:07.440660) ========= 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=af724c981e2a0f424dbabf99000001e7-1461845700.45430-528921731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:37:07.524932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:37:07.525335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:37:07.525822) ========= ========= Total master_lag: 0.18 =========