builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1461197531.19 results: success (0) buildid: 20160420143016 builduid: 96f8210f19a448f3934b26ffe75efe24 revision: 6d48e6b9edc64b919c1055073406bf991a3f16cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.191763) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.192232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.192524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.224351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.224648) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 17:12:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-04-20 17:12:11 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.359460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.359833) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.410017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.410415) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6d48e6b9edc64b919c1055073406bf991a3f16cd --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 6d48e6b9edc64b919c1055073406bf991a3f16cd --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=2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 17:12:12,073 truncating revision to first 12 chars 2016-04-20 17:12:12,073 Setting DEBUG logging. 2016-04-20 17:12:12,073 attempt 1/10 2016-04-20 17:12:12,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6d48e6b9edc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 17:12:12,317 unpacking tar archive at: fx-team-6d48e6b9edc6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.953619) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.953893) ========= script_repo_revision: 6d48e6b9edc64b919c1055073406bf991a3f16cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.954279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.954553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:12:11.962891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-20 17:12:11.963171) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:12 INFO - MultiFileLogger online at 20160420 17:12:12 in /builds/slave/test 17:12:12 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 17:12:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:12 INFO - {'append_to_log': False, 17:12:12 INFO - 'base_work_dir': '/builds/slave/test', 17:12:12 INFO - 'blob_upload_branch': 'Fx-Team', 17:12:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:12 INFO - 'branch': 'Fx-Team', 17:12:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:12 INFO - 'config_files': ('talos/linux_config.py',), 17:12:12 INFO - 'default_actions': ('clobber', 17:12:12 INFO - 'read-buildbot-config', 17:12:12 INFO - 'download-and-extract', 17:12:12 INFO - 'populate-webroot', 17:12:12 INFO - 'create-virtualenv', 17:12:12 INFO - 'install', 17:12:12 INFO - 'run-tests'), 17:12:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:12 INFO - 'download_minidump_stackwalk': True, 17:12:12 INFO - 'download_symbols': 'ondemand', 17:12:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:12 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:12 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:12 INFO - 'installer_path': 'installer.exe', 17:12:12 INFO - 'log_level': 'info', 17:12:12 INFO - 'log_name': 'talos', 17:12:12 INFO - 'log_to_console': True, 17:12:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:12 INFO - 'opt_config_files': (), 17:12:12 INFO - 'pip_index': False, 17:12:12 INFO - 'sps_profile': False, 17:12:12 INFO - 'sps_profile_interval': 0, 17:12:12 INFO - 'suite': 'dromaeojs', 17:12:12 INFO - 'system_bits': '32', 17:12:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:12 INFO - 'title': 'talos-linux64-ix-012', 17:12:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:12 INFO - 'use_talos_json': True, 17:12:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:12 INFO - 'work_dir': 'build'} 17:12:12 INFO - ##### 17:12:12 INFO - ##### Running clobber step. 17:12:12 INFO - ##### 17:12:12 INFO - Running pre-action listener: _resource_record_pre_action 17:12:12 INFO - Running main action method: clobber 17:12:12 INFO - rmtree: /builds/slave/test/build 17:12:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:13 INFO - Running post-action listener: _resource_record_post_action 17:12:13 INFO - ##### 17:12:13 INFO - ##### Running read-buildbot-config step. 17:12:13 INFO - ##### 17:12:13 INFO - Running pre-action listener: _resource_record_pre_action 17:12:13 INFO - Running main action method: read_buildbot_config 17:12:13 INFO - Using buildbot properties: 17:12:13 INFO - { 17:12:13 INFO - "project": "", 17:12:13 INFO - "product": "firefox", 17:12:13 INFO - "script_repo_revision": "production", 17:12:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:12:13 INFO - "repository": "", 17:12:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:12:13 INFO - "buildid": "20160420143016", 17:12:13 INFO - "pgo_build": "True", 17:12:13 INFO - "basedir": "/builds/slave/test", 17:12:13 INFO - "buildnumber": 50, 17:12:13 INFO - "slavename": "talos-linux64-ix-012", 17:12:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:12:13 INFO - "platform": "ubuntu64_hw", 17:12:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:12:13 INFO - "branch": "fx-team", 17:12:13 INFO - "repo_path": "integration/fx-team", 17:12:13 INFO - "revision": "6d48e6b9edc64b919c1055073406bf991a3f16cd", 17:12:13 INFO - "stage_platform": "linux64-pgo", 17:12:13 INFO - "builduid": "96f8210f19a448f3934b26ffe75efe24", 17:12:13 INFO - "slavebuilddir": "test" 17:12:13 INFO - } 17:12:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:12:13 INFO - Running post-action listener: _resource_record_post_action 17:12:13 INFO - ##### 17:12:13 INFO - ##### Running download-and-extract step. 17:12:13 INFO - ##### 17:12:13 INFO - Running pre-action listener: _resource_record_pre_action 17:12:13 INFO - Running main action method: download_and_extract 17:12:13 INFO - mkdir: /builds/slave/test/build/tests 17:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:13 INFO - https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:19 INFO - Downloaded 1361 bytes. 17:12:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:12:19 INFO - Using the following test package requirements: 17:12:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:12:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'jsshell-linux-x86_64.zip'], 17:12:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:12:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:12:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12:19 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')]} 17:12:19 INFO - https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:20 INFO - Downloaded 23847263 bytes. 17:12:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:12:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:12:21 INFO - Return code: 0 17:12:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:21 INFO - https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:41 INFO - Downloaded 23847263 bytes. 17:12:41 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'] 17:12:41 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 17:12:42 INFO - Return code: 0 17:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:42 INFO - https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:43 INFO - Downloaded 10845952 bytes. 17:12:43 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'] 17:12:43 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 17:12:44 INFO - Return code: 0 17:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:44 INFO - https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUBEJcVpRaK_G5GvssrCaw/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 17:12:45 INFO - Downloaded 58289853 bytes. 17:12:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:45 INFO - mkdir: /builds/slave/test/properties 17:12:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:45 INFO - Contents: 17:12:45 INFO - build_url:https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:46 INFO - Running post-action listener: _resource_record_post_action 17:12:46 INFO - Running post-action listener: set_extra_try_arguments 17:12:46 INFO - ##### 17:12:46 INFO - ##### Running populate-webroot step. 17:12:46 INFO - ##### 17:12:46 INFO - Running pre-action listener: _resource_record_pre_action 17:12:46 INFO - Running main action method: populate_webroot 17:12:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:46 INFO - '--tppagecycles', 17:12:46 INFO - '7'], 17:12:46 INFO - 'tests': ['tsvgm']}}, 17:12:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['damp', 'tps']}, 17:12:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'tests': ['damp', 'tps']}, 17:12:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['dromaeo_dom']}, 17:12:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['a11yr', 17:12:46 INFO - 'ts_paint', 17:12:46 INFO - 'tpaint', 17:12:46 INFO - 'sessionrestore', 17:12:46 INFO - 'sessionrestore_no_auto_restore', 17:12:46 INFO - 'tabpaint']}, 17:12:46 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:46 INFO - 'ts_paint', 17:12:46 INFO - 'tpaint', 17:12:46 INFO - 'sessionrestore', 17:12:46 INFO - 'sessionrestore_no_auto_restore', 17:12:46 INFO - 'tabpaint']}, 17:12:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:46 INFO - 'ts_paint', 17:12:46 INFO - 'tpaint', 17:12:46 INFO - 'sessionrestore', 17:12:46 INFO - 'sessionrestore_no_auto_restore', 17:12:46 INFO - 'tabpaint']}, 17:12:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:46 INFO - 'ts_paint', 17:12:46 INFO - 'tpaint', 17:12:46 INFO - 'sessionrestore', 17:12:46 INFO - 'sessionrestore_no_auto_restore', 17:12:46 INFO - 'tabpaint']}, 17:12:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['a11yr', 17:12:46 INFO - 'ts_paint', 17:12:46 INFO - 'tpaint', 17:12:46 INFO - 'sessionrestore', 17:12:46 INFO - 'sessionrestore_no_auto_restore', 17:12:46 INFO - 'tabpaint']}, 17:12:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['a11yr', 17:12:46 INFO - 'ts_paint', 17:12:46 INFO - 'tpaint', 17:12:46 INFO - 'sessionrestore', 17:12:46 INFO - 'sessionrestore_no_auto_restore', 17:12:46 INFO - 'tabpaint']}, 17:12:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['tsvgx', 17:12:46 INFO - 'tsvgr_opacity', 17:12:46 INFO - 'tart', 17:12:46 INFO - 'tscrollx', 17:12:46 INFO - 'cart']}, 17:12:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:46 INFO - 'tsvgr_opacity', 17:12:46 INFO - 'tart', 17:12:46 INFO - 'tscrollx', 17:12:46 INFO - 'cart']}, 17:12:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'talos_options': ['--disable-e10s'], 17:12:46 INFO - 'tests': ['tp5o']}, 17:12:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'tests': ['tp5o']}, 17:12:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'talos_options': ['--disable-e10s', 17:12:46 INFO - '--xperf_path', 17:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:46 INFO - 'tests': ['tp5n']}, 17:12:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:46 INFO - 'talos_options': ['--xperf_path', 17:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:46 INFO - 'tests': ['tp5n']}}, 17:12:46 INFO - 'talos.zip': {'path': '', 17:12:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:46 INFO - Running post-action listener: _resource_record_post_action 17:12:46 INFO - ##### 17:12:46 INFO - ##### Running create-virtualenv step. 17:12:46 INFO - ##### 17:12:46 INFO - Running pre-action listener: _resource_record_pre_action 17:12:46 INFO - Running main action method: create_virtualenv 17:12:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:46 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 17:12:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:46 INFO - Using real prefix '/usr' 17:12:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:49 INFO - Installing pip.................done. 17:12:49 INFO - Return code: 0 17:12:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:49 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')]} 17:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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')]} 17:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:12:49 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 17:12:49 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 17:12:49 INFO - Using env: {'DISPLAY': ':0', 17:12:49 INFO - 'HOME': '/home/cltbld', 17:12:49 INFO - 'LANG': 'en_US.UTF-8', 17:12:49 INFO - 'LANGUAGE': 'en_US:en', 17:12:49 INFO - 'LOGNAME': 'cltbld', 17:12:49 INFO - 'MAIL': '/var/mail/cltbld', 17:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:49 INFO - 'MOZ_NO_REMOTE': '1', 17:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:49 INFO - 'NO_EM_RESTART': '1', 17:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:49 INFO - 'PWD': '/builds/slave/test', 17:12:49 INFO - 'SHELL': '/bin/bash', 17:12:49 INFO - 'SHLVL': '1', 17:12:49 INFO - 'TERM': 'linux', 17:12:49 INFO - 'TMOUT': '86400', 17:12:49 INFO - 'USER': 'cltbld', 17:12:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:49 INFO - '_': '/tools/buildbot/bin/python'} 17:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:49 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 17:12:49 INFO - Cleaning up... 17:12:49 INFO - Return code: 0 17:12:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:12:49 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')]} 17:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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')]} 17:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:12:49 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 17:12:49 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 17:12:49 INFO - Using env: {'DISPLAY': ':0', 17:12:49 INFO - 'HOME': '/home/cltbld', 17:12:49 INFO - 'LANG': 'en_US.UTF-8', 17:12:49 INFO - 'LANGUAGE': 'en_US:en', 17:12:49 INFO - 'LOGNAME': 'cltbld', 17:12:49 INFO - 'MAIL': '/var/mail/cltbld', 17:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:49 INFO - 'MOZ_NO_REMOTE': '1', 17:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:49 INFO - 'NO_EM_RESTART': '1', 17:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:49 INFO - 'PWD': '/builds/slave/test', 17:12:49 INFO - 'SHELL': '/bin/bash', 17:12:49 INFO - 'SHLVL': '1', 17:12:49 INFO - 'TERM': 'linux', 17:12:49 INFO - 'TMOUT': '86400', 17:12:49 INFO - 'USER': 'cltbld', 17:12:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:49 INFO - '_': '/tools/buildbot/bin/python'} 17:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:49 INFO - Downloading/unpacking psutil>=0.7.1 17:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:51 INFO - Installing collected packages: psutil 17:12:51 INFO - Running setup.py install for psutil 17:12:51 INFO - building 'psutil._psutil_linux' extension 17:12:51 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 17:12:51 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 17:12:51 INFO - building 'psutil._psutil_posix' extension 17:12:51 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 17:12:51 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 17:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:51 INFO - Successfully installed psutil 17:12:51 INFO - Cleaning up... 17:12:51 INFO - Return code: 0 17:12:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:12:51 INFO - Using env: {'DISPLAY': ':0', 17:12:52 INFO - 'HOME': '/home/cltbld', 17:12:52 INFO - 'LANG': 'en_US.UTF-8', 17:12:52 INFO - 'LANGUAGE': 'en_US:en', 17:12:52 INFO - 'LOGNAME': 'cltbld', 17:12:52 INFO - 'MAIL': '/var/mail/cltbld', 17:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:52 INFO - 'MOZ_NO_REMOTE': '1', 17:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:52 INFO - 'NO_EM_RESTART': '1', 17:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:52 INFO - 'PWD': '/builds/slave/test', 17:12:52 INFO - 'SHELL': '/bin/bash', 17:12:52 INFO - 'SHLVL': '1', 17:12:52 INFO - 'TERM': 'linux', 17:12:52 INFO - 'TMOUT': '86400', 17:12:52 INFO - 'USER': 'cltbld', 17:12:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:52 INFO - '_': '/tools/buildbot/bin/python'} 17:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:12:54 INFO - Installing collected packages: mozsystemmonitor 17:12:54 INFO - Running setup.py install for mozsystemmonitor 17:12:54 INFO - Successfully installed mozsystemmonitor 17:12:54 INFO - Cleaning up... 17:12:54 INFO - Return code: 0 17:12:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:12:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:12:54 INFO - Using env: {'DISPLAY': ':0', 17:12:54 INFO - 'HOME': '/home/cltbld', 17:12:54 INFO - 'LANG': 'en_US.UTF-8', 17:12:54 INFO - 'LANGUAGE': 'en_US:en', 17:12:54 INFO - 'LOGNAME': 'cltbld', 17:12:54 INFO - 'MAIL': '/var/mail/cltbld', 17:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:54 INFO - 'MOZ_NO_REMOTE': '1', 17:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:54 INFO - 'NO_EM_RESTART': '1', 17:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:54 INFO - 'PWD': '/builds/slave/test', 17:12:54 INFO - 'SHELL': '/bin/bash', 17:12:54 INFO - 'SHLVL': '1', 17:12:54 INFO - 'TERM': 'linux', 17:12:54 INFO - 'TMOUT': '86400', 17:12:54 INFO - 'USER': 'cltbld', 17:12:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:54 INFO - '_': '/tools/buildbot/bin/python'} 17:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:57 INFO - Downloading docopt-0.6.1.tar.gz 17:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:57 INFO - Running setup.py install for blobuploader 17:12:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:57 INFO - Running setup.py install for requests 17:12:57 INFO - Running setup.py install for docopt 17:12:57 INFO - Successfully installed blobuploader requests docopt 17:12:57 INFO - Cleaning up... 17:12:57 INFO - Return code: 0 17:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:12: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 17:12: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 17:12:57 INFO - Using env: {'DISPLAY': ':0', 17:12:57 INFO - 'HOME': '/home/cltbld', 17:12:57 INFO - 'LANG': 'en_US.UTF-8', 17:12:57 INFO - 'LANGUAGE': 'en_US:en', 17:12:57 INFO - 'LOGNAME': 'cltbld', 17:12:57 INFO - 'MAIL': '/var/mail/cltbld', 17:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:57 INFO - 'MOZ_NO_REMOTE': '1', 17:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:57 INFO - 'NO_EM_RESTART': '1', 17:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:57 INFO - 'PWD': '/builds/slave/test', 17:12:57 INFO - 'SHELL': '/bin/bash', 17:12:57 INFO - 'SHLVL': '1', 17:12:57 INFO - 'TERM': 'linux', 17:12:57 INFO - 'TMOUT': '86400', 17:12:57 INFO - 'USER': 'cltbld', 17:12:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:57 INFO - '_': '/tools/buildbot/bin/python'} 17:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:57 INFO - Running setup.py (path:/tmp/pip-klpX2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:57 INFO - Running setup.py (path:/tmp/pip-zdXsm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:58 INFO - Running setup.py (path:/tmp/pip-cfy6VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:58 INFO - Running setup.py (path:/tmp/pip-Mnjh2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:58 INFO - Running setup.py (path:/tmp/pip-b0fRIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:58 INFO - Running setup.py (path:/tmp/pip-9PBCKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:58 INFO - Running setup.py (path:/tmp/pip-4mWsAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:58 INFO - Running setup.py (path:/tmp/pip-Bn_RhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:58 INFO - Running setup.py (path:/tmp/pip-tlQDpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:58 INFO - Running setup.py (path:/tmp/pip-Onvd44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:58 INFO - Running setup.py (path:/tmp/pip-UHQJCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:58 INFO - Running setup.py (path:/tmp/pip-rJDI32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:58 INFO - Running setup.py (path:/tmp/pip-SKqhzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:58 INFO - Running setup.py (path:/tmp/pip-Hq0TEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:58 INFO - Running setup.py (path:/tmp/pip-mhpo4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:59 INFO - Running setup.py (path:/tmp/pip-Ke6TzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:59 INFO - Running setup.py (path:/tmp/pip-gBkVP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:59 INFO - Running setup.py install for manifestparser 17:12:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Running setup.py install for mozcrash 17:12:59 INFO - Running setup.py install for mozdebug 17:12:59 INFO - Running setup.py install for mozdevice 17:12:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Running setup.py install for mozfile 17:12:59 INFO - Running setup.py install for mozhttpd 17:12:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Running setup.py install for mozinfo 17:12:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Running setup.py install for mozInstall 17:12:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:59 INFO - Running setup.py install for mozleak 17:13:00 INFO - Running setup.py install for mozlog 17:13:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Running setup.py install for moznetwork 17:13:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Running setup.py install for mozprocess 17:13:00 INFO - Running setup.py install for mozprofile 17:13:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Running setup.py install for mozrunner 17:13:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Running setup.py install for mozscreenshot 17:13:00 INFO - Running setup.py install for moztest 17:13:00 INFO - Running setup.py install for mozversion 17:13:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:00 INFO - Cleaning up... 17:13:00 INFO - Return code: 0 17:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:13: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 17:13: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 17:13:00 INFO - Using env: {'DISPLAY': ':0', 17:13:00 INFO - 'HOME': '/home/cltbld', 17:13:00 INFO - 'LANG': 'en_US.UTF-8', 17:13:00 INFO - 'LANGUAGE': 'en_US:en', 17:13:00 INFO - 'LOGNAME': 'cltbld', 17:13:00 INFO - 'MAIL': '/var/mail/cltbld', 17:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:00 INFO - 'MOZ_NO_REMOTE': '1', 17:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:00 INFO - 'NO_EM_RESTART': '1', 17:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:00 INFO - 'PWD': '/builds/slave/test', 17:13:00 INFO - 'SHELL': '/bin/bash', 17:13:00 INFO - 'SHLVL': '1', 17:13:00 INFO - 'TERM': 'linux', 17:13:00 INFO - 'TMOUT': '86400', 17:13:00 INFO - 'USER': 'cltbld', 17:13:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:00 INFO - '_': '/tools/buildbot/bin/python'} 17:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:01 INFO - Running setup.py (path:/tmp/pip-uhBsWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:01 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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:01 INFO - Running setup.py (path:/tmp/pip-3zWENh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:01 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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:01 INFO - Running setup.py (path:/tmp/pip-SPeFql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:01 INFO - Running setup.py (path:/tmp/pip-PYgMGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:01 INFO - Running setup.py (path:/tmp/pip-gi0PcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:01 INFO - Running setup.py (path:/tmp/pip-TGVCI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:01 INFO - Running setup.py (path:/tmp/pip-mn9CmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:01 INFO - Running setup.py (path:/tmp/pip-_sOKnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:01 INFO - Running setup.py (path:/tmp/pip-hs9gp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:01 INFO - Running setup.py (path:/tmp/pip-kDdmQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:01 INFO - Running setup.py (path:/tmp/pip-vTG3GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13: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)) 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:01 INFO - Running setup.py (path:/tmp/pip-QbMAnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:02 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)) 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:02 INFO - Running setup.py (path:/tmp/pip-Twh2r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:02 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)) 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:02 INFO - Running setup.py (path:/tmp/pip-iXy373-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:02 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)) 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:02 INFO - Running setup.py (path:/tmp/pip-ppUJuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:02 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)) 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:02 INFO - Running setup.py (path:/tmp/pip-uGFoo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:02 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)) 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:02 INFO - Running setup.py (path:/tmp/pip-Ti6GXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:04 INFO - Downloading blessings-1.6.tar.gz 17:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:04 INFO - Installing collected packages: blessings 17:13:04 INFO - Running setup.py install for blessings 17:13:04 INFO - Successfully installed blessings 17:13:04 INFO - Cleaning up... 17:13:04 INFO - Return code: 0 17:13:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:04 INFO - Reading from file tmpfile_stdout 17:13:04 INFO - Current package versions: 17:13:04 INFO - argparse == 1.2.1 17:13:04 INFO - blessings == 1.6 17:13:04 INFO - blobuploader == 1.2.4 17:13:04 INFO - docopt == 0.6.1 17:13:04 INFO - manifestparser == 1.1 17:13:04 INFO - mozInstall == 1.12 17:13:04 INFO - mozcrash == 0.17 17:13:04 INFO - mozdebug == 0.1 17:13:04 INFO - mozdevice == 0.48 17:13:04 INFO - mozfile == 1.2 17:13:04 INFO - mozhttpd == 0.7 17:13:04 INFO - mozinfo == 0.9 17:13:04 INFO - mozleak == 0.1 17:13:04 INFO - mozlog == 3.1 17:13:04 INFO - moznetwork == 0.27 17:13:04 INFO - mozprocess == 0.22 17:13:04 INFO - mozprofile == 0.28 17:13:04 INFO - mozrunner == 6.11 17:13:04 INFO - mozscreenshot == 0.1 17:13:04 INFO - mozsystemmonitor == 0.0 17:13:04 INFO - moztest == 0.7 17:13:04 INFO - mozversion == 1.4 17:13:04 INFO - psutil == 3.1.1 17:13:04 INFO - requests == 1.2.3 17:13:04 INFO - wsgiref == 0.1.2 17:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:13: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 17:13: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 17:13:04 INFO - Using env: {'DISPLAY': ':0', 17:13:04 INFO - 'HOME': '/home/cltbld', 17:13:04 INFO - 'LANG': 'en_US.UTF-8', 17:13:04 INFO - 'LANGUAGE': 'en_US:en', 17:13:04 INFO - 'LOGNAME': 'cltbld', 17:13:04 INFO - 'MAIL': '/var/mail/cltbld', 17:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:04 INFO - 'MOZ_NO_REMOTE': '1', 17:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:04 INFO - 'NO_EM_RESTART': '1', 17:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:04 INFO - 'PWD': '/builds/slave/test', 17:13:04 INFO - 'SHELL': '/bin/bash', 17:13:04 INFO - 'SHLVL': '1', 17:13:04 INFO - 'TERM': 'linux', 17:13:04 INFO - 'TMOUT': '86400', 17:13:04 INFO - 'USER': 'cltbld', 17:13:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:04 INFO - '_': '/tools/buildbot/bin/python'} 17:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13: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)) 17:13:04 INFO - Cleaning up... 17:13:04 INFO - Return code: 0 17:13:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:13: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 17:13: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 17:13:04 INFO - Using env: {'DISPLAY': ':0', 17:13:04 INFO - 'HOME': '/home/cltbld', 17:13:04 INFO - 'LANG': 'en_US.UTF-8', 17:13:04 INFO - 'LANGUAGE': 'en_US:en', 17:13:04 INFO - 'LOGNAME': 'cltbld', 17:13:04 INFO - 'MAIL': '/var/mail/cltbld', 17:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:04 INFO - 'MOZ_NO_REMOTE': '1', 17:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:04 INFO - 'NO_EM_RESTART': '1', 17:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:04 INFO - 'PWD': '/builds/slave/test', 17:13:04 INFO - 'SHELL': '/bin/bash', 17:13:04 INFO - 'SHLVL': '1', 17:13:04 INFO - 'TERM': 'linux', 17:13:04 INFO - 'TMOUT': '86400', 17:13:04 INFO - 'USER': 'cltbld', 17:13:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:04 INFO - '_': '/tools/buildbot/bin/python'} 17:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:05 INFO - Downloading/unpacking jsonschema 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:07 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:07 INFO - warning: no files found matching '*.txt' 17:13:07 INFO - no previously-included directories found matching 'build' 17:13:07 INFO - no previously-included directories found matching 'dist' 17:13:07 INFO - no previously-included directories found matching '.git*' 17:13:07 INFO - Installing collected packages: jsonschema, functools32 17:13:07 INFO - Running setup.py install for functools32 17:13:07 INFO - warning: no files found matching '*.txt' 17:13:07 INFO - no previously-included directories found matching 'build' 17:13:07 INFO - no previously-included directories found matching 'dist' 17:13:07 INFO - no previously-included directories found matching '.git*' 17:13:07 INFO - Successfully installed jsonschema functools32 17:13:07 INFO - Cleaning up... 17:13:07 INFO - Return code: 0 17:13:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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 0x7f3ab4ac5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23029a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', '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 17:13: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 17:13: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 17:13:07 INFO - Using env: {'DISPLAY': ':0', 17:13:07 INFO - 'HOME': '/home/cltbld', 17:13:07 INFO - 'LANG': 'en_US.UTF-8', 17:13:07 INFO - 'LANGUAGE': 'en_US:en', 17:13:07 INFO - 'LOGNAME': 'cltbld', 17:13:07 INFO - 'MAIL': '/var/mail/cltbld', 17:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:07 INFO - 'MOZ_NO_REMOTE': '1', 17:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:07 INFO - 'NO_EM_RESTART': '1', 17:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:07 INFO - 'PWD': '/builds/slave/test', 17:13:07 INFO - 'SHELL': '/bin/bash', 17:13:07 INFO - 'SHLVL': '1', 17:13:07 INFO - 'TERM': 'linux', 17:13:07 INFO - 'TMOUT': '86400', 17:13:07 INFO - 'USER': 'cltbld', 17:13:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:07 INFO - '_': '/tools/buildbot/bin/python'} 17:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:07 INFO - Downloading/unpacking flake8 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:10 INFO - no previously-included directories found matching 'docs/_build' 17:13:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:10 INFO - Running setup.py install for pep8 17:13:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:10 INFO - no previously-included directories found matching 'docs/_build' 17:13:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:10 INFO - Cleaning up... 17:13:10 INFO - Return code: 0 17:13:10 INFO - Running post-action listener: _resource_record_post_action 17:13:10 INFO - Running post-action listener: _start_resource_monitoring 17:13:10 INFO - Starting resource monitoring. 17:13:10 INFO - ##### 17:13:10 INFO - ##### Running install step. 17:13:10 INFO - ##### 17:13:10 INFO - Running pre-action listener: _resource_record_pre_action 17:13:10 INFO - Running main action method: install 17:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:10 INFO - Reading from file tmpfile_stdout 17:13:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:10 INFO - Reading from file tmpfile_stdout 17:13:10 INFO - Output received: 17:13:10 INFO - Usage: mozinstall [options] installer 17:13:10 INFO - Options: 17:13:10 INFO - -h, --help show this help message and exit 17:13:10 INFO - -d DEST, --destination=DEST 17:13:10 INFO - Directory to install application into. [default: 17:13:10 INFO - "/builds/slave/test"] 17:13:10 INFO - --app=APP Application being installed. [default: firefox] 17:13:10 INFO - mkdir: /builds/slave/test/build/application 17:13:10 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'] 17:13:10 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 17:13:27 INFO - Reading from file tmpfile_stdout 17:13:27 INFO - Output received: 17:13:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:27 INFO - Running post-action listener: _resource_record_post_action 17:13:27 INFO - ##### 17:13:27 INFO - ##### Running run-tests step. 17:13:27 INFO - ##### 17:13:27 INFO - Running pre-action listener: _resource_record_pre_action 17:13:27 INFO - Running main action method: run_tests 17:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:27 INFO - Python 2.7.3 17:13:27 INFO - Return code: 0 17:13:27 INFO - grabbing minidump binary from tooltool 17:13:27 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')]} 17:13:27 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 0x2391810>, '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 0x2392710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2392ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:27 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 17:13:27 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 17:13:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:27 INFO - Return code: 0 17:13:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:13:28 INFO - Return code: 0 17:13:28 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/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 17:13:28 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/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 17:13:28 INFO - Using env: {'DISPLAY': ':0', 17:13:28 INFO - 'HOME': '/home/cltbld', 17:13:28 INFO - 'LANG': 'en_US.UTF-8', 17:13:28 INFO - 'LANGUAGE': 'en_US:en', 17:13:28 INFO - 'LOGNAME': 'cltbld', 17:13:28 INFO - 'MAIL': '/var/mail/cltbld', 17:13:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:28 INFO - 'MOZ_NO_REMOTE': '1', 17:13:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:28 INFO - 'NO_EM_RESTART': '1', 17:13:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:28 INFO - 'PWD': '/builds/slave/test', 17:13:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:28 INFO - 'SHELL': '/bin/bash', 17:13:28 INFO - 'SHLVL': '1', 17:13:28 INFO - 'TERM': 'linux', 17:13:28 INFO - 'TMOUT': '86400', 17:13:28 INFO - 'USER': 'cltbld', 17:13:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589', 17:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:28 INFO - '_': '/tools/buildbot/bin/python'} 17:13:28 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/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 17:13:28 INFO - mozversion application_buildid: 20160420143016 17:13:28 INFO - mozversion application_changeset: 6d48e6b9edc64b919c1055073406bf991a3f16cd 17:13:28 INFO - mozversion application_display_name: Nightly 17:13:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:28 INFO - mozversion application_name: Firefox 17:13:28 INFO - mozversion application_remotingname: firefox 17:13:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:13:28 INFO - mozversion application_vendor: Mozilla 17:13:28 INFO - mozversion application_version: 48.0a1 17:13:28 INFO - mozversion platform_buildid: 20160420143016 17:13:28 INFO - mozversion platform_changeset: 6d48e6b9edc64b919c1055073406bf991a3f16cd 17:13:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:28 INFO - mozversion platform_version: 48.0a1 17:13:28 INFO - using testdate: 1461197608 17:13:28 INFO - actual date: 1461197608 17:13:28 INFO - starting webserver on 'localhost:41591' 17:13:28 INFO - SUITE-START | Running 2 tests 17:13:28 INFO - TEST-START | dromaeo_css 17:13:28 INFO - operating with platform_type : linux_ 17:13:28 INFO - Initialising browser for dromaeo_css test... 17:13:28 INFO - TEST-INFO | started process 4039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptL6ADb/profile http://localhost:41591/getInfo.html) 17:13:32 INFO - PROCESS | 4039 | __metrics Screen width/height:1600/1200 17:13:32 INFO - PROCESS | 4039 | colorDepth:24 17:13:32 INFO - PROCESS | 4039 | Browser inner width/height: 1024/697 17:13:32 INFO - PROCESS | 4039 | __metrics 17:13:33 ERROR - PROCESS | 4039 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:13:33 INFO - TEST-INFO | 4039: exit 0 17:13:33 INFO - Browser initialized. 17:13:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:33 INFO - TEST-INFO | started process 4118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptL6ADb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:45 INFO - PROCESS | 4118 | RSS: Main: 153829376 17:13:45 INFO - PROCESS | 4118 | 17:14:36 INFO - PROCESS | 4118 | 1461197676687 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] 17:16:44 INFO - PROCESS | 4118 | Cycle 1(1): loaded http://localhost:41591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41591/tests/dromaeo/cssquery-ext.html) 17:16:45 INFO - PROCESS | 4118 | RSS: Main: 255303680 17:16:45 INFO - PROCESS | 4118 | 17:19:47 INFO - PROCESS | 4118 | Cycle 1(1): loaded http://localhost:41591/tests/dromaeo/cssquery-ext.html (next: http://localhost:41591/tests/dromaeo/cssquery-jquery.html) 17:19:47 INFO - PROCESS | 4118 | RSS: Main: 233078784 17:19:47 INFO - PROCESS | 4118 | 17:22:49 INFO - PROCESS | 4118 | Cycle 1(1): loaded http://localhost:41591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41591/tests/dromaeo/cssquery-mootools.html) 17:22:50 INFO - PROCESS | 4118 | RSS: Main: 230375424 17:22:50 INFO - PROCESS | 4118 | 17:25:52 INFO - PROCESS | 4118 | Cycle 1(1): loaded http://localhost:41591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41591/tests/dromaeo/cssquery-prototype.html) 17:25:52 INFO - PROCESS | 4118 | RSS: Main: 227192832 17:25:52 INFO - PROCESS | 4118 | 17:28:55 INFO - PROCESS | 4118 | Cycle 1(1): loaded http://localhost:41591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41591/tests/dromaeo/cssquery-yui.html) 17:28:56 INFO - PROCESS | 4118 | RSS: Main: 220393472 17:28:56 INFO - PROCESS | 4118 | 17:31:58 INFO - PROCESS | 4118 | Cycle 1(1): loaded http://localhost:41591/tests/dromaeo/cssquery-yui.html (next: http://localhost:41591/tests/dromaeo/cssquery-dojo.html) 17:31:59 INFO - PROCESS | 4118 | RSS: Main: 266076160 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | __start_tp_report 17:31:59 INFO - PROCESS | 4118 | _x_x_mozilla_page_load 17:31:59 INFO - PROCESS | 4118 | _x_x_mozilla_page_load_details 17:31:59 INFO - PROCESS | 4118 | |i|pagename|runs| 17:31:59 INFO - PROCESS | 4118 | |0;dojo.html;3058.801177923435;3121.3289142834287;3160.383725173591;3164.636066852311;3195.121341631051;5189.584833213344;5277.234800953859;5292.576593872491;5298.761555729991;5311.973440132799;5230.555402790757;5271.288376069229;5284.8150314739;5312.60155488338;5319.946800532003;4760.976195119019;4769.070031343898;4799.712017278957;4808.158572249859;4976.203807390818;4902.656814023002;4911.58251548617;4926.187179115442;4975;4996.075725990703;4732.43210814701;4776.737279449629;4781.665283430161;4834.299026641117;4847.369841920563;4839.637027222972;4860.659753817235;4862.562369386772;4866.270059491069;4894.951050489485;4628.213203755369;4811.158047341702;4826.0347930414055;4839.395075615548;4882.560569548722;5234.42421333653;5242.501962313574;5249.212618107276;5267.420583735786;5281.471852814726;5657.688827114507;5661.264035675335;5686.5735069869515;5692.231548740909;5693.28833895763;5541.639793413416;5613;5705.800296989585;5731.168980497804;5735.913961290584;5295.073362161645;5316.946830531684;5318.042752304545;5319.5744340452675;5355.518003379676;5791.986402379567;5793.362730099686;5794.130880367894;5794.333651630032;5794.507466865363;5428.5928555358505;5449.509544141047;5522.447755224445;5554.361248456479;5555.138953462219;5674.290713660793;5683.318001839723;5686.459786320293;5686.715664216773;5687.260656114679;5647.49172574462;5654.180143879197;5655.830325090172;5657.038303488417;5663.405342439067;5556.416576259516;5608.551315894719;5643.068893632505;5662.971685141548;5680.602357834994;4264.744115353089;4267.850625228102;4268.295731204316;4268.87193384199;4303.268444364466;3784.526934133233;3835.8082095895093;3845.442410850411;3864.768113913174;3891.902702432462;5273.077211487975;5336.46635336471;5345.652532585447;5381.811636592701;5403.2165336026055;5614.719264036864;5628.437156284421;5633.63381380209;5644.294463192101;5646.181303710939;5143.305653736697;5286.788528458896;5312.707801070901;5319.813806516753;5329.413764485904;4870.756462176877;4889.3888263967;4894.94758626897;4910.803567857317;4937.802487900443;5844.918690042356;5855.531557475391;5862.12068189775;5865.824025279248;5908.970455147697;5499.395066542757;5647.802326918538;5693.971530142323;5694.857628559319;5769.249997500298;5870.765169393177;5878.294604647299;5880.441358070976;5882.441168089024;5889.764409423747;5575.247341608993;5576.024195765806;5576.498115169654;5578.581606379619;5592.832215033555;5450.31871016123;5635.718214089361;5640.943590564042;5694.402087780723;5740;5567.805126820542;5572.3034620672415;5577.470140336662;5580.720963951868;5585.245991791218;5551.7779288828;5560.110382338807;5561.547293032494;5561.555075593862;5563.805266815642;5387.649802762808;5447.945520544744;5473.042217611823;5551.7779288828;5570.498655121059;5520;5545.3622833374675;5550.38945715979;5552;5558.749856256397;5454.781808727606;5454.781808727606;5456.372517160418;5461.9180712290145;5495.917561236504 17:31:59 INFO - PROCESS | 4118 | |1;ext.html;606.1150719948874;619.8419403052221;629.6851574212893;659.5712786688654;670.7283550162186;30456.695433045665;31162.53256201156;37412;38105.856824295246;38202.617973820255;40890.59109408905;41581.58418415815;41793;41851.79074104633;41887.79056104715;8459.746207613782;8687.826243475158;8703;8707.172818582225;8712;7457.216992215794;7688.500247483924;10248.487575621226;10602.628907988223;10613.41626210558;10173.84739228912;10243.180545556337;10330.121939635103;10338.638147664833;10343.22425818063;7475.663595138232;9929.156021738161;10208.234382421348;10338;10338.53476593555;10147.695569132939;10288.537015834305;10290.07389334956;10290.588376465008;10296.79406411875;39206.60793392058;39888.80055599703;39898.20203595941;39937.201255974716;39943.8002809987;3652.086978255436;3657.3416784978695;3676.8529258829612;3713.4615480755137;3932.508436445444;30045.399092018037;32413.834192260725;32565;32885.17787055319;33495.330093398;4333.349997500369;4360.193364227628;4364.476262848447;4398.670099742532;4461.517791832317;323774;328341;328870;329656;329807.350963246;34387.31225375478;64239;65269;65341;65538.34461655322;34630;34873;34896.127596809776;34918.476222856676;34936;15017.948743588062;15183;15183.089014659156;15214.695706085817;15222;12245.265284082983;12246;12250.509979600716;12254.571090011985;12274.324912129918;7792.41556883236;7828.725994590162;7835.843283134305;7886.487378320391;7895.842083158304;3037.4684430224625;3041.194083567856;3079.307155889907;3091.165385345944;3096.34976654905;977.3744803325877;1013.0882206014646;1095.5672509358758;1152.0207823350086;1157.5369852059243;32746.345073098404;34602.82698586491;34678.82660586681;35886.64113358833;37300.81349593234;1131.3890499130378;1141.9429028548539;1164.2897832322276;1218.9695257618453;1242.3291422631858;16149.434769783002;16964.491065268063;16989.40537081196;17076.658466830595;17089.316427343016;498683;501852;506945;508928;510961;56832;57826;57857.421425786044;57865;57872;1402.6212922510865;1442.1058943455125;1444.8555144485676;1446.3925151436422;1517.537151168882;30517.389652207276;31631;32070.358592827546;32187.839060804545;32241.35517289688;49397.25904111513;49892;50412.243816343514;50507;50512;413904;419869;420530;421093;422027;23677.763222367557;26548.867255663597;26919.865400672872;41354.37968430416;42486.36270455884;45774.31338529858;46290;46434.30348544707;47042.76478617585;47085.76457117692;41192.79403602963;42114.789426052674;42332.36501452419;42439.7878010608;43765.562344377424;41963.37054944239;42191.36712949247;42386.57613423826;42411.57588424076;43319.35020974625;43938.34092488551;44705.329420059374;44916.326255106855;44973;45270.77364613156;36707.26585468329;37769.81115094407;38543.80728096342;38855;39023.80488097541;28500.287492812844;29349.70650293555;29404.26489337698;29497.705022949496;29835 17:31:59 INFO - PROCESS | 4118 | |2;jquery.html;376.0936143893218;377.2643345476322;379.1563770610392;388.9902752431191;389.3536729029811;17355.82644173558;18991;19341.129649165785;19873.900630496828;19942.401727948185;18264;18524.444266671988;18802.529936751587;18855.15151818168;19144;3842.6733727633186;5467.371252305986;5545.112781954888;5625.634333768312;5627.971860140714;5748.19525266463;6108.602940808855;6121.204243448346;6123.173371594822;6126.540509461808;5792.304923409197;6010.729517171716;6055.606385584945;6120.602160859552;6134.570580059398;3820.0640842993366;4015.558288588253;6033.5173186145;6086;6123.142760013601;3702.129999450127;5151.278820965068;5441.782328706847;5444.373897001856;5450.5367043800925;20296.391108266776;20735;21068.367948961557;21117.15531378743;21247.36257912265;2073.5541858500496;2134.786917740337;2227.866328020324;2468.1114798672465;2496.163785131983;8536.061033286396;8612.8708069379;8632.266257368132;8722.38943273971;8812.250958668521;1839.2275244397385;1912.6844070728314;1945.620603982224;1947.9513012174668;1952.6778081616517;73528.63235683841;77084.61457692676;78340.21659783443;78359.21640783633;78770.60614696947;9882.764654418197;10131.797364052825;10337.312298802215;10566.313189642802;10575.20685948557;14343.641408964859;14354.138751674724;14485.20331381763;14531.273436328142;14535.418583256764;7641.7707468776025;7945.960270198728;8002.239787220205;8064.55644939534;8080.55556944362;7695.307422332017;7763.456558040883;7803.765887023284;7848.529088254723;7878.921210787818;3893.53277606689;4022.778747168934;4104.261232978092;4177.099419764;4186.497620285585;1602.8477294656989;1804.9639007220044;1810.8822926509736;1855.554666879939;1859.386402487176;990.9702708918744;1002.5588740953957;1033.7674023344837;1057.2229411382627;1065.6802959112235;18152.727709084375;18603.906980465283;18664.906675466806;18752.156152973148;18907.527311817314;957.5039274563953;993.7018894331671;1023.4013102335217;1059.941703206331;1061.87257529097;10182.694519164437;10476.214283928583;10507.47462626881;10508.842367364496;10594.841077383846;359933;363603;364591;366307;523960;70836.291637084;76906;78047.219527804;78081.2191878074;78446.6077669608;1033.3644808442752;1061.787642471509;1070.347088276151;1078.9406582637873;1090.8200146975819;16080.839191608402;16363.754543682093;16577.254023568727;16862.409815656392;17131.229094691018;34956;36653.63346366502;36688.63311366852;37787;37866.0533486665;51929.740351298;53633.90477904593;53955;54073.45926540842;54551;7169.283071692789;7817.843643127219;7990.121086680577;8067.3949453792375;8149.674013039412;10238.33450825694;12171.573994910135;12273.202241854608;12630.557930472389;12636.873631263938;10846.186536009673;11007.449627518752;11149.721256968316;11176;11201.943990279997;11210.775784484427;11229.88770112321;11336.546538138382;11404.372759497975;11504.137189710638;11594.362310073027;11607.129465290305;11741.941290293495;11824.113191510844;11862.703432413913;7241.5293005954445;7508.511946723445;7543.358814500829;7714.997050383414;8696;10153.746156346151;11040.779184416428;11133.888661113286;11238.943805280922;11411.315321080761 17:31:59 INFO - PROCESS | 4118 | |3;mootools.html;1267.8732126787318;1508.894377393582;1546.7138579362818;1689.417151082876;1807.204829874854;7735.651895664694;8023.27790498855;8094.514329140248;8099.311558517518;8108.716194933186;8083.595820208995;8332.791680207998;8333.958330208341;8342.541160236184;8349.41554091214;1979.9902049954483;2208.61349263879;2280.213326402393;2295.1278514164596;2342.1334106380664;2358.1628521874745;2366.0535785685693;2374.03851440167;2375.572396968545;2375.714914210297;2271.681964524968;2316.3051084674617;2322.280093171114;2333.288347054148;2335.5095429959642;1989.6717041688105;2177.684235785818;2236.8769717665523;2244.0799272298277;2245.0682966568857;2211.0934516848015;2220.2340192633515;2234.340869443518;2237.071615279657;2247.3370355745096;7922.762317130495;8000.8399832003615;8004.119546849842;8019.278264956182;8024.27781499662;4885.7312847793355;5053.393592768891;5060.418051924039;5081.034603425374;5082.796688132507;3297.55483009793;3365.9158521036925;3378.341223461426;3409.641987591292;3426.7601267911255;1095.895889890459;1099.5546803544578;1105.485949033695;1113.1706878375662;1140.5095808802212;11412.258203216847;11496.482658280314;11541.653750387502;11643.708907277301;11646.534138634444;4269.893252668709;4372.759498227628;4503.121891231244;4525.683202175816;4552.521985191507;9910.554025068745;9918.851217231748;9949.353292035994;9953.153981911473;9993.550290236957;4493.7977790999485;5128.974355128201;5133.717645529457;5159.09715799741;5171.4052883918075;4227.7040607157205;4248.9787551062045;4255.893602659959;4570.13167498181;4697.553732395417;3912.8630497932436;3952.130531283113;3994.6005399459823;4025.3156963316305;4081.3673880548563;1257.1262972234392;1262.5581046633604;1274.6877015131352;1297.2151848131743;1300.206873806977;1017.8473229015707;1020.6937918624383;1034.3070143004206;1043.0508237503986;1052.6578861869923;5994.1608174855555;6033.668148251801;6063.575549711478;6079.908801367983;6249.281332646713;397.8130278768974;399.2334717342709;409.66202882621957;410.94452248946607;416.6167126243863;4086.8569600063856;4115.794210289474;4119.279126152911;4128.876133715993;4155.335146376626;9786.5596048178;10185.032421919906;10277.794444111076;10288.279820412648;10295.279330446947;10043.19654427644;10078.294519383719;10133.2906696532;10175.440350780778;10180.083792458714;7965.322947549524;7999.200079992071;8061.395395345373;8070.273675369128;8077.071136819341;5669.7165141741925;5671.461211185096;5706.400827913009;5816.47651711348;5942.959982003219;9153.496557689392;9211.124943130391;9392.81214375695;9395.483248421402;9423.670171543963;9025.638974440948;9304.627814887328;9472.857907131262;9547.236221102155;9564.76088097803;6567.671616419065;7114.466415018791;7211.2428195038765;7308.196098429275;7311.524750891175;7882.921170788448;7905.446618736633;7931.405144614292;7942.285194332538;7944.126146124037;6996.825079373057;7210.351068403869;7239.710411583688;7340.339369456561;7352;7057.153141623038;7129.144502659714;7151.32062454066;7159.355657990805;7173.6353741633;6801.9319806801295;6861.519693621598;6894;6901.965490172718;6902.516823822284;5075.746212689277;5092.108880945893;5105.617078719037;5108.719020453911;5122.052420302256;5015.573676237561;5179.45615710345;5184.248283998874;5198.636095473281;5279.577633789211 17:31:59 INFO - PROCESS | 4118 | |4;prototype.html;288.28505306839054;301.71789376932566;304.6466099324783;304.98170109793415;305.3191383215431;5291.973540132303;5364.91952620711;5566.805161819337;5589.357223919245;5590.748416321265;5459.754311056002;5562.332520097584;5566.304211973504;5572.749226284816;5623.297087864017;4288.270993931032;4309;4309.482862056542;4321.82712691492;4329;3958.9208215835665;4126.938095928548;4252.489701235856;4302.397664326997;4321.956780432187;4207.705460617758;4217.978910105445;4239.321708526621;4243.618074373306;4244.851430199944;4204.306289462251;4208.242516347056;4213.557576454459;4223.704340696153;4237.322028475429;3606.9278614427562;3687.557493100845;3691.575468821093;3696.6303369663087;3705.2404257127496;5330.92003619946;5356.678599284055;5356.839294821161;5356.892862142735;5363.839084827461;4872.074305881871;4875.317455556225;4878.487758785347;4879.853604391874;4888.608911287089;5702;5785.8553536161935;5814.970925145347;5837.824865254049;5838.591298609099;3989.98005009976;4016;4030.556638769733;4032.1532478179615;4040.7979601019833;6050.42520960508;6058.363871793443;6071.757129714851;6076.635401875901;6097.237845269341;4009.1179940413062;4060.3706425504092;4085.22380747657;4096.795160242035;4131.194417088699;4149.066460046526;4150.149219410014;4151.626353628188;4159.854405095807;4189.2040512302565;4821.132196204717;4839.41926968766;4842.564169224786;4843.75781210938;4844.612431005511;5694.487496125285;5826.504747096545;5867.706614669335;5871.148683440877;5879.470847623649;1362.6593351662084;1398.9650258743409;1451.0350616839894;1454.3382760844001;1456.410153887677;979.3242662562809;986.605357856863;1004.352192835617;1008.7377281906757;1014.4826138669332;5605.860717997853;5607.775688972477;5611.102223644279;5623.578231632644;5642.153676948408;5880.647161170344;5912.438318359749;5923.911141332884;5942.1383899335215;5970.9701451492465;5416.106342453451;5607.186957891083;5629.071203251499;5690.2033715279895;5723.8569035774435;3210.6628803975245;3211.6306624738454;3212.180893872048;3224.7742658013713;3226.8870589529256;6186.381361863778;6251.218597675291;6254.593451425642;6303.495720342362;6307.9369206308265;6136.343187339483;6179.474744646755;6197.194364732646;6202.7670038786;6210.4410603045035;6230.906536401958;6239.812805615838;6243.843903902439;6285.182926219562;6297.527685423612;5921.14143449206;6062.393760623902;6076.240469941257;6097.298810636834;6104.572679912363;6030.6080104793045;6044.576879618385;6047.09293605945;6051.7579296827635;6055.636661800306;6125.173101631401;6304.873902522016;6314.431701146735;6328.335524769833;6333.145025421509;4060.9187816244103;4067.613576710208;4082.755034697928;4085.8774236772942;4092.304308267542;5782.190493330853;5922.230110085661;6069.696515174312;6077.513798896166;6086.573939824169;5854.765809367577;5876.500497457593;5890.440408161217;5921.792737254175;5927.733252003756;5897.085951677497;5898.439648233411;5907.527397808251;5915.970420147872;5925.733341999534;5632.267805185464;5803.578123359804;5815.709214539341;5821.417858214145;5826.912596311144;5884.735186916513;5926.170336152856;5926.288845338587;5934.554908381975;5947.613405128653;5461.208124821958;5747.885042299047;5810.186573879745;5810.883782324415;5812.476877081083 17:31:59 INFO - PROCESS | 4118 | |5;yui.html;791.0507391130643;797.992020079799;852.049964289817;864.0883867519768;868.9963092628013;13179.7364052719;13350.132241404302;13364.19814811112;13385.063045586812;13427.932860335684;14059.718805623907;14574.781378279335;14579.416823327054;14604.196769177692;14638.26808659568;670.6881300195408;799.5562462833125;835.9791005224857;836.9329105390646;838.5932822581043;826.1036775099025;826.9421140520166;828.581566309013;829.340674164041;829.3448175940999;872.7032808844991;872.7818045488627;874.3791907745508;875.3609864798701;875.6803766625168;696.362828012368;839.1901814748736;870.3428911172088;870.582120582121;871.3813192633238;633.1357696743958;635.4503354598239;635.726637545855;635.9173307470046;636.4876274598946;12985.545505907343;13007.54473593429;13014.21914685122;13018.088733788543;13025.283609401478;12273.509059637603;12582.622521324374;12748;13068.215907045607;13158.473661053546;10790.190735694854;11107.278026928223;11164.720881977933;11195.160362972729;11400.087992960543;3702.092987218122;3711.6473934976134;3741.6445437683647;3808.124131449782;3815.351390263662;57254.7137264311;57845;59616.105758414094;59633.701831491;60027.399726002615;10398.532066057045;10443.791124177626;10454.790904181873;10529.84205236922;10533.683989480327;16970.40603578869;16978.830211697972;17013;17022.48932532026;17072.658546828992;7516.361109305771;7622.047244094489;7777.611119444005;7784.455088143889;7846.254605812439;4129.236091323115;4149.128682976549;4205.201011807747;4351.912961740747;4432.202203603382;3076.338587203717;3137.984310078435;3140.371925614886;3249.7400207983305;3249.78876373035;506.2559482582468;584.4564554963839;591.775125452334;601.1103566721278;608.397686290578;649;649.6881496881523;715.3893158592923;760.9086909570887;779.5244900610624;8921.286297096216;8982.820343593092;9186.127317904788;9304.72085837426;9352.579133938989;671.9731210751613;677.2245778583494;756.9318761311508;770.7533589251386;788.6687591211705;4327.567243275647;4415;4419.602235798729;4437.267850804581;4468.977655111704;62909.685451573365;64063;64952.35047649557;65549.34450655528;66309;56134;56390;56959.43040569624;57671;59556.70221648864;52222.21666675003;52355.73822130865;52680.736596316776;53115.46884531183;53489.46510534923;8256.215659512336;8386.748397547839;8502.277306429023;8503.107173746668;8638.697645582375;28521.857390712914;28785;29615.111546653636;30344;35032.29935401227;41558.37662435006;41716.791416042724;41800.3729944045;41814.581854181066;41946.58053419427;11963.342016188844;12011.879881201427;12216.45025973851;12439.191452555917;12786.296753678636;12633;12656.873431265569;12837.165584237368;12875.742485150431;13670.11144275619;12883.420246089136;12944.15862968904;13231.139975901535;13298.069135160446;13406.597802065953;12556.748865022832;13105.803412949004;13242.933785331397;13355.399007044512;13377.66555836073;11825.881741182478;12894.41975111141;13346.799798003232;13460;13989.720205596035;10554.155667546731;10681.412522311348;10683.358998460117;11031.779364412827;11346.886531134583;10871.565137394731;10886.836697449702;10911;10984.176186785864;11062.446877656246 17:31:59 INFO - PROCESS | 4118 | __end_tp_report 17:31:59 INFO - PROCESS | 4118 | __start_cc_report 17:31:59 INFO - PROCESS | 4118 | _x_x_mozilla_cycle_collect,844 17:31:59 INFO - PROCESS | 4118 | __end_cc_report 17:31:59 INFO - PROCESS | 4118 | __startTimestamp1461198719148__endTimestamp 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | ------- Summary: start ------- 17:31:59 INFO - PROCESS | 4118 | Number of tests: 6 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | [#0] dojo.html Cycles:165 Average:5261.76 Median:5456.37 stddev:588.79 (10.8%) stddev-sans-first:564.67 17:31:59 INFO - PROCESS | 4118 | Values: 3058.8 3121.3 3160.4 3164.6 3195.1 5189.6 5277.2 5292.6 5298.8 5312.0 5230.6 5271.3 5284.8 5312.6 5319.9 4761.0 4769.1 4799.7 4808.2 4976.2 4902.7 4911.6 4926.2 4975.0 4996.1 4732.4 4776.7 4781.7 4834.3 4847.4 4839.6 4860.7 4862.6 4866.3 4895.0 4628.2 4811.2 4826.0 4839.4 4882.6 5234.4 5242.5 5249.2 5267.4 5281.5 5657.7 5661.3 5686.6 5692.2 5693.3 5541.6 5613.0 5705.8 5731.2 5735.9 5295.1 5316.9 5318.0 5319.6 5355.5 5792.0 5793.4 5794.1 5794.3 5794.5 5428.6 5449.5 5522.4 5554.4 5555.1 5674.3 5683.3 5686.5 5686.7 5687.3 5647.5 5654.2 5655.8 5657.0 5663.4 5556.4 5608.6 5643.1 5663.0 5680.6 4264.7 4267.9 4268.3 4268.9 4303.3 3784.5 3835.8 3845.4 3864.8 3891.9 5273.1 5336.5 5345.7 5381.8 5403.2 5614.7 5628.4 5633.6 5644.3 5646.2 5143.3 5286.8 5312.7 5319.8 5329.4 4870.8 4889.4 4894.9 4910.8 4937.8 5844.9 5855.5 5862.1 5865.8 5909.0 5499.4 5647.8 5694.0 5694.9 5769.2 5870.8 5878.3 5880.4 5882.4 5889.8 5575.2 5576.0 5576.5 5578.6 5592.8 5450.3 5635.7 5640.9 5694.4 5740.0 5567.8 5572.3 5577.5 5580.7 5585.2 5551.8 5560.1 5561.5 5561.6 5563.8 5387.6 5447.9 5473.0 5551.8 5570.5 5520.0 5545.4 5550.4 5552.0 5558.7 5454.8 5454.8 5456.4 5461.9 5495.9 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | [#1] ext.html Cycles:180 Average:57271.63 Median:37356.41 stddev:112365.52 (300.8%) stddev-sans-first:112600.19 17:31:59 INFO - PROCESS | 4118 | Values: 606.1 619.8 629.7 659.6 670.7 30456.7 31162.5 37412.0 38105.9 38202.6 40890.6 41581.6 41793.0 41851.8 41887.8 8459.7 8687.8 8703.0 8707.2 8712.0 7457.2 7688.5 10248.5 10602.6 10613.4 10173.8 10243.2 10330.1 10338.6 10343.2 7475.7 9929.2 10208.2 10338.0 10338.5 10147.7 10288.5 10290.1 10290.6 10296.8 39206.6 39888.8 39898.2 39937.2 39943.8 3652.1 3657.3 3676.9 3713.5 3932.5 30045.4 32413.8 32565.0 32885.2 33495.3 4333.3 4360.2 4364.5 4398.7 4461.5 323774.0 328341.0 328870.0 329656.0 329807.4 34387.3 64239.0 65269.0 65341.0 65538.3 34630.0 34873.0 34896.1 34918.5 34936.0 15017.9 15183.0 15183.1 15214.7 15222.0 12245.3 12246.0 12250.5 12254.6 12274.3 7792.4 7828.7 7835.8 7886.5 7895.8 3037.5 3041.2 3079.3 3091.2 3096.3 977.4 1013.1 1095.6 1152.0 1157.5 32746.3 34602.8 34678.8 35886.6 37300.8 1131.4 1141.9 1164.3 1219.0 1242.3 16149.4 16964.5 16989.4 17076.7 17089.3 498683.0 501852.0 506945.0 508928.0 510961.0 56832.0 57826.0 57857.4 57865.0 57872.0 1402.6 1442.1 1444.9 1446.4 1517.5 30517.4 31631.0 32070.4 32187.8 32241.4 49397.3 49892.0 50412.2 50507.0 50512.0 413904.0 419869.0 420530.0 421093.0 422027.0 23677.8 26548.9 26919.9 41354.4 42486.4 45774.3 46290.0 46434.3 47042.8 47085.8 41192.8 42114.8 42332.4 42439.8 43765.6 41963.4 42191.4 42386.6 42411.6 43319.4 43938.3 44705.3 44916.3 44973.0 45270.8 36707.3 37769.8 38543.8 38855.0 39023.8 28500.3 29349.7 29404.3 29497.7 29835.0 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | [#2] jquery.html Cycles:180 Average:25198.06 Median:18726.08 stddev:66272.72 (353.9%) stddev-sans-first:66432.42 17:31:59 INFO - PROCESS | 4118 | Values: 376.1 377.3 379.2 389.0 389.4 17355.8 18991.0 19341.1 19873.9 19942.4 18264.0 18524.4 18802.5 18855.2 19144.0 3842.7 5467.4 5545.1 5625.6 5628.0 5748.2 6108.6 6121.2 6123.2 6126.5 5792.3 6010.7 6055.6 6120.6 6134.6 3820.1 4015.6 6033.5 6086.0 6123.1 3702.1 5151.3 5441.8 5444.4 5450.5 20296.4 20735.0 21068.4 21117.2 21247.4 2073.6 2134.8 2227.9 2468.1 2496.2 8536.1 8612.9 8632.3 8722.4 8812.3 1839.2 1912.7 1945.6 1948.0 1952.7 73528.6 77084.6 78340.2 78359.2 78770.6 9882.8 10131.8 10337.3 10566.3 10575.2 14343.6 14354.1 14485.2 14531.3 14535.4 7641.8 7946.0 8002.2 8064.6 8080.6 7695.3 7763.5 7803.8 7848.5 7878.9 3893.5 4022.8 4104.3 4177.1 4186.5 1602.8 1805.0 1810.9 1855.6 1859.4 991.0 1002.6 1033.8 1057.2 1065.7 18152.7 18603.9 18664.9 18752.2 18907.5 957.5 993.7 1023.4 1059.9 1061.9 10182.7 10476.2 10507.5 10508.8 10594.8 359933.0 363603.0 364591.0 366307.0 523960.0 70836.3 76906.0 78047.2 78081.2 78446.6 1033.4 1061.8 1070.3 1078.9 1090.8 16080.8 16363.8 16577.3 16862.4 17131.2 34956.0 36653.6 36688.6 37787.0 37866.1 51929.7 53633.9 53955.0 54073.5 54551.0 7169.3 7817.8 7990.1 8067.4 8149.7 10238.3 12171.6 12273.2 12630.6 12636.9 10846.2 11007.4 11149.7 11176.0 11201.9 11210.8 11229.9 11336.5 11404.4 11504.1 11594.4 11607.1 11741.9 11824.1 11862.7 7241.5 7508.5 7543.4 7715.0 8696.0 10153.7 11040.8 11133.9 11238.9 11411.3 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | [#3] mootools.html Cycles:180 Average:5507.79 Median:4950.65 stddev:3060.27 (61.8%) stddev-sans-first:3052.27 17:31:59 INFO - PROCESS | 4118 | Values: 1267.9 1508.9 1546.7 1689.4 1807.2 7735.7 8023.3 8094.5 8099.3 8108.7 8083.6 8332.8 8334.0 8342.5 8349.4 1980.0 2208.6 2280.2 2295.1 2342.1 2358.2 2366.1 2374.0 2375.6 2375.7 2271.7 2316.3 2322.3 2333.3 2335.5 1989.7 2177.7 2236.9 2244.1 2245.1 2211.1 2220.2 2234.3 2237.1 2247.3 7922.8 8000.8 8004.1 8019.3 8024.3 4885.7 5053.4 5060.4 5081.0 5082.8 3297.6 3365.9 3378.3 3409.6 3426.8 1095.9 1099.6 1105.5 1113.2 1140.5 11412.3 11496.5 11541.7 11643.7 11646.5 4269.9 4372.8 4503.1 4525.7 4552.5 9910.6 9918.9 9949.4 9953.2 9993.6 4493.8 5129.0 5133.7 5159.1 5171.4 4227.7 4249.0 4255.9 4570.1 4697.6 3912.9 3952.1 3994.6 4025.3 4081.4 1257.1 1262.6 1274.7 1297.2 1300.2 1017.8 1020.7 1034.3 1043.1 1052.7 5994.2 6033.7 6063.6 6079.9 6249.3 397.8 399.2 409.7 410.9 416.6 4086.9 4115.8 4119.3 4128.9 4155.3 9786.6 10185.0 10277.8 10288.3 10295.3 10043.2 10078.3 10133.3 10175.4 10180.1 7965.3 7999.2 8061.4 8070.3 8077.1 5669.7 5671.5 5706.4 5816.5 5943.0 9153.5 9211.1 9392.8 9395.5 9423.7 9025.6 9304.6 9472.9 9547.2 9564.8 6567.7 7114.5 7211.2 7308.2 7311.5 7882.9 7905.4 7931.4 7942.3 7944.1 6996.8 7210.4 7239.7 7340.3 7352.0 7057.2 7129.1 7151.3 7159.4 7173.6 6801.9 6861.5 6894.0 6902.0 6902.5 5075.7 5092.1 5105.6 5108.7 5122.1 5015.6 5179.5 5184.2 5198.6 5279.6 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | [#4] prototype.html Cycles:180 Average:4893.77 Median:5607.48 stddev:1485.62 (26.5%) stddev-sans-first:1449.01 17:31:59 INFO - PROCESS | 4118 | Values: 288.3 301.7 304.6 305.0 305.3 5292.0 5364.9 5566.8 5589.4 5590.7 5459.8 5562.3 5566.3 5572.7 5623.3 4288.3 4309.0 4309.5 4321.8 4329.0 3958.9 4126.9 4252.5 4302.4 4322.0 4207.7 4218.0 4239.3 4243.6 4244.9 4204.3 4208.2 4213.6 4223.7 4237.3 3606.9 3687.6 3691.6 3696.6 3705.2 5330.9 5356.7 5356.8 5356.9 5363.8 4872.1 4875.3 4878.5 4879.9 4888.6 5702.0 5785.9 5815.0 5837.8 5838.6 3990.0 4016.0 4030.6 4032.2 4040.8 6050.4 6058.4 6071.8 6076.6 6097.2 4009.1 4060.4 4085.2 4096.8 4131.2 4149.1 4150.1 4151.6 4159.9 4189.2 4821.1 4839.4 4842.6 4843.8 4844.6 5694.5 5826.5 5867.7 5871.1 5879.5 1362.7 1399.0 1451.0 1454.3 1456.4 979.3 986.6 1004.4 1008.7 1014.5 5605.9 5607.8 5611.1 5623.6 5642.2 5880.6 5912.4 5923.9 5942.1 5971.0 5416.1 5607.2 5629.1 5690.2 5723.9 3210.7 3211.6 3212.2 3224.8 3226.9 6186.4 6251.2 6254.6 6303.5 6307.9 6136.3 6179.5 6197.2 6202.8 6210.4 6230.9 6239.8 6243.8 6285.2 6297.5 5921.1 6062.4 6076.2 6097.3 6104.6 6030.6 6044.6 6047.1 6051.8 6055.6 6125.2 6304.9 6314.4 6328.3 6333.1 4060.9 4067.6 4082.8 4085.9 4092.3 5782.2 5922.2 6069.7 6077.5 6086.6 5854.8 5876.5 5890.4 5921.8 5927.7 5897.1 5898.4 5907.5 5916.0 5925.7 5632.3 5803.6 5815.7 5821.4 5826.9 5884.7 5926.2 5926.3 5934.6 5947.6 5461.2 5747.9 5810.2 5810.9 5812.5 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - PROCESS | 4118 | [#5] yui.html Cycles:180 Average:14787.04 Median:41880.58 stddev:17642.11 (42.1%) stddev-sans-first:17660.30 17:31:59 INFO - PROCESS | 4118 | Values: 791.1 798.0 852.0 864.1 869.0 13179.7 13350.1 13364.2 13385.1 13427.9 14059.7 14574.8 14579.4 14604.2 14638.3 670.7 799.6 836.0 836.9 838.6 826.1 826.9 828.6 829.3 829.3 872.7 872.8 874.4 875.4 875.7 696.4 839.2 870.3 870.6 871.4 633.1 635.5 635.7 635.9 636.5 12985.5 13007.5 13014.2 13018.1 13025.3 12273.5 12582.6 12748.0 13068.2 13158.5 10790.2 11107.3 11164.7 11195.2 11400.1 3702.1 3711.6 3741.6 3808.1 3815.4 57254.7 57845.0 59616.1 59633.7 60027.4 10398.5 10443.8 10454.8 10529.8 10533.7 16970.4 16978.8 17013.0 17022.5 17072.7 7516.4 7622.0 7777.6 7784.5 7846.3 4129.2 4149.1 4205.2 4351.9 4432.2 3076.3 3138.0 3140.4 3249.7 3249.8 506.3 584.5 591.8 601.1 608.4 649.0 649.7 715.4 760.9 779.5 8921.3 8982.8 9186.1 9304.7 9352.6 672.0 677.2 756.9 770.8 788.7 4327.6 4415.0 4419.6 4437.3 4469.0 62909.7 64063.0 64952.4 65549.3 66309.0 56134.0 56390.0 56959.4 57671.0 59556.7 52222.2 52355.7 52680.7 53115.5 53489.5 8256.2 8386.7 8502.3 8503.1 8638.7 28521.9 28785.0 29615.1 30344.0 35032.3 41558.4 41716.8 41800.4 41814.6 41946.6 11963.3 12011.9 12216.5 12439.2 12786.3 12633.0 12656.9 12837.2 12875.7 13670.1 12883.4 12944.2 13231.1 13298.1 13406.6 12556.7 13105.8 13242.9 13355.4 13377.7 11825.9 12894.4 13346.8 13460.0 13989.7 10554.2 10681.4 10683.4 11031.8 11346.9 10871.6 10886.8 10911.0 10984.2 11062.4 17:31:59 INFO - PROCESS | 4118 | -------- Summary: end -------- 17:31:59 INFO - PROCESS | 4118 | 17:31:59 INFO - TEST-INFO | 4118: exit 0 17:31:59 INFO - TEST-OK | dromaeo_css | took 1111184ms 17:31:59 INFO - TEST-START | kraken 17:31:59 INFO - operating with platform_type : linux_ 17:31:59 INFO - Initialising browser for kraken test... 17:31:59 INFO - TEST-INFO | started process 4310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcve4ft/profile http://localhost:41591/getInfo.html) 17:32:03 INFO - PROCESS | 4310 | __metrics Screen width/height:1600/1200 17:32:03 INFO - PROCESS | 4310 | colorDepth:24 17:32:03 INFO - PROCESS | 4310 | Browser inner width/height: 1024/697 17:32:03 INFO - PROCESS | 4310 | __metrics 17:32:04 ERROR - PROCESS | 4310 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:04 INFO - TEST-INFO | 4310: exit 0 17:32:04 INFO - Browser initialized. 17:32:04 INFO - Running cycle 1/1 for kraken test... 17:32:04 INFO - TEST-INFO | started process 4393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcve4ft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:16 INFO - PROCESS | 4393 | RSS: Main: 153251840 17:32:16 INFO - PROCESS | 4393 | 17:32:19 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41591/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:19 INFO - PROCESS | 4393 | RSS: Main: 208039936 17:32:19 INFO - PROCESS | 4393 | 17:32:22 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41591/tests/kraken/driver.html?testName=audio-dft) 17:32:23 INFO - PROCESS | 4393 | RSS: Main: 193581056 17:32:23 INFO - PROCESS | 4393 | 17:32:26 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41591/tests/kraken/driver.html?testName=audio-fft) 17:32:26 INFO - PROCESS | 4393 | RSS: Main: 263766016 17:32:26 INFO - PROCESS | 4393 | 17:32:28 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41591/tests/kraken/driver.html?testName=audio-oscillator) 17:32:29 INFO - PROCESS | 4393 | RSS: Main: 173944832 17:32:29 INFO - PROCESS | 4393 | 17:32:31 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:32 INFO - PROCESS | 4393 | RSS: Main: 177094656 17:32:32 INFO - PROCESS | 4393 | 17:32:35 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41591/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:35 INFO - PROCESS | 4393 | RSS: Main: 213643264 17:32:35 INFO - PROCESS | 4393 | 17:32:39 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41591/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:39 INFO - PROCESS | 4393 | RSS: Main: 214081536 17:32:39 INFO - PROCESS | 4393 | 17:32:42 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41591/tests/kraken/driver.html?testName=json-parse-financial) 17:32:43 INFO - PROCESS | 4393 | RSS: Main: 213778432 17:32:43 INFO - PROCESS | 4393 | 17:32:44 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:45 INFO - PROCESS | 4393 | RSS: Main: 202252288 17:32:45 INFO - PROCESS | 4393 | 17:32:46 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:47 INFO - PROCESS | 4393 | RSS: Main: 203419648 17:32:47 INFO - PROCESS | 4393 | 17:32:49 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:50 INFO - PROCESS | 4393 | RSS: Main: 218857472 17:32:50 INFO - PROCESS | 4393 | 17:32:52 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:53 INFO - PROCESS | 4393 | RSS: Main: 223891456 17:32:53 INFO - PROCESS | 4393 | 17:32:56 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:56 INFO - PROCESS | 4393 | RSS: Main: 219230208 17:32:56 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | Cycle 1(1): loaded http://localhost:41591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41591/tests/kraken/driver.html?testName=ai-astar) 17:32:58 INFO - PROCESS | 4393 | RSS: Main: 282550272 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | __start_tp_report 17:32:58 INFO - PROCESS | 4393 | _x_x_mozilla_page_load 17:32:58 INFO - PROCESS | 4393 | _x_x_mozilla_page_load_details 17:32:58 INFO - PROCESS | 4393 | |i|pagename|runs| 17:32:58 INFO - PROCESS | 4393 | |0;ai-astar;110;110;105;110;112;111;99;110;110;110 17:32:58 INFO - PROCESS | 4393 | |1;audio-beat-detection;157;134;152;183;128;156;151;127;200;127 17:32:58 INFO - PROCESS | 4393 | |2;audio-dft;160;161;162;161;161;160;160;161;162;161 17:32:58 INFO - PROCESS | 4393 | |3;audio-fft;76;75;102;109;76;75;72;114;104;73 17:32:58 INFO - PROCESS | 4393 | |4;audio-oscillator;93;92;150;92;92;93;144;93;92;151 17:32:58 INFO - PROCESS | 4393 | |5;imaging-gaussian-blur;116;117;118;116;117;117;117;117;117;116 17:32:58 INFO - PROCESS | 4393 | |6;imaging-darkroom;146;146;145;145;145;146;146;146;146;146 17:32:58 INFO - PROCESS | 4393 | |7;imaging-desaturate;94;95;95;94;96;95;95;95;96;95 17:32:58 INFO - PROCESS | 4393 | |8;json-parse-financial;57;55;57;55;55;55;58;73;55;53 17:32:58 INFO - PROCESS | 4393 | |9;json-stringify-tinderbox;60;60;61;60;60;61;61;61;60;60 17:32:58 INFO - PROCESS | 4393 | |10;stanford-crypto-aes;75;83;75;75;76;77;77;77;76;76 17:32:58 INFO - PROCESS | 4393 | |11;stanford-crypto-ccm;126;124;124;123;124;121;121;124;159;126 17:32:58 INFO - PROCESS | 4393 | |12;stanford-crypto-pbkdf2;164;163;162;164;162;164;166;162;162;174 17:32:58 INFO - PROCESS | 4393 | |13;stanford-crypto-sha256-iterative;70;68;68;70;68;68;70;68;67;67 17:32:58 INFO - PROCESS | 4393 | __end_tp_report 17:32:58 INFO - PROCESS | 4393 | __start_cc_report 17:32:58 INFO - PROCESS | 4393 | _x_x_mozilla_cycle_collect,1621 17:32:58 INFO - PROCESS | 4393 | __end_cc_report 17:32:58 INFO - PROCESS | 4393 | __startTimestamp1461198778660__endTimestamp 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | ------- Summary: start ------- 17:32:58 INFO - PROCESS | 4393 | Number of tests: 14 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:4.07 17:32:58 INFO - PROCESS | 4393 | Values: 110.0 110.0 105.0 110.0 112.0 111.0 99.0 110.0 110.0 110.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:154.00 stddev:24.62 (16.0%) stddev-sans-first:26.03 17:32:58 INFO - PROCESS | 4393 | Values: 157.0 134.0 152.0 183.0 128.0 156.0 151.0 127.0 200.0 127.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 17:32:58 INFO - PROCESS | 4393 | Values: 160.0 161.0 162.0 161.0 161.0 160.0 160.0 161.0 162.0 161.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#3] audio-fft Cycles:10 Average:87.60 Median:74.00 stddev:17.24 (23.3%) stddev-sans-first:17.77 17:32:58 INFO - PROCESS | 4393 | Values: 76.0 75.0 102.0 109.0 76.0 75.0 72.0 114.0 104.0 73.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.07 (29.4%) stddev-sans-first:28.07 17:32:58 INFO - PROCESS | 4393 | Values: 93.0 92.0 150.0 92.0 92.0 93.0 144.0 93.0 92.0 151.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 17:32:58 INFO - PROCESS | 4393 | Values: 116.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:32:58 INFO - PROCESS | 4393 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:32:58 INFO - PROCESS | 4393 | Values: 94.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 96.0 95.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.00 stddev:5.70 (10.2%) stddev-sans-first:6.04 17:32:58 INFO - PROCESS | 4393 | Values: 57.0 55.0 57.0 55.0 55.0 55.0 58.0 73.0 55.0 53.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 17:32:58 INFO - PROCESS | 4393 | Values: 60.0 60.0 61.0 60.0 60.0 61.0 61.0 61.0 60.0 60.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.50 stddev:2.36 (3.1%) stddev-sans-first:2.42 17:32:58 INFO - PROCESS | 4393 | Values: 75.0 83.0 75.0 75.0 76.0 77.0 77.0 77.0 76.0 76.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:124.00 stddev:11.30 (9.1%) stddev-sans-first:11.98 17:32:58 INFO - PROCESS | 4393 | Values: 126.0 124.0 124.0 123.0 124.0 121.0 121.0 124.0 159.0 126.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.00 stddev:3.65 (2.2%) stddev-sans-first:3.87 17:32:58 INFO - PROCESS | 4393 | Values: 164.0 163.0 162.0 164.0 162.0 164.0 166.0 162.0 162.0 174.0 17:32:58 INFO - PROCESS | 4393 | 17:32:58 INFO - PROCESS | 4393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.09 17:32:58 INFO - PROCESS | 4393 | Values: 70.0 68.0 68.0 70.0 68.0 68.0 70.0 68.0 67.0 67.0 17:32:58 INFO - PROCESS | 4393 | -------- Summary: end -------- 17:32:58 INFO - PROCESS | 4393 | 17:32:59 INFO - TEST-INFO | 4393: exit 0 17:32:59 INFO - TEST-OK | kraken | took 59913ms 17:32:59 INFO - SUITE-END | took 1171s 17:32:59 INFO - Completed test suite (00:19:31) 17:32:59 INFO - javascript benchmark 17:32:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.801177923435, 3121.3289142834287, 3160.383725173591, 3164.636066852311, 3195.121341631051, 5189.584833213344, 5277.234800953859, 5292.576593872491, 5298.761555729991, 5311.973440132799, 5230.555402790757, 5271.288376069229, 5284.8150314739, 5312.60155488338, 5319.946800532003, 4760.976195119019, 4769.070031343898, 4799.712017278957, 4808.158572249859, 4976.203807390818, 4902.656814023002, 4911.58251548617, 4926.187179115442, 4975.0, 4996.075725990703, 4732.43210814701, 4776.737279449629, 4781.665283430161, 4834.299026641117, 4847.369841920563, 4839.637027222972, 4860.659753817235, 4862.562369386772, 4866.270059491069, 4894.951050489485, 4628.213203755369, 4811.158047341702, 4826.0347930414055, 4839.395075615548, 4882.560569548722, 5234.42421333653, 5242.501962313574, 5249.212618107276, 5267.420583735786, 5281.471852814726, 5657.688827114507, 5661.264035675335, 5686.5735069869515, 5692.231548740909, 5693.28833895763, 5541.639793413416, 5613.0, 5705.800296989585, 5731.168980497804, 5735.913961290584, 5295.073362161645, 5316.946830531684, 5318.042752304545, 5319.5744340452675, 5355.518003379676, 5791.986402379567, 5793.362730099686, 5794.130880367894, 5794.333651630032, 5794.507466865363, 5428.5928555358505, 5449.509544141047, 5522.447755224445, 5554.361248456479, 5555.138953462219, 5674.290713660793, 5683.318001839723, 5686.459786320293, 5686.715664216773, 5687.260656114679, 5647.49172574462, 5654.180143879197, 5655.830325090172, 5657.038303488417, 5663.405342439067, 5556.416576259516, 5608.551315894719, 5643.068893632505, 5662.971685141548, 5680.602357834994, 4264.744115353089, 4267.850625228102, 4268.295731204316, 4268.87193384199, 4303.268444364466, 3784.526934133233, 3835.8082095895093, 3845.442410850411, 3864.768113913174, 3891.902702432462, 5273.077211487975, 5336.46635336471, 5345.652532585447, 5381.811636592701, 5403.2165336026055, 5614.719264036864, 5628.437156284421, 5633.63381380209, 5644.294463192101, 5646.181303710939, 5143.305653736697, 5286.788528458896, 5312.707801070901, 5319.813806516753, 5329.413764485904, 4870.756462176877, 4889.3888263967, 4894.94758626897, 4910.803567857317, 4937.802487900443, 5844.918690042356, 5855.531557475391, 5862.12068189775, 5865.824025279248, 5908.970455147697, 5499.395066542757, 5647.802326918538, 5693.971530142323, 5694.857628559319, 5769.249997500298, 5870.765169393177, 5878.294604647299, 5880.441358070976, 5882.441168089024, 5889.764409423747, 5575.247341608993, 5576.024195765806, 5576.498115169654, 5578.581606379619, 5592.832215033555, 5450.31871016123, 5635.718214089361, 5640.943590564042, 5694.402087780723, 5740.0, 5567.805126820542, 5572.3034620672415, 5577.470140336662, 5580.720963951868, 5585.245991791218, 5551.7779288828, 5560.110382338807, 5561.547293032494, 5561.555075593862, 5563.805266815642, 5387.649802762808, 5447.945520544744, 5473.042217611823, 5551.7779288828, 5570.498655121059, 5520.0, 5545.3622833374675, 5550.38945715979, 5552.0, 5558.749856256397, 5454.781808727606, 5454.781808727606, 5456.372517160418, 5461.9180712290145, 5495.917561236504], "value": 5222.854456360505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1150719948874, 619.8419403052221, 629.6851574212893, 659.5712786688654, 670.7283550162186, 30456.695433045665, 31162.53256201156, 37412.0, 38105.856824295246, 38202.617973820255, 40890.59109408905, 41581.58418415815, 41793.0, 41851.79074104633, 41887.79056104715, 8459.746207613782, 8687.826243475158, 8703.0, 8707.172818582225, 8712.0, 7457.216992215794, 7688.500247483924, 10248.487575621226, 10602.628907988223, 10613.41626210558, 10173.84739228912, 10243.180545556337, 10330.121939635103, 10338.638147664833, 10343.22425818063, 7475.663595138232, 9929.156021738161, 10208.234382421348, 10338.0, 10338.53476593555, 10147.695569132939, 10288.537015834305, 10290.07389334956, 10290.588376465008, 10296.79406411875, 39206.60793392058, 39888.80055599703, 39898.20203595941, 39937.201255974716, 39943.8002809987, 3652.086978255436, 3657.3416784978695, 3676.8529258829612, 3713.4615480755137, 3932.508436445444, 30045.399092018037, 32413.834192260725, 32565.0, 32885.17787055319, 33495.330093398, 4333.349997500369, 4360.193364227628, 4364.476262848447, 4398.670099742532, 4461.517791832317, 323774.0, 328341.0, 328870.0, 329656.0, 329807.350963246, 34387.31225375478, 64239.0, 65269.0, 65341.0, 65538.34461655322, 34630.0, 34873.0, 34896.127596809776, 34918.476222856676, 34936.0, 15017.948743588062, 15183.0, 15183.089014659156, 15214.695706085817, 15222.0, 12245.265284082983, 12246.0, 12250.509979600716, 12254.571090011985, 12274.324912129918, 7792.41556883236, 7828.725994590162, 7835.843283134305, 7886.487378320391, 7895.842083158304, 3037.4684430224625, 3041.194083567856, 3079.307155889907, 3091.165385345944, 3096.34976654905, 977.3744803325877, 1013.0882206014646, 1095.5672509358758, 1152.0207823350086, 1157.5369852059243, 32746.345073098404, 34602.82698586491, 34678.82660586681, 35886.64113358833, 37300.81349593234, 1131.3890499130378, 1141.9429028548539, 1164.2897832322276, 1218.9695257618453, 1242.3291422631858, 16149.434769783002, 16964.491065268063, 16989.40537081196, 17076.658466830595, 17089.316427343016, 498683.0, 501852.0, 506945.0, 508928.0, 510961.0, 56832.0, 57826.0, 57857.421425786044, 57865.0, 57872.0, 1402.6212922510865, 1442.1058943455125, 1444.8555144485676, 1446.3925151436422, 1517.537151168882, 30517.389652207276, 31631.0, 32070.358592827546, 32187.839060804545, 32241.35517289688, 49397.25904111513, 49892.0, 50412.243816343514, 50507.0, 50512.0, 413904.0, 419869.0, 420530.0, 421093.0, 422027.0, 23677.763222367557, 26548.867255663597, 26919.865400672872, 41354.37968430416, 42486.36270455884, 45774.31338529858, 46290.0, 46434.30348544707, 47042.76478617585, 47085.76457117692, 41192.79403602963, 42114.789426052674, 42332.36501452419, 42439.7878010608, 43765.562344377424, 41963.37054944239, 42191.36712949247, 42386.57613423826, 42411.57588424076, 43319.35020974625, 43938.34092488551, 44705.329420059374, 44916.326255106855, 44973.0, 45270.77364613156, 36707.26585468329, 37769.81115094407, 38543.80728096342, 38855.0, 39023.80488097541, 28500.287492812844, 29349.70650293555, 29404.26489337698, 29497.705022949496, 29835.0], "value": 19132.171920661967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.0936143893218, 377.2643345476322, 379.1563770610392, 388.9902752431191, 389.3536729029811, 17355.82644173558, 18991.0, 19341.129649165785, 19873.900630496828, 19942.401727948185, 18264.0, 18524.444266671988, 18802.529936751587, 18855.15151818168, 19144.0, 3842.6733727633186, 5467.371252305986, 5545.112781954888, 5625.634333768312, 5627.971860140714, 5748.19525266463, 6108.602940808855, 6121.204243448346, 6123.173371594822, 6126.540509461808, 5792.304923409197, 6010.729517171716, 6055.606385584945, 6120.602160859552, 6134.570580059398, 3820.0640842993366, 4015.558288588253, 6033.5173186145, 6086.0, 6123.142760013601, 3702.129999450127, 5151.278820965068, 5441.782328706847, 5444.373897001856, 5450.5367043800925, 20296.391108266776, 20735.0, 21068.367948961557, 21117.15531378743, 21247.36257912265, 2073.5541858500496, 2134.786917740337, 2227.866328020324, 2468.1114798672465, 2496.163785131983, 8536.061033286396, 8612.8708069379, 8632.266257368132, 8722.38943273971, 8812.250958668521, 1839.2275244397385, 1912.6844070728314, 1945.620603982224, 1947.9513012174668, 1952.6778081616517, 73528.63235683841, 77084.61457692676, 78340.21659783443, 78359.21640783633, 78770.60614696947, 9882.764654418197, 10131.797364052825, 10337.312298802215, 10566.313189642802, 10575.20685948557, 14343.641408964859, 14354.138751674724, 14485.20331381763, 14531.273436328142, 14535.418583256764, 7641.7707468776025, 7945.960270198728, 8002.239787220205, 8064.55644939534, 8080.55556944362, 7695.307422332017, 7763.456558040883, 7803.765887023284, 7848.529088254723, 7878.921210787818, 3893.53277606689, 4022.778747168934, 4104.261232978092, 4177.099419764, 4186.497620285585, 1602.8477294656989, 1804.9639007220044, 1810.8822926509736, 1855.554666879939, 1859.386402487176, 990.9702708918744, 1002.5588740953957, 1033.7674023344837, 1057.2229411382627, 1065.6802959112235, 18152.727709084375, 18603.906980465283, 18664.906675466806, 18752.156152973148, 18907.527311817314, 957.5039274563953, 993.7018894331671, 1023.4013102335217, 1059.941703206331, 1061.87257529097, 10182.694519164437, 10476.214283928583, 10507.47462626881, 10508.842367364496, 10594.841077383846, 359933.0, 363603.0, 364591.0, 366307.0, 523960.0, 70836.291637084, 76906.0, 78047.219527804, 78081.2191878074, 78446.6077669608, 1033.3644808442752, 1061.787642471509, 1070.347088276151, 1078.9406582637873, 1090.8200146975819, 16080.839191608402, 16363.754543682093, 16577.254023568727, 16862.409815656392, 17131.229094691018, 34956.0, 36653.63346366502, 36688.63311366852, 37787.0, 37866.0533486665, 51929.740351298, 53633.90477904593, 53955.0, 54073.45926540842, 54551.0, 7169.283071692789, 7817.843643127219, 7990.121086680577, 8067.3949453792375, 8149.674013039412, 10238.33450825694, 12171.573994910135, 12273.202241854608, 12630.557930472389, 12636.873631263938, 10846.186536009673, 11007.449627518752, 11149.721256968316, 11176.0, 11201.943990279997, 11210.775784484427, 11229.88770112321, 11336.546538138382, 11404.372759497975, 11504.137189710638, 11594.362310073027, 11607.129465290305, 11741.941290293495, 11824.113191510844, 11862.703432413913, 7241.5293005954445, 7508.511946723445, 7543.358814500829, 7714.997050383414, 8696.0, 10153.746156346151, 11040.779184416428, 11133.888661113286, 11238.943805280922, 11411.315321080761], "value": 8718.669634507549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.8732126787318, 1508.894377393582, 1546.7138579362818, 1689.417151082876, 1807.204829874854, 7735.651895664694, 8023.27790498855, 8094.514329140248, 8099.311558517518, 8108.716194933186, 8083.595820208995, 8332.791680207998, 8333.958330208341, 8342.541160236184, 8349.41554091214, 1979.9902049954483, 2208.61349263879, 2280.213326402393, 2295.1278514164596, 2342.1334106380664, 2358.1628521874745, 2366.0535785685693, 2374.03851440167, 2375.572396968545, 2375.714914210297, 2271.681964524968, 2316.3051084674617, 2322.280093171114, 2333.288347054148, 2335.5095429959642, 1989.6717041688105, 2177.684235785818, 2236.8769717665523, 2244.0799272298277, 2245.0682966568857, 2211.0934516848015, 2220.2340192633515, 2234.340869443518, 2237.071615279657, 2247.3370355745096, 7922.762317130495, 8000.8399832003615, 8004.119546849842, 8019.278264956182, 8024.27781499662, 4885.7312847793355, 5053.393592768891, 5060.418051924039, 5081.034603425374, 5082.796688132507, 3297.55483009793, 3365.9158521036925, 3378.341223461426, 3409.641987591292, 3426.7601267911255, 1095.895889890459, 1099.5546803544578, 1105.485949033695, 1113.1706878375662, 1140.5095808802212, 11412.258203216847, 11496.482658280314, 11541.653750387502, 11643.708907277301, 11646.534138634444, 4269.893252668709, 4372.759498227628, 4503.121891231244, 4525.683202175816, 4552.521985191507, 9910.554025068745, 9918.851217231748, 9949.353292035994, 9953.153981911473, 9993.550290236957, 4493.7977790999485, 5128.974355128201, 5133.717645529457, 5159.09715799741, 5171.4052883918075, 4227.7040607157205, 4248.9787551062045, 4255.893602659959, 4570.13167498181, 4697.553732395417, 3912.8630497932436, 3952.130531283113, 3994.6005399459823, 4025.3156963316305, 4081.3673880548563, 1257.1262972234392, 1262.5581046633604, 1274.6877015131352, 1297.2151848131743, 1300.206873806977, 1017.8473229015707, 1020.6937918624383, 1034.3070143004206, 1043.0508237503986, 1052.6578861869923, 5994.1608174855555, 6033.668148251801, 6063.575549711478, 6079.908801367983, 6249.281332646713, 397.8130278768974, 399.2334717342709, 409.66202882621957, 410.94452248946607, 416.6167126243863, 4086.8569600063856, 4115.794210289474, 4119.279126152911, 4128.876133715993, 4155.335146376626, 9786.5596048178, 10185.032421919906, 10277.794444111076, 10288.279820412648, 10295.279330446947, 10043.19654427644, 10078.294519383719, 10133.2906696532, 10175.440350780778, 10180.083792458714, 7965.322947549524, 7999.200079992071, 8061.395395345373, 8070.273675369128, 8077.071136819341, 5669.7165141741925, 5671.461211185096, 5706.400827913009, 5816.47651711348, 5942.959982003219, 9153.496557689392, 9211.124943130391, 9392.81214375695, 9395.483248421402, 9423.670171543963, 9025.638974440948, 9304.627814887328, 9472.857907131262, 9547.236221102155, 9564.76088097803, 6567.671616419065, 7114.466415018791, 7211.2428195038765, 7308.196098429275, 7311.524750891175, 7882.921170788448, 7905.446618736633, 7931.405144614292, 7942.285194332538, 7944.126146124037, 6996.825079373057, 7210.351068403869, 7239.710411583688, 7340.339369456561, 7352.0, 7057.153141623038, 7129.144502659714, 7151.32062454066, 7159.355657990805, 7173.6353741633, 6801.9319806801295, 6861.519693621598, 6894.0, 6901.965490172718, 6902.516823822284, 5075.746212689277, 5092.108880945893, 5105.617078719037, 5108.719020453911, 5122.052420302256, 5015.573676237561, 5179.45615710345, 5184.248283998874, 5198.636095473281, 5279.577633789211], "value": 4379.886538193458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.28505306839054, 301.71789376932566, 304.6466099324783, 304.98170109793415, 305.3191383215431, 5291.973540132303, 5364.91952620711, 5566.805161819337, 5589.357223919245, 5590.748416321265, 5459.754311056002, 5562.332520097584, 5566.304211973504, 5572.749226284816, 5623.297087864017, 4288.270993931032, 4309.0, 4309.482862056542, 4321.82712691492, 4329.0, 3958.9208215835665, 4126.938095928548, 4252.489701235856, 4302.397664326997, 4321.956780432187, 4207.705460617758, 4217.978910105445, 4239.321708526621, 4243.618074373306, 4244.851430199944, 4204.306289462251, 4208.242516347056, 4213.557576454459, 4223.704340696153, 4237.322028475429, 3606.9278614427562, 3687.557493100845, 3691.575468821093, 3696.6303369663087, 3705.2404257127496, 5330.92003619946, 5356.678599284055, 5356.839294821161, 5356.892862142735, 5363.839084827461, 4872.074305881871, 4875.317455556225, 4878.487758785347, 4879.853604391874, 4888.608911287089, 5702.0, 5785.8553536161935, 5814.970925145347, 5837.824865254049, 5838.591298609099, 3989.98005009976, 4016.0, 4030.556638769733, 4032.1532478179615, 4040.7979601019833, 6050.42520960508, 6058.363871793443, 6071.757129714851, 6076.635401875901, 6097.237845269341, 4009.1179940413062, 4060.3706425504092, 4085.22380747657, 4096.795160242035, 4131.194417088699, 4149.066460046526, 4150.149219410014, 4151.626353628188, 4159.854405095807, 4189.2040512302565, 4821.132196204717, 4839.41926968766, 4842.564169224786, 4843.75781210938, 4844.612431005511, 5694.487496125285, 5826.504747096545, 5867.706614669335, 5871.148683440877, 5879.470847623649, 1362.6593351662084, 1398.9650258743409, 1451.0350616839894, 1454.3382760844001, 1456.410153887677, 979.3242662562809, 986.605357856863, 1004.352192835617, 1008.7377281906757, 1014.4826138669332, 5605.860717997853, 5607.775688972477, 5611.102223644279, 5623.578231632644, 5642.153676948408, 5880.647161170344, 5912.438318359749, 5923.911141332884, 5942.1383899335215, 5970.9701451492465, 5416.106342453451, 5607.186957891083, 5629.071203251499, 5690.2033715279895, 5723.8569035774435, 3210.6628803975245, 3211.6306624738454, 3212.180893872048, 3224.7742658013713, 3226.8870589529256, 6186.381361863778, 6251.218597675291, 6254.593451425642, 6303.495720342362, 6307.9369206308265, 6136.343187339483, 6179.474744646755, 6197.194364732646, 6202.7670038786, 6210.4410603045035, 6230.906536401958, 6239.812805615838, 6243.843903902439, 6285.182926219562, 6297.527685423612, 5921.14143449206, 6062.393760623902, 6076.240469941257, 6097.298810636834, 6104.572679912363, 6030.6080104793045, 6044.576879618385, 6047.09293605945, 6051.7579296827635, 6055.636661800306, 6125.173101631401, 6304.873902522016, 6314.431701146735, 6328.335524769833, 6333.145025421509, 4060.9187816244103, 4067.613576710208, 4082.755034697928, 4085.8774236772942, 4092.304308267542, 5782.190493330853, 5922.230110085661, 6069.696515174312, 6077.513798896166, 6086.573939824169, 5854.765809367577, 5876.500497457593, 5890.440408161217, 5921.792737254175, 5927.733252003756, 5897.085951677497, 5898.439648233411, 5907.527397808251, 5915.970420147872, 5925.733341999534, 5632.267805185464, 5803.578123359804, 5815.709214539341, 5821.417858214145, 5826.912596311144, 5884.735186916513, 5926.170336152856, 5926.288845338587, 5934.554908381975, 5947.613405128653, 5461.208124821958, 5747.885042299047, 5810.186573879745, 5810.883782324415, 5812.476877081083], "value": 4405.961530810095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.0507391130643, 797.992020079799, 852.049964289817, 864.0883867519768, 868.9963092628013, 13179.7364052719, 13350.132241404302, 13364.19814811112, 13385.063045586812, 13427.932860335684, 14059.718805623907, 14574.781378279335, 14579.416823327054, 14604.196769177692, 14638.26808659568, 670.6881300195408, 799.5562462833125, 835.9791005224857, 836.9329105390646, 838.5932822581043, 826.1036775099025, 826.9421140520166, 828.581566309013, 829.340674164041, 829.3448175940999, 872.7032808844991, 872.7818045488627, 874.3791907745508, 875.3609864798701, 875.6803766625168, 696.362828012368, 839.1901814748736, 870.3428911172088, 870.582120582121, 871.3813192633238, 633.1357696743958, 635.4503354598239, 635.726637545855, 635.9173307470046, 636.4876274598946, 12985.545505907343, 13007.54473593429, 13014.21914685122, 13018.088733788543, 13025.283609401478, 12273.509059637603, 12582.622521324374, 12748.0, 13068.215907045607, 13158.473661053546, 10790.190735694854, 11107.278026928223, 11164.720881977933, 11195.160362972729, 11400.087992960543, 3702.092987218122, 3711.6473934976134, 3741.6445437683647, 3808.124131449782, 3815.351390263662, 57254.7137264311, 57845.0, 59616.105758414094, 59633.701831491, 60027.399726002615, 10398.532066057045, 10443.791124177626, 10454.790904181873, 10529.84205236922, 10533.683989480327, 16970.40603578869, 16978.830211697972, 17013.0, 17022.48932532026, 17072.658546828992, 7516.361109305771, 7622.047244094489, 7777.611119444005, 7784.455088143889, 7846.254605812439, 4129.236091323115, 4149.128682976549, 4205.201011807747, 4351.912961740747, 4432.202203603382, 3076.338587203717, 3137.984310078435, 3140.371925614886, 3249.7400207983305, 3249.78876373035, 506.2559482582468, 584.4564554963839, 591.775125452334, 601.1103566721278, 608.397686290578, 649.0, 649.6881496881523, 715.3893158592923, 760.9086909570887, 779.5244900610624, 8921.286297096216, 8982.820343593092, 9186.127317904788, 9304.72085837426, 9352.579133938989, 671.9731210751613, 677.2245778583494, 756.9318761311508, 770.7533589251386, 788.6687591211705, 4327.567243275647, 4415.0, 4419.602235798729, 4437.267850804581, 4468.977655111704, 62909.685451573365, 64063.0, 64952.35047649557, 65549.34450655528, 66309.0, 56134.0, 56390.0, 56959.43040569624, 57671.0, 59556.70221648864, 52222.21666675003, 52355.73822130865, 52680.736596316776, 53115.46884531183, 53489.46510534923, 8256.215659512336, 8386.748397547839, 8502.277306429023, 8503.107173746668, 8638.697645582375, 28521.857390712914, 28785.0, 29615.111546653636, 30344.0, 35032.29935401227, 41558.37662435006, 41716.791416042724, 41800.3729944045, 41814.581854181066, 41946.58053419427, 11963.342016188844, 12011.879881201427, 12216.45025973851, 12439.191452555917, 12786.296753678636, 12633.0, 12656.873431265569, 12837.165584237368, 12875.742485150431, 13670.11144275619, 12883.420246089136, 12944.15862968904, 13231.139975901535, 13298.069135160446, 13406.597802065953, 12556.748865022832, 13105.803412949004, 13242.933785331397, 13355.399007044512, 13377.66555836073, 11825.881741182478, 12894.41975111141, 13346.799798003232, 13460.0, 13989.720205596035, 10554.155667546731, 10681.412522311348, 10683.358998460117, 11031.779364412827, 11346.886531134583, 10871.565137394731, 10886.836697449702, 10911.0, 10984.176186785864, 11062.446877656246], "value": 6646.697940560334, "unit": "score"}], "name": "dromaeo_css", "value": 6940.315255256871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 105.0, 110.0, 112.0, 111.0, 99.0, 110.0, 110.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 134.0, 152.0, 183.0, 128.0, 156.0, 151.0, 127.0, 200.0, 127.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 102.0, 109.0, 76.0, 75.0, 72.0, 114.0, 104.0, 73.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 92.0, 92.0, 93.0, 144.0, 93.0, 92.0, 151.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 55.0, 55.0, 55.0, 58.0, 73.0, 55.0, 53.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 75.0, 75.0, 76.0, 77.0, 77.0, 77.0, 76.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 124.0, 123.0, 124.0, 121.0, 121.0, 124.0, 159.0, 126.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 164.0, 162.0, 164.0, 166.0, 162.0, 162.0, 174.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 70.0, 68.0, 68.0, 70.0, 68.0, 67.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1529.7000000000003, "alertThreshold": 2.0}]} 17:32:59 INFO - Return code: 0 17:32:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:32:59 ERROR - # TBPL SUCCESS # 17:32:59 INFO - Running post-action listener: _resource_record_post_action 17:32:59 INFO - Running post-run listener: _resource_record_post_run 17:33:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 540106752; Read time: 0; Write time: 425024 17:33:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244473856; Read time: 0; Write time: 211736 17:33:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295448576; Read time: 0; Write time: 213268 17:33:01 INFO - Running post-run listener: _upload_blobber_files 17:33:01 INFO - Blob upload gear active. 17:33:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:01 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 17:33:01 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'] 17:33:01 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 17:33:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:02 INFO - (blobuploader) - INFO - Done attempting. 17:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:03 INFO - (blobuploader) - INFO - Done attempting. 17:33:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:03 INFO - Return code: 0 17:33:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3d15c1b410f36ce0dc74af39417b9aba90d865f2750fe7262fee941f68063695e3bcdf5b406a18ac1d026c3f00cfb8b74b3fd76a486b1866a1ab8a1c0c9e84e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e66ca2e60bb49501ba5dcb059b4d81d109e6bfcce86bd4455ab028b5f2f94d866ae6d6c5332e4e193da0ee98b8fd5403a4ef952bae1d19c1d6afd6fe3e7d239"} 17:33:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:03 INFO - Contents: 17:33:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3d15c1b410f36ce0dc74af39417b9aba90d865f2750fe7262fee941f68063695e3bcdf5b406a18ac1d026c3f00cfb8b74b3fd76a486b1866a1ab8a1c0c9e84e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e66ca2e60bb49501ba5dcb059b4d81d109e6bfcce86bd4455ab028b5f2f94d866ae6d6c5332e4e193da0ee98b8fd5403a4ef952bae1d19c1d6afd6fe3e7d239"} 17:33:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:03 INFO - Copying logs to upload dir... 17:33:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.498584 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-20 17:33:02.477603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 17:33:02.481497) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589 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/d3d15c1b410f36ce0dc74af39417b9aba90d865f2750fe7262fee941f68063695e3bcdf5b406a18ac1d026c3f00cfb8b74b3fd76a486b1866a1ab8a1c0c9e84e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e66ca2e60bb49501ba5dcb059b4d81d109e6bfcce86bd4455ab028b5f2f94d866ae6d6c5332e4e193da0ee98b8fd5403a4ef952bae1d19c1d6afd6fe3e7d239"} build_url:https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/XUBEJcVpRaK_G5GvssrCaw/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/d3d15c1b410f36ce0dc74af39417b9aba90d865f2750fe7262fee941f68063695e3bcdf5b406a18ac1d026c3f00cfb8b74b3fd76a486b1866a1ab8a1c0c9e84e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e66ca2e60bb49501ba5dcb059b4d81d109e6bfcce86bd4455ab028b5f2f94d866ae6d6c5332e4e193da0ee98b8fd5403a4ef952bae1d19c1d6afd6fe3e7d239"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 17:33:02.506043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:33:02.506378) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461195495.914352-1579823589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:33:02.590538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 17:33:02.590865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 17:33:02.591163) ========= ========= Total master_lag: 0.17 =========