builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1461271096.57 results: success (0) buildid: 20160421130623 builduid: 80cedbe1cfe94b50bba3723e71cef2cd revision: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.568229) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.568741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.569042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.596123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.596416) ========= 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=d2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 13:38:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-04-21 13:38:16 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.716795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.717153) ========= 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=d2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020041 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.773850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.774246) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 --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 b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 --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=d2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 13:38:17,011 truncating revision to first 12 chars 2016-04-21 13:38:17,011 Setting DEBUG logging. 2016-04-21 13:38:17,011 attempt 1/10 2016-04-21 13:38:17,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b31b99289389?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 13:38:17,260 unpacking tar archive at: fx-team-b31b99289389/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.311675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.311997) ========= script_repo_revision: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.312421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.312696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.323902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-21 13:38:17.324333) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:38:17 INFO - MultiFileLogger online at 20160421 13:38:17 in /builds/slave/test 13:38:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:38:17 INFO - {'append_to_log': False, 13:38:17 INFO - 'base_work_dir': '/builds/slave/test', 13:38:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:38:17 INFO - 'branch': 'Fx-Team-Non-PGO', 13:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 13:38:17 INFO - 'config_files': ('talos/linux_config.py',), 13:38:17 INFO - 'default_actions': ('clobber', 13:38:17 INFO - 'read-buildbot-config', 13:38:17 INFO - 'download-and-extract', 13:38:17 INFO - 'populate-webroot', 13:38:17 INFO - 'create-virtualenv', 13:38:17 INFO - 'install', 13:38:17 INFO - 'run-tests'), 13:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:38:17 INFO - 'download_minidump_stackwalk': True, 13:38:17 INFO - 'download_symbols': 'ondemand', 13:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 13:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 13:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:38:17 INFO - 'installer_path': 'installer.exe', 13:38:17 INFO - 'log_level': 'info', 13:38:17 INFO - 'log_name': 'talos', 13:38:17 INFO - 'log_to_console': True, 13:38:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:38:17 INFO - 'opt_config_files': (), 13:38:17 INFO - 'pip_index': False, 13:38:17 INFO - 'sps_profile': False, 13:38:17 INFO - 'sps_profile_interval': 0, 13:38:17 INFO - 'suite': 'dromaeojs', 13:38:17 INFO - 'system_bits': '32', 13:38:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:38:17 INFO - 'title': 'talos-linux64-ix-043', 13:38:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:38:17 INFO - 'use_talos_json': True, 13:38:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:38:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:38:17 INFO - 'work_dir': 'build'} 13:38:17 INFO - ##### 13:38:17 INFO - ##### Running clobber step. 13:38:17 INFO - ##### 13:38:17 INFO - Running pre-action listener: _resource_record_pre_action 13:38:17 INFO - Running main action method: clobber 13:38:17 INFO - rmtree: /builds/slave/test/build 13:38:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:38:18 INFO - Running post-action listener: _resource_record_post_action 13:38:18 INFO - ##### 13:38:18 INFO - ##### Running read-buildbot-config step. 13:38:18 INFO - ##### 13:38:18 INFO - Running pre-action listener: _resource_record_pre_action 13:38:18 INFO - Running main action method: read_buildbot_config 13:38:18 INFO - Using buildbot properties: 13:38:18 INFO - { 13:38:18 INFO - "project": "", 13:38:18 INFO - "product": "firefox", 13:38:18 INFO - "script_repo_revision": "production", 13:38:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:38:18 INFO - "repository": "", 13:38:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:38:18 INFO - "buildid": "20160421130623", 13:38:18 INFO - "pgo_build": "False", 13:38:18 INFO - "basedir": "/builds/slave/test", 13:38:18 INFO - "buildnumber": 1582, 13:38:18 INFO - "slavename": "talos-linux64-ix-043", 13:38:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:38:18 INFO - "platform": "ubuntu64_hw", 13:38:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:38:18 INFO - "branch": "fx-team", 13:38:18 INFO - "repo_path": "integration/fx-team", 13:38:18 INFO - "revision": "b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4", 13:38:18 INFO - "stage_platform": "linux64", 13:38:18 INFO - "builduid": "80cedbe1cfe94b50bba3723e71cef2cd", 13:38:18 INFO - "slavebuilddir": "test" 13:38:18 INFO - } 13:38:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:38:18 INFO - Running post-action listener: _resource_record_post_action 13:38:18 INFO - ##### 13:38:18 INFO - ##### Running download-and-extract step. 13:38:18 INFO - ##### 13:38:18 INFO - Running pre-action listener: _resource_record_pre_action 13:38:18 INFO - Running main action method: download_and_extract 13:38:18 INFO - mkdir: /builds/slave/test/build/tests 13:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:18 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:38:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:38:19 INFO - Downloaded 1361 bytes. 13:38:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:19 INFO - Using the following test package requirements: 13:38:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:38:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:38:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:38:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'jsshell-linux-x86_64.zip'], 13:38:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:38:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:38:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:38:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:38:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:38:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:38:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:38: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')]} 13:38:19 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:38:22 INFO - Downloaded 22275480 bytes. 13:38:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:38:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:38:23 INFO - Return code: 0 13:38:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:23 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:38:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:38:39 INFO - Downloaded 22275480 bytes. 13:38:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:38:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:38:40 INFO - Return code: 0 13:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:40 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:38:42 INFO - Downloaded 10845952 bytes. 13:38:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:38:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:38:42 INFO - Return code: 0 13:38: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')]} 13:38:42 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:38:44 INFO - Downloaded 54622518 bytes. 13:38:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:44 INFO - mkdir: /builds/slave/test/properties 13:38:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:38:44 INFO - Writing to file /builds/slave/test/properties/build_url 13:38:44 INFO - Contents: 13:38:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:44 INFO - Running post-action listener: _resource_record_post_action 13:38:44 INFO - Running post-action listener: set_extra_try_arguments 13:38:44 INFO - ##### 13:38:44 INFO - ##### Running populate-webroot step. 13:38:44 INFO - ##### 13:38:44 INFO - Running pre-action listener: _resource_record_pre_action 13:38:44 INFO - Running main action method: populate_webroot 13:38:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:38:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:38:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:38:44 INFO - '--tppagecycles', 13:38:44 INFO - '7'], 13:38:44 INFO - 'tests': ['tsvgm']}}, 13:38:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:38:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:38:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:38:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:38:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['damp', 'tps']}, 13:38:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'tests': ['damp', 'tps']}, 13:38:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['dromaeo_dom']}, 13:38:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:38:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['a11yr', 13:38:44 INFO - 'ts_paint', 13:38:44 INFO - 'tpaint', 13:38:44 INFO - 'sessionrestore', 13:38:44 INFO - 'sessionrestore_no_auto_restore', 13:38:44 INFO - 'tabpaint']}, 13:38:44 INFO - 'other-e10s': {'tests': ['a11yr', 13:38:44 INFO - 'ts_paint', 13:38:44 INFO - 'tpaint', 13:38:44 INFO - 'sessionrestore', 13:38:44 INFO - 'sessionrestore_no_auto_restore', 13:38:44 INFO - 'tabpaint']}, 13:38:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:38:44 INFO - 'ts_paint', 13:38:44 INFO - 'tpaint', 13:38:44 INFO - 'sessionrestore', 13:38:44 INFO - 'sessionrestore_no_auto_restore', 13:38:44 INFO - 'tabpaint']}, 13:38:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:38:44 INFO - 'ts_paint', 13:38:44 INFO - 'tpaint', 13:38:44 INFO - 'sessionrestore', 13:38:44 INFO - 'sessionrestore_no_auto_restore', 13:38:44 INFO - 'tabpaint']}, 13:38:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['a11yr', 13:38:44 INFO - 'ts_paint', 13:38:44 INFO - 'tpaint', 13:38:44 INFO - 'sessionrestore', 13:38:44 INFO - 'sessionrestore_no_auto_restore', 13:38:44 INFO - 'tabpaint']}, 13:38:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['a11yr', 13:38:44 INFO - 'ts_paint', 13:38:44 INFO - 'tpaint', 13:38:44 INFO - 'sessionrestore', 13:38:44 INFO - 'sessionrestore_no_auto_restore', 13:38:44 INFO - 'tabpaint']}, 13:38:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['tsvgx', 13:38:44 INFO - 'tsvgr_opacity', 13:38:44 INFO - 'tart', 13:38:44 INFO - 'tscrollx', 13:38:44 INFO - 'cart']}, 13:38:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:38:44 INFO - 'tsvgr_opacity', 13:38:44 INFO - 'tart', 13:38:44 INFO - 'tscrollx', 13:38:44 INFO - 'cart']}, 13:38:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'talos_options': ['--disable-e10s'], 13:38:44 INFO - 'tests': ['tp5o']}, 13:38:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'tests': ['tp5o']}, 13:38:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'talos_options': ['--disable-e10s', 13:38:44 INFO - '--xperf_path', 13:38:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:44 INFO - 'tests': ['tp5n']}, 13:38:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:44 INFO - 'talos_options': ['--xperf_path', 13:38:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:44 INFO - 'tests': ['tp5n']}}, 13:38:44 INFO - 'talos.zip': {'path': '', 13:38:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:38:44 INFO - Running post-action listener: _resource_record_post_action 13:38:44 INFO - ##### 13:38:44 INFO - ##### Running create-virtualenv step. 13:38:44 INFO - ##### 13:38:44 INFO - Running pre-action listener: _resource_record_pre_action 13:38:44 INFO - Running main action method: create_virtualenv 13:38:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:38:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:38:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:38:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:38:44 INFO - Using real prefix '/usr' 13:38:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:38:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:38:47 INFO - Installing pip.................done. 13:38:47 INFO - Return code: 0 13:38:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:38:47 INFO - Using env: {'DISPLAY': ':0', 13:38:47 INFO - 'HOME': '/home/cltbld', 13:38:47 INFO - 'LANG': 'en_US.UTF-8', 13:38:47 INFO - 'LANGUAGE': 'en_US:en', 13:38:47 INFO - 'LOGNAME': 'cltbld', 13:38:47 INFO - 'MAIL': '/var/mail/cltbld', 13:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:47 INFO - 'MOZ_NO_REMOTE': '1', 13:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:47 INFO - 'NO_EM_RESTART': '1', 13:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:47 INFO - 'PWD': '/builds/slave/test', 13:38:47 INFO - 'SHELL': '/bin/bash', 13:38:47 INFO - 'SHLVL': '1', 13:38:47 INFO - 'TERM': 'linux', 13:38:47 INFO - 'TMOUT': '86400', 13:38:47 INFO - 'USER': 'cltbld', 13:38:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:47 INFO - '_': '/tools/buildbot/bin/python'} 13:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:38:47 INFO - Cleaning up... 13:38:47 INFO - Return code: 0 13:38:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:38:47 INFO - Using env: {'DISPLAY': ':0', 13:38:47 INFO - 'HOME': '/home/cltbld', 13:38:47 INFO - 'LANG': 'en_US.UTF-8', 13:38:47 INFO - 'LANGUAGE': 'en_US:en', 13:38:47 INFO - 'LOGNAME': 'cltbld', 13:38:47 INFO - 'MAIL': '/var/mail/cltbld', 13:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:47 INFO - 'MOZ_NO_REMOTE': '1', 13:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:47 INFO - 'NO_EM_RESTART': '1', 13:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:47 INFO - 'PWD': '/builds/slave/test', 13:38:47 INFO - 'SHELL': '/bin/bash', 13:38:47 INFO - 'SHLVL': '1', 13:38:47 INFO - 'TERM': 'linux', 13:38:47 INFO - 'TMOUT': '86400', 13:38:47 INFO - 'USER': 'cltbld', 13:38:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:47 INFO - '_': '/tools/buildbot/bin/python'} 13:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:47 INFO - Downloading/unpacking psutil>=0.7.1 13:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:38:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:49 INFO - Installing collected packages: psutil 13:38:49 INFO - Running setup.py install for psutil 13:38:49 INFO - building 'psutil._psutil_linux' extension 13:38:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:38:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:38:50 INFO - building 'psutil._psutil_posix' extension 13:38:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:38:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:38:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:50 INFO - Successfully installed psutil 13:38:50 INFO - Cleaning up... 13:38:50 INFO - Return code: 0 13:38:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:38:50 INFO - Using env: {'DISPLAY': ':0', 13:38:50 INFO - 'HOME': '/home/cltbld', 13:38:50 INFO - 'LANG': 'en_US.UTF-8', 13:38:50 INFO - 'LANGUAGE': 'en_US:en', 13:38:50 INFO - 'LOGNAME': 'cltbld', 13:38:50 INFO - 'MAIL': '/var/mail/cltbld', 13:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:50 INFO - 'MOZ_NO_REMOTE': '1', 13:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:50 INFO - 'NO_EM_RESTART': '1', 13:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:50 INFO - 'PWD': '/builds/slave/test', 13:38:50 INFO - 'SHELL': '/bin/bash', 13:38:50 INFO - 'SHLVL': '1', 13:38:50 INFO - 'TERM': 'linux', 13:38:50 INFO - 'TMOUT': '86400', 13:38:50 INFO - 'USER': 'cltbld', 13:38:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:50 INFO - '_': '/tools/buildbot/bin/python'} 13:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:38:52 INFO - Installing collected packages: mozsystemmonitor 13:38:52 INFO - Running setup.py install for mozsystemmonitor 13:38:52 INFO - Successfully installed mozsystemmonitor 13:38:52 INFO - Cleaning up... 13:38:52 INFO - Return code: 0 13:38:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:52 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 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:38:52 INFO - Using env: {'DISPLAY': ':0', 13:38:52 INFO - 'HOME': '/home/cltbld', 13:38:52 INFO - 'LANG': 'en_US.UTF-8', 13:38:52 INFO - 'LANGUAGE': 'en_US:en', 13:38:52 INFO - 'LOGNAME': 'cltbld', 13:38:52 INFO - 'MAIL': '/var/mail/cltbld', 13:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:52 INFO - 'MOZ_NO_REMOTE': '1', 13:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:52 INFO - 'NO_EM_RESTART': '1', 13:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:52 INFO - 'PWD': '/builds/slave/test', 13:38:52 INFO - 'SHELL': '/bin/bash', 13:38:52 INFO - 'SHLVL': '1', 13:38:52 INFO - 'TERM': 'linux', 13:38:52 INFO - 'TMOUT': '86400', 13:38:52 INFO - 'USER': 'cltbld', 13:38:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:52 INFO - '_': '/tools/buildbot/bin/python'} 13:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:38:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:38:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:55 INFO - Downloading docopt-0.6.1.tar.gz 13:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:38:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:38:55 INFO - Running setup.py install for blobuploader 13:38:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:38:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:38:55 INFO - Running setup.py install for requests 13:38:55 INFO - Running setup.py install for docopt 13:38:56 INFO - Successfully installed blobuploader requests docopt 13:38:56 INFO - Cleaning up... 13:38:56 INFO - Return code: 0 13:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:56 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 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:38:56 INFO - Using env: {'DISPLAY': ':0', 13:38:56 INFO - 'HOME': '/home/cltbld', 13:38:56 INFO - 'LANG': 'en_US.UTF-8', 13:38:56 INFO - 'LANGUAGE': 'en_US:en', 13:38:56 INFO - 'LOGNAME': 'cltbld', 13:38:56 INFO - 'MAIL': '/var/mail/cltbld', 13:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:56 INFO - 'MOZ_NO_REMOTE': '1', 13:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:56 INFO - 'NO_EM_RESTART': '1', 13:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:56 INFO - 'PWD': '/builds/slave/test', 13:38:56 INFO - 'SHELL': '/bin/bash', 13:38:56 INFO - 'SHLVL': '1', 13:38:56 INFO - 'TERM': 'linux', 13:38:56 INFO - 'TMOUT': '86400', 13:38:56 INFO - 'USER': 'cltbld', 13:38:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:56 INFO - '_': '/tools/buildbot/bin/python'} 13:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:56 INFO - Running setup.py (path:/tmp/pip-MnQIt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:56 INFO - Running setup.py (path:/tmp/pip-cuEYFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:56 INFO - Running setup.py (path:/tmp/pip-gRLZhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:56 INFO - Running setup.py (path:/tmp/pip-477G46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:56 INFO - Running setup.py (path:/tmp/pip-X6s94d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:56 INFO - Running setup.py (path:/tmp/pip-TKGPvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:38:56 INFO - Running setup.py (path:/tmp/pip-86vRtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:38:56 INFO - Running setup.py (path:/tmp/pip-3n3ZvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:38:56 INFO - Running setup.py (path:/tmp/pip-G6owKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:38:57 INFO - Running setup.py (path:/tmp/pip-cuFWQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:38:57 INFO - Running setup.py (path:/tmp/pip-JQMsJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:38:57 INFO - Running setup.py (path:/tmp/pip-kOC4MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:38:57 INFO - Running setup.py (path:/tmp/pip-sibUWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:38:57 INFO - Running setup.py (path:/tmp/pip-IJWUJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:57 INFO - Running setup.py (path:/tmp/pip-ecqi27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:38:57 INFO - Running setup.py (path:/tmp/pip-VbrzjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:38:57 INFO - Running setup.py (path:/tmp/pip-062g4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:38:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:38:57 INFO - Running setup.py install for manifestparser 13:38:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:38:57 INFO - Running setup.py install for mozcrash 13:38:57 INFO - Running setup.py install for mozdebug 13:38:57 INFO - Running setup.py install for mozdevice 13:38:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:38:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:38:57 INFO - Running setup.py install for mozfile 13:38:58 INFO - Running setup.py install for mozhttpd 13:38:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Running setup.py install for mozinfo 13:38:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Running setup.py install for mozInstall 13:38:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Running setup.py install for mozleak 13:38:58 INFO - Running setup.py install for mozlog 13:38:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Running setup.py install for moznetwork 13:38:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Running setup.py install for mozprocess 13:38:58 INFO - Running setup.py install for mozprofile 13:38:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:38:58 INFO - Running setup.py install for mozrunner 13:38:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:38:59 INFO - Running setup.py install for mozscreenshot 13:38:59 INFO - Running setup.py install for moztest 13:38:59 INFO - Running setup.py install for mozversion 13:38:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:38:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:38:59 INFO - Cleaning up... 13:38:59 INFO - Return code: 0 13:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:59 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 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:38:59 INFO - Using env: {'DISPLAY': ':0', 13:38:59 INFO - 'HOME': '/home/cltbld', 13:38:59 INFO - 'LANG': 'en_US.UTF-8', 13:38:59 INFO - 'LANGUAGE': 'en_US:en', 13:38:59 INFO - 'LOGNAME': 'cltbld', 13:38:59 INFO - 'MAIL': '/var/mail/cltbld', 13:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:59 INFO - 'MOZ_NO_REMOTE': '1', 13:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:59 INFO - 'NO_EM_RESTART': '1', 13:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:59 INFO - 'PWD': '/builds/slave/test', 13:38:59 INFO - 'SHELL': '/bin/bash', 13:38:59 INFO - 'SHLVL': '1', 13:38:59 INFO - 'TERM': 'linux', 13:38:59 INFO - 'TMOUT': '86400', 13:38:59 INFO - 'USER': 'cltbld', 13:38:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:59 INFO - '_': '/tools/buildbot/bin/python'} 13:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:59 INFO - Running setup.py (path:/tmp/pip-EQ6U5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:59 INFO - Running setup.py (path:/tmp/pip-4TfW1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:59 INFO - Running setup.py (path:/tmp/pip-p15_4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:59 INFO - Running setup.py (path:/tmp/pip-yZwCmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:59 INFO - Running setup.py (path:/tmp/pip-btefMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:59 INFO - Running setup.py (path:/tmp/pip-u5SWp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:00 INFO - Running setup.py (path:/tmp/pip-iL4r1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:00 INFO - Running setup.py (path:/tmp/pip-kYEzsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:00 INFO - Running setup.py (path:/tmp/pip-Oyyzgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:00 INFO - Running setup.py (path:/tmp/pip-q3zB2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:00 INFO - Running setup.py (path:/tmp/pip-xKj0ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:00 INFO - Running setup.py (path:/tmp/pip-R4HAFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:00 INFO - Running setup.py (path:/tmp/pip-qqNvMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:00 INFO - Running setup.py (path:/tmp/pip-4JRxXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:00 INFO - Running setup.py (path:/tmp/pip-VUyuXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:00 INFO - Running setup.py (path:/tmp/pip-blQzM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:00 INFO - Running setup.py (path:/tmp/pip-LWK9g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:02 INFO - Downloading blessings-1.6.tar.gz 13:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:02 INFO - Installing collected packages: blessings 13:39:02 INFO - Running setup.py install for blessings 13:39:02 INFO - Successfully installed blessings 13:39:02 INFO - Cleaning up... 13:39:02 INFO - Return code: 0 13:39:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:03 INFO - Reading from file tmpfile_stdout 13:39:03 INFO - Current package versions: 13:39:03 INFO - argparse == 1.2.1 13:39:03 INFO - blessings == 1.6 13:39:03 INFO - blobuploader == 1.2.4 13:39:03 INFO - docopt == 0.6.1 13:39:03 INFO - manifestparser == 1.1 13:39:03 INFO - mozInstall == 1.12 13:39:03 INFO - mozcrash == 0.17 13:39:03 INFO - mozdebug == 0.1 13:39:03 INFO - mozdevice == 0.48 13:39:03 INFO - mozfile == 1.2 13:39:03 INFO - mozhttpd == 0.7 13:39:03 INFO - mozinfo == 0.9 13:39:03 INFO - mozleak == 0.1 13:39:03 INFO - mozlog == 3.1 13:39:03 INFO - moznetwork == 0.27 13:39:03 INFO - mozprocess == 0.22 13:39:03 INFO - mozprofile == 0.28 13:39:03 INFO - mozrunner == 6.11 13:39:03 INFO - mozscreenshot == 0.1 13:39:03 INFO - mozsystemmonitor == 0.0 13:39:03 INFO - moztest == 0.7 13:39:03 INFO - mozversion == 1.4 13:39:03 INFO - psutil == 3.1.1 13:39:03 INFO - requests == 1.2.3 13:39:03 INFO - wsgiref == 0.1.2 13:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:03 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 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:03 INFO - Using env: {'DISPLAY': ':0', 13:39:03 INFO - 'HOME': '/home/cltbld', 13:39:03 INFO - 'LANG': 'en_US.UTF-8', 13:39:03 INFO - 'LANGUAGE': 'en_US:en', 13:39:03 INFO - 'LOGNAME': 'cltbld', 13:39:03 INFO - 'MAIL': '/var/mail/cltbld', 13:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:03 INFO - 'MOZ_NO_REMOTE': '1', 13:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:03 INFO - 'NO_EM_RESTART': '1', 13:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:03 INFO - 'PWD': '/builds/slave/test', 13:39:03 INFO - 'SHELL': '/bin/bash', 13:39:03 INFO - 'SHLVL': '1', 13:39:03 INFO - 'TERM': 'linux', 13:39:03 INFO - 'TMOUT': '86400', 13:39:03 INFO - 'USER': 'cltbld', 13:39:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:03 INFO - '_': '/tools/buildbot/bin/python'} 13:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:03 INFO - Cleaning up... 13:39:03 INFO - Return code: 0 13:39:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:39:03 INFO - Using env: {'DISPLAY': ':0', 13:39:03 INFO - 'HOME': '/home/cltbld', 13:39:03 INFO - 'LANG': 'en_US.UTF-8', 13:39:03 INFO - 'LANGUAGE': 'en_US:en', 13:39:03 INFO - 'LOGNAME': 'cltbld', 13:39:03 INFO - 'MAIL': '/var/mail/cltbld', 13:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:03 INFO - 'MOZ_NO_REMOTE': '1', 13:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:03 INFO - 'NO_EM_RESTART': '1', 13:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:03 INFO - 'PWD': '/builds/slave/test', 13:39:03 INFO - 'SHELL': '/bin/bash', 13:39:03 INFO - 'SHLVL': '1', 13:39:03 INFO - 'TERM': 'linux', 13:39:03 INFO - 'TMOUT': '86400', 13:39:03 INFO - 'USER': 'cltbld', 13:39:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:03 INFO - '_': '/tools/buildbot/bin/python'} 13:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:03 INFO - Downloading/unpacking jsonschema 13:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:05 INFO - Downloading/unpacking functools32 (from jsonschema) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:05 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:05 INFO - warning: no files found matching '*.txt' 13:39:05 INFO - no previously-included directories found matching 'build' 13:39:05 INFO - no previously-included directories found matching 'dist' 13:39:05 INFO - no previously-included directories found matching '.git*' 13:39:05 INFO - Installing collected packages: jsonschema, functools32 13:39:05 INFO - Running setup.py install for functools32 13:39:05 INFO - warning: no files found matching '*.txt' 13:39:05 INFO - no previously-included directories found matching 'build' 13:39:05 INFO - no previously-included directories found matching 'dist' 13:39:05 INFO - no previously-included directories found matching '.git*' 13:39:05 INFO - Successfully installed jsonschema functools32 13:39:05 INFO - Cleaning up... 13:39:05 INFO - Return code: 0 13:39:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:05 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 0x7f5b0cf88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12055a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:39:05 INFO - Using env: {'DISPLAY': ':0', 13:39:05 INFO - 'HOME': '/home/cltbld', 13:39:05 INFO - 'LANG': 'en_US.UTF-8', 13:39:05 INFO - 'LANGUAGE': 'en_US:en', 13:39:05 INFO - 'LOGNAME': 'cltbld', 13:39:05 INFO - 'MAIL': '/var/mail/cltbld', 13:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:05 INFO - 'MOZ_NO_REMOTE': '1', 13:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:05 INFO - 'NO_EM_RESTART': '1', 13:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:05 INFO - 'PWD': '/builds/slave/test', 13:39:05 INFO - 'SHELL': '/bin/bash', 13:39:05 INFO - 'SHLVL': '1', 13:39:05 INFO - 'TERM': 'linux', 13:39:05 INFO - 'TMOUT': '86400', 13:39:05 INFO - 'USER': 'cltbld', 13:39:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:05 INFO - '_': '/tools/buildbot/bin/python'} 13:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:06 INFO - Downloading/unpacking flake8 13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:39:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:39:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:39:08 INFO - no previously-included directories found matching 'docs/_build' 13:39:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:39:08 INFO - Running setup.py install for pep8 13:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:39:08 INFO - no previously-included directories found matching 'docs/_build' 13:39:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:39:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:39:08 INFO - Cleaning up... 13:39:08 INFO - Return code: 0 13:39:08 INFO - Running post-action listener: _resource_record_post_action 13:39:08 INFO - Running post-action listener: _start_resource_monitoring 13:39:09 INFO - Starting resource monitoring. 13:39:09 INFO - ##### 13:39:09 INFO - ##### Running install step. 13:39:09 INFO - ##### 13:39:09 INFO - Running pre-action listener: _resource_record_pre_action 13:39:09 INFO - Running main action method: install 13:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:09 INFO - Reading from file tmpfile_stdout 13:39:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:09 INFO - Reading from file tmpfile_stdout 13:39:09 INFO - Output received: 13:39:09 INFO - Usage: mozinstall [options] installer 13:39:09 INFO - Options: 13:39:09 INFO - -h, --help show this help message and exit 13:39:09 INFO - -d DEST, --destination=DEST 13:39:09 INFO - Directory to install application into. [default: 13:39:09 INFO - "/builds/slave/test"] 13:39:09 INFO - --app=APP Application being installed. [default: firefox] 13:39:09 INFO - mkdir: /builds/slave/test/build/application 13:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:39:25 INFO - Reading from file tmpfile_stdout 13:39:25 INFO - Output received: 13:39:25 INFO - /builds/slave/test/build/application/firefox/firefox 13:39:25 INFO - Running post-action listener: _resource_record_post_action 13:39:25 INFO - ##### 13:39:25 INFO - ##### Running run-tests step. 13:39:25 INFO - ##### 13:39:25 INFO - Running pre-action listener: _resource_record_pre_action 13:39:25 INFO - Running main action method: run_tests 13:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:39:25 INFO - Python 2.7.3 13:39:25 INFO - Return code: 0 13:39:25 INFO - grabbing minidump binary from tooltool 13:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:25 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 0x1294410>, '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 0x1295310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12957a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:39:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:39:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:39:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:39:25 INFO - Return code: 0 13:39:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:39:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:39:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:39:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:39:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:39:26 INFO - Return code: 0 13:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:39:26 INFO - Using env: {'DISPLAY': ':0', 13:39:26 INFO - 'HOME': '/home/cltbld', 13:39:26 INFO - 'LANG': 'en_US.UTF-8', 13:39:26 INFO - 'LANGUAGE': 'en_US:en', 13:39:26 INFO - 'LOGNAME': 'cltbld', 13:39:26 INFO - 'MAIL': '/var/mail/cltbld', 13:39:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:39:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:26 INFO - 'MOZ_NO_REMOTE': '1', 13:39:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:26 INFO - 'NO_EM_RESTART': '1', 13:39:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:26 INFO - 'PWD': '/builds/slave/test', 13:39:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:39:26 INFO - 'SHELL': '/bin/bash', 13:39:26 INFO - 'SHLVL': '1', 13:39:26 INFO - 'TERM': 'linux', 13:39:26 INFO - 'TMOUT': '86400', 13:39:26 INFO - 'USER': 'cltbld', 13:39:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619', 13:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:26 INFO - '_': '/tools/buildbot/bin/python'} 13:39:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:39:26 INFO - mozversion application_buildid: 20160421130623 13:39:26 INFO - mozversion application_changeset: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 13:39:26 INFO - mozversion application_display_name: Nightly 13:39:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:39:26 INFO - mozversion application_name: Firefox 13:39:26 INFO - mozversion application_remotingname: firefox 13:39:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:39:26 INFO - mozversion application_vendor: Mozilla 13:39:26 INFO - mozversion application_version: 48.0a1 13:39:26 INFO - mozversion platform_buildid: 20160421130623 13:39:26 INFO - mozversion platform_changeset: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 13:39:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:39:26 INFO - mozversion platform_version: 48.0a1 13:39:26 INFO - using testdate: 1461271166 13:39:26 INFO - actual date: 1461271166 13:39:26 INFO - starting webserver on 'localhost:48482' 13:39:26 INFO - SUITE-START | Running 2 tests 13:39:26 INFO - TEST-START | dromaeo_css 13:39:26 INFO - operating with platform_type : linux_ 13:39:26 INFO - Initialising browser for dromaeo_css test... 13:39:26 INFO - TEST-INFO | started process 2267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpux0asF/profile http://localhost:48482/getInfo.html) 13:39:30 INFO - PROCESS | 2267 | __metrics Screen width/height:1600/1200 13:39:30 INFO - PROCESS | 2267 | colorDepth:24 13:39:30 INFO - PROCESS | 2267 | Browser inner width/height: 1024/697 13:39:30 INFO - PROCESS | 2267 | __metrics 13:39:31 ERROR - PROCESS | 2267 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:39:32 INFO - TEST-INFO | 2267: exit 0 13:39:32 INFO - Browser initialized. 13:39:32 INFO - Running cycle 1/1 for dromaeo_css test... 13:39:32 INFO - TEST-INFO | started process 2349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpux0asF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:39:44 INFO - PROCESS | 2349 | RSS: Main: 154808320 13:39:44 INFO - PROCESS | 2349 | 13:40:36 INFO - PROCESS | 2349 | 1461271236119 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:42:47 INFO - PROCESS | 2349 | Cycle 1(1): loaded http://localhost:48482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48482/tests/dromaeo/cssquery-ext.html) 13:42:48 INFO - PROCESS | 2349 | RSS: Main: 277147648 13:42:48 INFO - PROCESS | 2349 | 13:45:51 INFO - PROCESS | 2349 | Cycle 1(1): loaded http://localhost:48482/tests/dromaeo/cssquery-ext.html (next: http://localhost:48482/tests/dromaeo/cssquery-jquery.html) 13:45:52 INFO - PROCESS | 2349 | RSS: Main: 238190592 13:45:52 INFO - PROCESS | 2349 | 13:48:54 INFO - PROCESS | 2349 | Cycle 1(1): loaded http://localhost:48482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48482/tests/dromaeo/cssquery-mootools.html) 13:48:54 INFO - PROCESS | 2349 | RSS: Main: 241025024 13:48:54 INFO - PROCESS | 2349 | 13:51:56 INFO - PROCESS | 2349 | Cycle 1(1): loaded http://localhost:48482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48482/tests/dromaeo/cssquery-prototype.html) 13:51:57 INFO - PROCESS | 2349 | RSS: Main: 233353216 13:51:57 INFO - PROCESS | 2349 | 13:55:00 INFO - PROCESS | 2349 | Cycle 1(1): loaded http://localhost:48482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48482/tests/dromaeo/cssquery-yui.html) 13:55:01 INFO - PROCESS | 2349 | RSS: Main: 214790144 13:55:01 INFO - PROCESS | 2349 | 13:58:03 INFO - PROCESS | 2349 | Cycle 1(1): loaded http://localhost:48482/tests/dromaeo/cssquery-yui.html (next: http://localhost:48482/tests/dromaeo/cssquery-dojo.html) 13:58:04 INFO - PROCESS | 2349 | RSS: Main: 314888192 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | __start_tp_report 13:58:04 INFO - PROCESS | 2349 | _x_x_mozilla_page_load 13:58:04 INFO - PROCESS | 2349 | _x_x_mozilla_page_load_details 13:58:04 INFO - PROCESS | 2349 | |i|pagename|runs| 13:58:04 INFO - PROCESS | 2349 | |0;dojo.html;2601.5317242896276;2652.244110428528;2658.468306338733;2672.3052006478324;2686.408990022195;4521.0731799981;4522.366868638389;4531.252343363345;4536.977315113424;4605.055963527478;4526.321051842226;4534.795934182961;4557.931631025529;4675.696079754822;4743.359646447729;4215.725977811448;4217.599328063829;4233.132207897389;4250.043740158455;4376.19040477511;4314.568543145676;4320.308750599905;4346.5436129206455;4350.825966961318;4385.451818522684;4177.603127702879;4243.151369726067;4262.211490874198;4286.657067434598;4311.310190369526;4237.80929858154;4256.936145957813;4260.38224457455;4263.8081286342185;4301.806418711166;4233.491980962273;4249.87250382489;4256.553061928515;4260.659147268242;4265.125649241898;4424.712393694432;4576.8626941191815;4578;4613;4627.421572303462;4789.928151077736;4822.68652537584;4835.178019736653;4845.224764037737;4855.781489832931;4845.055214233226;4852.150873597142;4859.951400485986;4885.267209918541;4890.926636100461;4588.197065513556;4639.791209395517;4642.373279607277;4662.743549104798;4686.367340409001;5126.87182820425;5170.870728231825;5175.585953123741;5175.896482070338;5227.3988491323225;4797.496262892346;4821.63837712173;4942.332785074041;4953.529414705597;4958.42978057528;4990.8253211137435;5026;5054.949450505522;5062.873428164326;5065.214891691794;4938.481459446778;4955.876103097379;4958.330625365602;4961.925571116436;5010.724410157403;4787.2101103318255;4935.580475659609;4938.8271410501175;4964.205727083649;5001.299818025479;4087.652549533323;4179.540250572434;4210.789460526961;4246.044639955985;4250.256205164084;3694.3165514379925;3700.3709369407266;3709.3879509880567;3733.010752150682;3739.9813000934823;4169.4162817205615;4269.082147338338;4273.978630106892;4282.657387409;4318.784060796947;4947.431045429749;4991.101601711654;4995.375578052744;5018.473060328686;5025.447200807908;4212.347086201644;4216.91566168681;4226.281532139544;4232.746035237896;4263.16868210696;4318.287482565404;4461.442319709971;4462.933056004163;4469.061497085583;4479.820807167677;4656.324832899143;4660.39414876064;4661.696989695659;4700.365450664117;4705.1765940960195;4931.211006238985;4936.555709986119;4941.283513890394;4955.2567114933045;4993.251012348177;4494.393256910275;4632.444106707217;4666.906661866811;4703.576678098988;4724.574788269072;4886.584640305472;4903.5586797188425;4904.215325547895;4929.507049295042;4950.430700469492;4934.259861020732;4979.701217926936;4980.651354405157;4983.725895075806;4984.675996060245;4640.373549570765;4827.613790896649;4880.902381952412;4907.582855457326;4916.680415772963;4787.305840653155;4790.185668436444;4808.2787581863;4811.615070794258;4860.076585448754;4730.172219861579;4733.7396443194575;4737.952620473751;4745.501722319107;4793.736344500946;4762.880927976828;4768.76156192182;4808.735519546319;4847.2729090636685;4858;4717.127331443694;4761.500042495488;4799.232122860326;4805.567498925114;4818.7831547581145 13:58:04 INFO - PROCESS | 2349 | |1;ext.html;543.1860996713772;573.5927491481049;589.6815719511465;598.2521847690385;605.476263032477;26198.345041373974;26690.733092669067;26736.46527069462;26748.465030699375;26781.86609066957;33436;34360;34745.13137171572;35865.2826943461;35949.64050359496;7531.209223031585;7703.4222433317445;7715.189905059972;7717.112532058829;7718.343940765042;7247;7610.543367397946;7795.532268063935;7810.0237470316215;9342.532873356338;9580.281478889112;9744.464054477;9746.951265243664;9748.902510974905;9754.219662426989;9537.952310238474;9678.27412944032;9683.612655493771;9689.660861869801;9691.951540242324;9508.714738557854;9648.372855764354;9653.951730241373;9655.71032869008;9661.275404344702;34328.65671343305;34770;34851.477227841606;34905.47641785375;38522.422163667565;2387.4866903615807;2454.662209096047;3223.097532690827;3276.541284220187;3306.437905556061;27875.442491150265;27901;28143.296417589518;28687.71312286892;28982.710172898212;3493.266414053052;3533.2050288685095;3558.822058897045;3573.213892943548;3646.9270614587826;187304;188169;188615;188932;189882.05058974755;55919;56743.71628141833;56782.148267776014;56806.71596642073;56825;61449.38550614526;61544;61562.69218653878;61697;61771.69114154491;12983.415746291439;13306.26815525136;13311.467541298432;13313.534026309033;13327.333633318296;10032.69901902944;10082.899171008343;10094.747631309128;10099.69700908974;10107.039831216023;16215.83784162167;18804;18949.315205438314;19535.588590115734;20271.391858244275;7254.854902902018;7296.270372962767;7382.18795932447;7388.298111679382;7561.621918904033;887.8179973105628;939.6664184214642;976.1848856205006;990.7176454710373;1030.5362586835954;26799.330016749347;28115.43769124606;28597.42805143927;28616.85691571529;28756.137315880558;946.1768261612303;984.7045886234101;1011.529638717985;1044.237706474278;1074.978500429987;12968.36728076341;13550.796738048937;13575.185488870502;13597.32013399326;13668.31658417095;340220;642532;642621;644010;645087;47354.5264547357;47901.520984790404;48222.758886205345;48274;48371;1131.1403333466624;1263.7788387032417;1277.5783991282854;1285.7364240330896;1289.3553223388305;25519.744802551737;27662.6961430388;27738.861305693343;28111.43777124487;29376.412471750016;41259.38110928398;41871.7906410466;42114.57885421229;42144.15711685688;42159;265985;267886;268565;268935;269861;32491.18772030718;37675.246495070496;38785;39532.20935581215;39991;38491.42262866003;39828.60171398249;39932.600673992885;40087.1982560353;40433;33511.49732753962;33650.83174584111;33965.3206935855;34234.82882585571;34660.82669586636;33990.32019359648;36672.26655466929;36882.07794805151;36895.44656830203;37001.259974800894;36357.27285454329;36650;36682.41469816273;36876.446853297755;37809.24381512409;29632.259193520335;31633.525497118022;31716.841415792773;31800.522992154674;31921.840390798825;23961.28116156518;25043.87478062598;25982.480350392507;26371.4725705481;26496.735032649427 13:58:04 INFO - PROCESS | 2349 | |2;jquery.html;366.9761465504742;369.80400387794464;371.4817829128366;376.8266597365212;387.7053439386069;15823.84176158238;16413.671726565462;17571.385001524948;17612.82387176128;17638.91180544097;15980.76028859568;16193.35226590938;16963.236654350552;16989.83010169898;16991;4884.120858245523;4981.227909674007;5054.797808087672;5061.6962982221;5064.442911279756;3628.2380700053022;3831.5019047523783;4929.186684197103;5433.701146436944;5775.162601422791;5651.378348381675;5677.517411020048;5715.342735585419;5736.627119237257;5737.340205876315;5433.755481003344;5632.9436705632825;5637.774489020434;5669.177969194444;5711.571632127607;3287.556179915705;4703.529647035269;4970.925436118461;4974.751262436864;4975.203967365204;18225.08874556267;19043.143058562397;19055.333063342856;19129;19146.80853191464;661.3683931845077;1936.5255512399413;1955.2836008311494;2041.4181958142008;2201.460642142685;12865.871341286562;13118.278494682789;13231.404586793617;13400.731985360335;13530.93234533821;1714.6056407026329;1811.1668632428966;1841.272697284565;1862.3854128137818;1888.726134710473;63718.68140659313;63848.68075659638;63917.68041159764;64060.679696601685;65833.3416665832;9110;9473.147416732527;9511.57197926095;9599.280053995979;9646.083622055894;12855.871441285468;12997.805032924514;13000.479980800852;13013.869861301266;13025.088243822842;6871.759488417882;6921.584704917721;6995.685194166274;7032;7107.147142342952;6600.80197594073;6621.801345959629;6625.039369291426;6704.765333213314;6744.42672372844;5898;5933.554983376264;5977.820665380045;6022.307434644984;6076.779306967314;1594.2347673116737;1675.5392267126394;1701.3109690575336;1706.9231884565224;1719.071701281319;777.3004296133525;874.8556488179506;922.5848368234322;944.8063147054837;969.3166317745972;16170.514884553482;16766.413175538797;16778.6644267114;16988.150592470327;17266.395676151526;930.5161316115582;933.7525555727738;937.7702462896634;942.0767647705287;946.9593027026631;7648.80877978055;10140.54367553447;10157.593696252216;10171.389716617026;10235.385876847413;389919;400336;401296;403308;403593;68281;69760;70286.64856675787;73961;76401;872.1104473437059;1001.6694490818013;1032.7056788815303;1066.7173199102244;1073.1522097543009;11381.886181138414;14578.416863325348;15000.099994000395;15102.622434439227;15678.294476748346;34336;34667;35077.64922350744;35662;35891.461628076126;47580.52419475761;48370.758146209046;48520.27219591638;48522.27216591824;48593;4600.2409602416565;4676.08816280822;4924.778384972613;7068.363847253772;7556.9798077258865;8839.204471597586;10900.618478353219;10993.175511836804;11692.479977602858;11908.880911190778;8703.825923481369;9143.177114059767;10571.735706607089;10811.35131892089;10835.783284334428;10139.290249682452;10471.94764026175;10488.213383996079;10566.154707623218;10662.453944177896;10297;10494.842577361498;10534.051935325551;10603.098736607166;10753.946230269112;7829.138794732461;8030.478018928751;8045.919540804517;8123.878141827996;8191.017077950684;7792.688292468464;9710.126088652056;10024.699259022242;10227.642032529124;10460.058594726512 13:58:04 INFO - PROCESS | 2349 | |3;mootools.html;1189.8988585970192;1449.1594874972518;1450.6373406648338;1610.9194540272983;1785.5089850291167;7136.643167841607;7353.154387245469;7401.666924988375;7406.111266648003;7428.071491063617;7190.8561828763395;7336.523125996807;7368.300011498913;7368.778936631897;7368.926310736891;1818.5271829324404;1879.915403806832;1881.868269221155;2193.385851961449;2230.096810791632;1838.485224137237;2196.374033400481;2295;2295.6326987681973;2299.494111295512;2203.724534433196;2213.712217411742;2229.2754854672216;2234;2234.1733558583346;1777.3423833181805;2193.8903054847274;2222.799948004671;2224.6218142915745;2226.0205509575735;2169.349195241421;2239.55208958209;2239.7088378510853;2241.4284357488737;2243.2260869999823;7317.780466586011;7379.077615298088;7386.446016548726;7387.889181662279;7388.741394051182;4307.892302692427;4482.103579284156;4488.506264310923;4492.056668099703;4517.548245175489;2727.686316073637;2787.080263513036;2875.971240287591;2892.6673432555317;2901.2746813296676;943.6272672294474;960.9279304052154;968.3221744778613;971.7667759737612;1005.6832097889142;9898.257630677728;10099.343542669776;10108.797824043551;10125.746856328577;10261.897381026169;4037.5962403759977;4314.546972567835;4318.632916202158;4322.9351559726;4352.368906508602;9000.909990900138;9004;9037.63849446028;9061.275097992146;9064.320175986695;4682.672212945129;4697.577218050392;4700.7179569225955;4730.2668086445965;4734.100520901018;3601.9639803602154;3715.16408808016;4069.328560787496;4266.850660226877;4300.333448315516;3108.7202151806446;3253.5933008373954;3446.2590543033366;3548.609652938175;3550.2721942001826;1056.8414737789394;1066.1950227578284;1076.2950267574752;1077.9730506737237;1082.5074591061048;790.6046976511744;813.2680587471323;850.6724910909345;869.682565863468;889.217488610032;5025.275643832354;5128.769205385766;5263;5339.41266460689;5423.322084739408;889.3196704521047;899.2176806178667;912.7581190984395;922.1470140120362;945.7919257763418;3613.638636136365;3743.812809359521;3749.7750134991443;3806.923861522754;3811.8856434307013;9011.63953441868;9184.357095003286;9337.766555836022;9356.95321523388;9365.203957663674;9234.95382523083;9249.260059195249;9255.444673319622;9257.305702072372;9258.166764991183;6783.966080169567;6970.581765094111;7131.393831524379;7164;7164.247753985861;5339.3058902344;5459.235707000944;5476.67139971603;5484.204790305464;5584.972075139598;8531.402801803813;8565.357598180037;8646.481211127353;8683.696070637498;8728.08355122703;8100.108988011432;8370.58147092655;8398.748037558884;8499.150084991452;8500.362472814688;6556.377144171296;6669.533132680665;6676.031975363642;6677.565958212701;6679.76620818269;6365.9681701593045;7057.682404291717;7097.290270972861;7261.237570055279;7286.453515986216;6855.897161542481;6888.035675005403;6907.896381554381;7001.544899581511;7008.053912721921;6728.461723062242;6833.58998460094;6838.589684618939;6889.2421833599265;6950.4787140965645;6171.074338849208;6211.534134939988;6254.749810007549;6256.124142620128;6265.498760099273;4643.7213767172725;4771.6898401603785;4857.53853383928;4875.268709693574;4986.227134794112;4784.497627749036;4852.684575502581;4923.261510773413;4953.752312384294;5034.672746271481 13:58:04 INFO - PROCESS | 2349 | |4;prototype.html;302.32732170919707;302.780484148992;306.16569847166465;310.0512431958207;313.2857085844274;4897.70613763174;4996.700197988123;5000.449950505446;5010.774515146818;5016.573591244749;4906.460289368176;4949.80737424362;4950.504949505057;4956.2565615157655;4962.00759848031;3702.389105797547;3790.374588192945;3833.0609000794843;3910.8435662573606;3951.802409879509;3904.258190943726;3936.075022369741;3941.0935484838506;3958.604139586033;3961.8019099045077;3676.191237927665;3897.532296124469;3911.5918269422987;3913.788709379206;3923.0584659681613;3751.3060083884434;3881.204353107606;3887.105965627893;3891.1633998690136;3896.7467114637457;3437.4500079987083;3452.2577645806273;3453.1539772755586;3457.3258214648154;3473.7047350974944;4767.451743049559;4792.9760351198365;4802.567768900815;4802.783874725646;4817.181079216542;4287.2711639021445;4482.977585112086;4493.28107502798;4495.842645507391;4503.279475283972;5206;5207.114790485626;5222.086134926372;5241.9213711794355;5265.236540701615;3787.2010794872217;3787.3750831112834;3795;3796.544414670257;3802.2395520895657;5326.307580014612;5453.127499600085;5457.208704737831;5496.835094947158;5518;3891.3579259421876;3893.9415908761393;3916.96083039166;3920.1179734559496;3922.4508568800393;3947.881563553098;3960.9207815844097;3963.1083006323347;3964.52425708911;3972.7020473464604;4364.170807546556;4443.289073748249;4467.128909862546;4483.7533935633855;4488.60853135529;5236.439221329532;5252.579793616502;5252.632315737862;5256.342957130359;5275.103232450492;1342.2013901728455;1373.7939309103715;1377.7864431013209;1387.6461502316845;1387.7363300972784;895.4000819450853;923.6213152607532;943.2831048403262;949.6154057606681;961.274237950343;4548.476925153584;4549.840755573539;4551.840685576055;4557.840475583405;4562.828833960432;5371.334886185295;5372.113601255827;5377.435369286247;5384.138537833927;5385.569154467633;4337.6963612546815;4518.43519560055;4548.13585418776;4552.954470455319;4563.1101935123;2840.6875243723175;2873.3822228221034;2875.511163102278;2875.8418286994415;2880.423915216965;5015.974920125449;5065.949340506548;5066.898662026739;5068.251453248697;5086.3896332440345;5331.70675612845;5463.644863083966;5481.945180548223;5654.547636189095;5659.5755318351285;5148.613853960893;5168.250603662523;5169.379674439091;5174.9482505174465;5175.378954525481;5514.779408823762;5514.972425137848;5516.0071187186695;5520.613557050968;5526.226328313959;5218.399884013387;5406.432324605859;5414.10667239901;5417.241586177859;5429.294191755047;5141.305923700402;5141.89449268409;5162.9483705162465;5173.896522069463;5174.560162386088;3727.1986522897705;3763.830627621709;3794.1273507094074;3798.981005094957;3815.771053736785;5396.541293989898;5478.753456094406;5492.148716948879;5504.889902202013;5526.115821468546;5292.655977361459;5312.335958005249;5318.813841515528;5321.787128514816;5336.78652853897;5129.461406552258;5315.096433606219;5323.893522129459;5327.360716714019;5343.4122246553625;4948.554630083309;5220.843374698765;5229.764660590358;5241.947580524146;5246.868828279324;5173.689578625294;5336.866578335417;5340.184337325328;5351.5451186648015;5351.785928562814;5189.844304670866;5192.5586325162785;5199.688018718889;5226.555742761908;5237.580993520585 13:58:04 INFO - PROCESS | 2349 | |5;yui.html;656.7012009535662;676.681959479045;684.254162962371;742.2095468326232;748.4050180106815;11228.045616122628;11339.716507087307;11355.034822040116;11372.431378431076;11420.31478111313;10986.297123945782;11026.283291586042;11114.444277786099;11124.165687573424;11126.276792008533;643.2152773616181;785.0461689047805;791.4064451661254;800.8638531449639;808.1675873849914;810.1898101898101;814.6659869453525;815.5759005317232;816.8325493273865;817.1624085312543;846.6232526525698;846.7502086884354;848.1984524624232;848.2111636178352;848.3255811629738;663.8141320430287;820.3601191070974;843.3421930893882;845.0957475501216;845.9577021148918;616.9907451388233;617.0836308082494;617.1267656266377;617.1637431280595;617.1822335405606;11490.942545287304;11513.65459036222;11521.884781152165;11546.942265288704;11548.076153907667;12083.697907552294;12506.249625022529;12533.498660053587;12662.620121396372;12844.678883027998;9936.205103591696;10044.694189755284;10144.137748291405;10166.694999150037;10169.847452288222;3323.4682450807995;3348.096014076186;3410.2667926395943;3412.7269818414466;3466.41071017925;45233;45540.089198216185;45563.77218113921;45650;45722.31416528755;9686.70939871805;9770.51147442625;9843;10358.119559837498;10373.377597344033;16458.341666333454;16672.33310667584;16683.749743753855;16693.499195024167;16701.415450459175;6687.933120668828;6705.932940670628;6806.18325800907;6855.5543889647015;7031.226565077837;3831.65515103642;3836.405357169643;3839.865604703822;3912.217556488714;3949.170674158459;2872.727090926359;2949.439606474763;2956.1131660501765;2958.2456473599095;2958.2456473599095;448.13733562891304;518.284767021508;528.4583302115362;530.082956485275;562.8986782379129;554.9334079910436;586.2905883880467;608.6652341212316;623.741147423814;639.5906619763355;7881.842363152819;8013.879791803128;8077.798055048671;8113.229243221885;8209.795926505689;472.5369138244471;538.1927109335996;622.9205084217832;625.0686477149015;628.1676778268812;3415.8292085395633;3702.3520883845217;3723.6090210528046;3748.681362084199;3768.4158955361963;51053;51860.740696297034;51958;52136.47863521392;52540.21189682158;24004.15985440501;24294.05647548192;24329.878350608134;44348.3347749784;47554.76222618865;41671.374929376085;42573;43229.56770432255;43272.9181770452;43661;7132.964335178291;7134.143902731706;7268.854622907618;7319.780406587811;7328.3770879473705;25119.372015699024;25180.622290665287;25654;25943.87028064923;30184.5472317911;33213.50179747354;33765.32469350648;34091.48862767011;34408;35204.823975879954;10674.634939417605;11058.22592418523;11103.888961110286;11155.721106972065;11185.776284474428;11321.886781132413;11801.996830269523;11833.526658933546;11969.16215864881;12076.396180191132;11264.324140551593;11342.60300889465;11646;11739.765204696028;11920.821187682364;10595.629152979609;10828.5127169276;11183.776324473627;11204.71988200269;11211.495482703462;11508.13688973347;11868.82196767032;11918.284902905853;12292.81560776607;12325.691857703629;9850.261230407892;10002.649907253211;10082.949585252027;10190.643327483502;10246.846297305696;8808.471491710518;9195.25361327391;9414.170636207307;10016.348937319051;10120.443375614412 13:58:04 INFO - PROCESS | 2349 | __end_tp_report 13:58:04 INFO - PROCESS | 2349 | __start_cc_report 13:58:04 INFO - PROCESS | 2349 | _x_x_mozilla_cycle_collect,1154 13:58:04 INFO - PROCESS | 2349 | __end_cc_report 13:58:04 INFO - PROCESS | 2349 | __startTimestamp1461272284243__endTimestamp 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | ------- Summary: start ------- 13:58:04 INFO - PROCESS | 2349 | Number of tests: 6 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | [#0] dojo.html Cycles:165 Average:4577.78 Median:4703.58 stddev:471.82 (10.0%) stddev-sans-first:447.07 13:58:04 INFO - PROCESS | 2349 | Values: 2601.5 2652.2 2658.5 2672.3 2686.4 4521.1 4522.4 4531.3 4537.0 4605.1 4526.3 4534.8 4557.9 4675.7 4743.4 4215.7 4217.6 4233.1 4250.0 4376.2 4314.6 4320.3 4346.5 4350.8 4385.5 4177.6 4243.2 4262.2 4286.7 4311.3 4237.8 4256.9 4260.4 4263.8 4301.8 4233.5 4249.9 4256.6 4260.7 4265.1 4424.7 4576.9 4578.0 4613.0 4627.4 4789.9 4822.7 4835.2 4845.2 4855.8 4845.1 4852.2 4860.0 4885.3 4890.9 4588.2 4639.8 4642.4 4662.7 4686.4 5126.9 5170.9 5175.6 5175.9 5227.4 4797.5 4821.6 4942.3 4953.5 4958.4 4990.8 5026.0 5054.9 5062.9 5065.2 4938.5 4955.9 4958.3 4961.9 5010.7 4787.2 4935.6 4938.8 4964.2 5001.3 4087.7 4179.5 4210.8 4246.0 4250.3 3694.3 3700.4 3709.4 3733.0 3740.0 4169.4 4269.1 4274.0 4282.7 4318.8 4947.4 4991.1 4995.4 5018.5 5025.4 4212.3 4216.9 4226.3 4232.7 4263.2 4318.3 4461.4 4462.9 4469.1 4479.8 4656.3 4660.4 4661.7 4700.4 4705.2 4931.2 4936.6 4941.3 4955.3 4993.3 4494.4 4632.4 4666.9 4703.6 4724.6 4886.6 4903.6 4904.2 4929.5 4950.4 4934.3 4979.7 4980.7 4983.7 4984.7 4640.4 4827.6 4880.9 4907.6 4916.7 4787.3 4790.2 4808.3 4811.6 4860.1 4730.2 4733.7 4738.0 4745.5 4793.7 4762.9 4768.8 4808.7 4847.3 4858.0 4717.1 4761.5 4799.2 4805.6 4818.8 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | [#1] ext.html Cycles:180 Average:49678.63 Median:3546.01 stddev:105644.51 (2979.2%) stddev-sans-first:105876.46 13:58:04 INFO - PROCESS | 2349 | Values: 543.2 573.6 589.7 598.3 605.5 26198.3 26690.7 26736.5 26748.5 26781.9 33436.0 34360.0 34745.1 35865.3 35949.6 7531.2 7703.4 7715.2 7717.1 7718.3 7247.0 7610.5 7795.5 7810.0 9342.5 9580.3 9744.5 9747.0 9748.9 9754.2 9538.0 9678.3 9683.6 9689.7 9692.0 9508.7 9648.4 9654.0 9655.7 9661.3 34328.7 34770.0 34851.5 34905.5 38522.4 2387.5 2454.7 3223.1 3276.5 3306.4 27875.4 27901.0 28143.3 28687.7 28982.7 3493.3 3533.2 3558.8 3573.2 3646.9 187304.0 188169.0 188615.0 188932.0 189882.1 55919.0 56743.7 56782.1 56806.7 56825.0 61449.4 61544.0 61562.7 61697.0 61771.7 12983.4 13306.3 13311.5 13313.5 13327.3 10032.7 10082.9 10094.7 10099.7 10107.0 16215.8 18804.0 18949.3 19535.6 20271.4 7254.9 7296.3 7382.2 7388.3 7561.6 887.8 939.7 976.2 990.7 1030.5 26799.3 28115.4 28597.4 28616.9 28756.1 946.2 984.7 1011.5 1044.2 1075.0 12968.4 13550.8 13575.2 13597.3 13668.3 340220.0 642532.0 642621.0 644010.0 645087.0 47354.5 47901.5 48222.8 48274.0 48371.0 1131.1 1263.8 1277.6 1285.7 1289.4 25519.7 27662.7 27738.9 28111.4 29376.4 41259.4 41871.8 42114.6 42144.2 42159.0 265985.0 267886.0 268565.0 268935.0 269861.0 32491.2 37675.2 38785.0 39532.2 39991.0 38491.4 39828.6 39932.6 40087.2 40433.0 33511.5 33650.8 33965.3 34234.8 34660.8 33990.3 36672.3 36882.1 36895.4 37001.3 36357.3 36650.0 36682.4 36876.4 37809.2 29632.3 31633.5 31716.8 31800.5 31921.8 23961.3 25043.9 25982.5 26371.5 26496.7 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | [#2] jquery.html Cycles:180 Average:24090.79 Median:395127.50 stddev:65713.31 (16.6%) stddev-sans-first:65873.51 13:58:04 INFO - PROCESS | 2349 | Values: 367.0 369.8 371.5 376.8 387.7 15823.8 16413.7 17571.4 17612.8 17638.9 15980.8 16193.4 16963.2 16989.8 16991.0 4884.1 4981.2 5054.8 5061.7 5064.4 3628.2 3831.5 4929.2 5433.7 5775.2 5651.4 5677.5 5715.3 5736.6 5737.3 5433.8 5632.9 5637.8 5669.2 5711.6 3287.6 4703.5 4970.9 4974.8 4975.2 18225.1 19043.1 19055.3 19129.0 19146.8 661.4 1936.5 1955.3 2041.4 2201.5 12865.9 13118.3 13231.4 13400.7 13530.9 1714.6 1811.2 1841.3 1862.4 1888.7 63718.7 63848.7 63917.7 64060.7 65833.3 9110.0 9473.1 9511.6 9599.3 9646.1 12855.9 12997.8 13000.5 13013.9 13025.1 6871.8 6921.6 6995.7 7032.0 7107.1 6600.8 6621.8 6625.0 6704.8 6744.4 5898.0 5933.6 5977.8 6022.3 6076.8 1594.2 1675.5 1701.3 1706.9 1719.1 777.3 874.9 922.6 944.8 969.3 16170.5 16766.4 16778.7 16988.2 17266.4 930.5 933.8 937.8 942.1 947.0 7648.8 10140.5 10157.6 10171.4 10235.4 389919.0 400336.0 401296.0 403308.0 403593.0 68281.0 69760.0 70286.6 73961.0 76401.0 872.1 1001.7 1032.7 1066.7 1073.2 11381.9 14578.4 15000.1 15102.6 15678.3 34336.0 34667.0 35077.6 35662.0 35891.5 47580.5 48370.8 48520.3 48522.3 48593.0 4600.2 4676.1 4924.8 7068.4 7557.0 8839.2 10900.6 10993.2 11692.5 11908.9 8703.8 9143.2 10571.7 10811.4 10835.8 10139.3 10471.9 10488.2 10566.2 10662.5 10297.0 10494.8 10534.1 10603.1 10753.9 7829.1 8030.5 8045.9 8123.9 8191.0 7792.7 9710.1 10024.7 10227.6 10460.1 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | [#3] mootools.html Cycles:180 Average:5035.99 Median:5441.28 stddev:2742.41 (50.4%) stddev-sans-first:2734.87 13:58:04 INFO - PROCESS | 2349 | Values: 1189.9 1449.2 1450.6 1610.9 1785.5 7136.6 7353.2 7401.7 7406.1 7428.1 7190.9 7336.5 7368.3 7368.8 7368.9 1818.5 1879.9 1881.9 2193.4 2230.1 1838.5 2196.4 2295.0 2295.6 2299.5 2203.7 2213.7 2229.3 2234.0 2234.2 1777.3 2193.9 2222.8 2224.6 2226.0 2169.3 2239.6 2239.7 2241.4 2243.2 7317.8 7379.1 7386.4 7387.9 7388.7 4307.9 4482.1 4488.5 4492.1 4517.5 2727.7 2787.1 2876.0 2892.7 2901.3 943.6 960.9 968.3 971.8 1005.7 9898.3 10099.3 10108.8 10125.7 10261.9 4037.6 4314.5 4318.6 4322.9 4352.4 9000.9 9004.0 9037.6 9061.3 9064.3 4682.7 4697.6 4700.7 4730.3 4734.1 3602.0 3715.2 4069.3 4266.9 4300.3 3108.7 3253.6 3446.3 3548.6 3550.3 1056.8 1066.2 1076.3 1078.0 1082.5 790.6 813.3 850.7 869.7 889.2 5025.3 5128.8 5263.0 5339.4 5423.3 889.3 899.2 912.8 922.1 945.8 3613.6 3743.8 3749.8 3806.9 3811.9 9011.6 9184.4 9337.8 9357.0 9365.2 9235.0 9249.3 9255.4 9257.3 9258.2 6784.0 6970.6 7131.4 7164.0 7164.2 5339.3 5459.2 5476.7 5484.2 5585.0 8531.4 8565.4 8646.5 8683.7 8728.1 8100.1 8370.6 8398.7 8499.2 8500.4 6556.4 6669.5 6676.0 6677.6 6679.8 6366.0 7057.7 7097.3 7261.2 7286.5 6855.9 6888.0 6907.9 7001.5 7008.1 6728.5 6833.6 6838.6 6889.2 6950.5 6171.1 6211.5 6254.7 6256.1 6265.5 4643.7 4771.7 4857.5 4875.3 4986.2 4784.5 4852.7 4923.3 4953.8 5034.7 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | [#4] prototype.html Cycles:180 Average:4374.11 Median:4959.13 stddev:1270.32 (25.6%) stddev-sans-first:1236.57 13:58:04 INFO - PROCESS | 2349 | Values: 302.3 302.8 306.2 310.1 313.3 4897.7 4996.7 5000.4 5010.8 5016.6 4906.5 4949.8 4950.5 4956.3 4962.0 3702.4 3790.4 3833.1 3910.8 3951.8 3904.3 3936.1 3941.1 3958.6 3961.8 3676.2 3897.5 3911.6 3913.8 3923.1 3751.3 3881.2 3887.1 3891.2 3896.7 3437.5 3452.3 3453.2 3457.3 3473.7 4767.5 4793.0 4802.6 4802.8 4817.2 4287.3 4483.0 4493.3 4495.8 4503.3 5206.0 5207.1 5222.1 5241.9 5265.2 3787.2 3787.4 3795.0 3796.5 3802.2 5326.3 5453.1 5457.2 5496.8 5518.0 3891.4 3893.9 3917.0 3920.1 3922.5 3947.9 3960.9 3963.1 3964.5 3972.7 4364.2 4443.3 4467.1 4483.8 4488.6 5236.4 5252.6 5252.6 5256.3 5275.1 1342.2 1373.8 1377.8 1387.6 1387.7 895.4 923.6 943.3 949.6 961.3 4548.5 4549.8 4551.8 4557.8 4562.8 5371.3 5372.1 5377.4 5384.1 5385.6 4337.7 4518.4 4548.1 4553.0 4563.1 2840.7 2873.4 2875.5 2875.8 2880.4 5016.0 5065.9 5066.9 5068.3 5086.4 5331.7 5463.6 5481.9 5654.5 5659.6 5148.6 5168.3 5169.4 5174.9 5175.4 5514.8 5515.0 5516.0 5520.6 5526.2 5218.4 5406.4 5414.1 5417.2 5429.3 5141.3 5141.9 5162.9 5173.9 5174.6 3727.2 3763.8 3794.1 3799.0 3815.8 5396.5 5478.8 5492.1 5504.9 5526.1 5292.7 5312.3 5318.8 5321.8 5336.8 5129.5 5315.1 5323.9 5327.4 5343.4 4948.6 5220.8 5229.8 5241.9 5246.9 5173.7 5336.9 5340.2 5351.5 5351.8 5189.8 5192.6 5199.7 5226.6 5237.6 13:58:04 INFO - PROCESS | 2349 | 13:58:04 INFO - PROCESS | 2349 | [#5] yui.html Cycles:180 Average:12117.58 Median:3834.03 stddev:13449.95 (350.8%) stddev-sans-first:13460.14 13:58:04 INFO - PROCESS | 2349 | Values: 656.7 676.7 684.3 742.2 748.4 11228.0 11339.7 11355.0 11372.4 11420.3 10986.3 11026.3 11114.4 11124.2 11126.3 643.2 785.0 791.4 800.9 808.2 810.2 814.7 815.6 816.8 817.2 846.6 846.8 848.2 848.2 848.3 663.8 820.4 843.3 845.1 846.0 617.0 617.1 617.1 617.2 617.2 11490.9 11513.7 11521.9 11546.9 11548.1 12083.7 12506.2 12533.5 12662.6 12844.7 9936.2 10044.7 10144.1 10166.7 10169.8 3323.5 3348.1 3410.3 3412.7 3466.4 45233.0 45540.1 45563.8 45650.0 45722.3 9686.7 9770.5 9843.0 10358.1 10373.4 16458.3 16672.3 16683.7 16693.5 16701.4 6687.9 6705.9 6806.2 6855.6 7031.2 3831.7 3836.4 3839.9 3912.2 3949.2 2872.7 2949.4 2956.1 2958.2 2958.2 448.1 518.3 528.5 530.1 562.9 554.9 586.3 608.7 623.7 639.6 7881.8 8013.9 8077.8 8113.2 8209.8 472.5 538.2 622.9 625.1 628.2 3415.8 3702.4 3723.6 3748.7 3768.4 51053.0 51860.7 51958.0 52136.5 52540.2 24004.2 24294.1 24329.9 44348.3 47554.8 41671.4 42573.0 43229.6 43272.9 43661.0 7133.0 7134.1 7268.9 7319.8 7328.4 25119.4 25180.6 25654.0 25943.9 30184.5 33213.5 33765.3 34091.5 34408.0 35204.8 10674.6 11058.2 11103.9 11155.7 11185.8 11321.9 11802.0 11833.5 11969.2 12076.4 11264.3 11342.6 11646.0 11739.8 11920.8 10595.6 10828.5 11183.8 11204.7 11211.5 11508.1 11868.8 11918.3 12292.8 12325.7 9850.3 10002.6 10082.9 10190.6 10246.8 8808.5 9195.3 9414.2 10016.3 10120.4 13:58:04 INFO - PROCESS | 2349 | -------- Summary: end -------- 13:58:04 INFO - PROCESS | 2349 | 13:58:05 INFO - TEST-INFO | 2349: exit 0 13:58:05 INFO - TEST-OK | dromaeo_css | took 1118728ms 13:58:05 INFO - TEST-START | kraken 13:58:05 INFO - operating with platform_type : linux_ 13:58:05 INFO - Initialising browser for kraken test... 13:58:05 INFO - TEST-INFO | started process 2624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_SJxt/profile http://localhost:48482/getInfo.html) 13:58:09 INFO - PROCESS | 2624 | __metrics Screen width/height:1600/1200 13:58:09 INFO - PROCESS | 2624 | colorDepth:24 13:58:09 INFO - PROCESS | 2624 | Browser inner width/height: 1024/697 13:58:09 INFO - PROCESS | 2624 | __metrics 13:58:10 ERROR - PROCESS | 2624 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:58:11 INFO - TEST-INFO | 2624: exit 0 13:58:11 INFO - Browser initialized. 13:58:11 INFO - Running cycle 1/1 for kraken test... 13:58:11 INFO - TEST-INFO | started process 2738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_SJxt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:23 INFO - PROCESS | 2738 | RSS: Main: 154808320 13:58:23 INFO - PROCESS | 2738 | 13:58:25 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48482/tests/kraken/driver.html?testName=audio-beat-detection) 13:58:26 INFO - PROCESS | 2738 | RSS: Main: 209891328 13:58:26 INFO - PROCESS | 2738 | 13:58:29 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48482/tests/kraken/driver.html?testName=audio-dft) 13:58:30 INFO - PROCESS | 2738 | RSS: Main: 195624960 13:58:30 INFO - PROCESS | 2738 | 13:58:33 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48482/tests/kraken/driver.html?testName=audio-fft) 13:58:34 INFO - PROCESS | 2738 | RSS: Main: 266715136 13:58:34 INFO - PROCESS | 2738 | 13:58:36 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48482/tests/kraken/driver.html?testName=audio-oscillator) 13:58:36 INFO - PROCESS | 2738 | RSS: Main: 175054848 13:58:36 INFO - PROCESS | 2738 | 13:58:39 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:58:39 INFO - PROCESS | 2738 | RSS: Main: 179093504 13:58:39 INFO - PROCESS | 2738 | 13:58:42 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48482/tests/kraken/driver.html?testName=imaging-darkroom) 13:58:43 INFO - PROCESS | 2738 | RSS: Main: 214806528 13:58:43 INFO - PROCESS | 2738 | 13:58:46 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48482/tests/kraken/driver.html?testName=imaging-desaturate) 13:58:47 INFO - PROCESS | 2738 | RSS: Main: 215031808 13:58:47 INFO - PROCESS | 2738 | 13:58:50 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48482/tests/kraken/driver.html?testName=json-parse-financial) 13:58:51 INFO - PROCESS | 2738 | RSS: Main: 216244224 13:58:51 INFO - PROCESS | 2738 | 13:58:52 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:58:53 INFO - PROCESS | 2738 | RSS: Main: 202067968 13:58:53 INFO - PROCESS | 2738 | 13:58:55 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:58:55 INFO - PROCESS | 2738 | RSS: Main: 204595200 13:58:55 INFO - PROCESS | 2738 | 13:58:57 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:58:58 INFO - PROCESS | 2738 | RSS: Main: 220016640 13:58:58 INFO - PROCESS | 2738 | 13:59:01 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:01 INFO - PROCESS | 2738 | RSS: Main: 225189888 13:59:01 INFO - PROCESS | 2738 | 13:59:04 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:05 INFO - PROCESS | 2738 | RSS: Main: 218644480 13:59:05 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:48482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48482/tests/kraken/driver.html?testName=ai-astar) 13:59:07 INFO - PROCESS | 2738 | RSS: Main: 281690112 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | __start_tp_report 13:59:07 INFO - PROCESS | 2738 | _x_x_mozilla_page_load 13:59:07 INFO - PROCESS | 2738 | _x_x_mozilla_page_load_details 13:59:07 INFO - PROCESS | 2738 | |i|pagename|runs| 13:59:07 INFO - PROCESS | 2738 | |0;ai-astar;113;114;107;113;114;114;103;112;115;114 13:59:07 INFO - PROCESS | 2738 | |1;audio-beat-detection;157;144;158;183;142;164;159;132;191;140 13:59:07 INFO - PROCESS | 2738 | |2;audio-dft;162;162;163;162;162;164;162;163;170;165 13:59:07 INFO - PROCESS | 2738 | |3;audio-fft;74;73;128;109;73;73;74;112;106;77 13:59:07 INFO - PROCESS | 2738 | |4;audio-oscillator;95;94;146;94;95;95;141;95;94;149 13:59:07 INFO - PROCESS | 2738 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;117;117 13:59:07 INFO - PROCESS | 2738 | |6;imaging-darkroom;146;147;147;146;145;146;145;146;146;145 13:59:07 INFO - PROCESS | 2738 | |7;imaging-desaturate;95;94;94;94;95;95;97;95;95;94 13:59:07 INFO - PROCESS | 2738 | |8;json-parse-financial;64;64;64;65;65;65;64;85;61;62 13:59:07 INFO - PROCESS | 2738 | |9;json-stringify-tinderbox;65;65;65;65;64;65;64;64;65;64 13:59:07 INFO - PROCESS | 2738 | |10;stanford-crypto-aes;78;81;79;88;80;78;81;79;79;79 13:59:07 INFO - PROCESS | 2738 | |11;stanford-crypto-ccm;139;136;132;132;141;135;138;132;165;135 13:59:07 INFO - PROCESS | 2738 | |12;stanford-crypto-pbkdf2;174;179;177;178;176;177;183;173;175;183 13:59:07 INFO - PROCESS | 2738 | |13;stanford-crypto-sha256-iterative;74;76;73;73;74;73;75;74;73;71 13:59:07 INFO - PROCESS | 2738 | __end_tp_report 13:59:07 INFO - PROCESS | 2738 | __start_cc_report 13:59:07 INFO - PROCESS | 2738 | _x_x_mozilla_cycle_collect,1881 13:59:07 INFO - PROCESS | 2738 | __end_cc_report 13:59:07 INFO - PROCESS | 2738 | __startTimestamp1461272347658__endTimestamp 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | ------- Summary: start ------- 13:59:07 INFO - PROCESS | 2738 | Number of tests: 14 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#0] ai-astar Cycles:10 Average:111.90 Median:114.00 stddev:3.84 (3.4%) stddev-sans-first:4.06 13:59:07 INFO - PROCESS | 2738 | Values: 113.0 114.0 107.0 113.0 114.0 114.0 103.0 112.0 115.0 114.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:158.50 stddev:18.84 (11.9%) stddev-sans-first:19.98 13:59:07 INFO - PROCESS | 2738 | Values: 157.0 144.0 158.0 183.0 142.0 164.0 159.0 132.0 191.0 140.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.60 13:59:07 INFO - PROCESS | 2738 | Values: 162.0 162.0 163.0 162.0 162.0 164.0 162.0 163.0 170.0 165.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#3] audio-fft Cycles:10 Average:89.90 Median:73.00 stddev:21.33 (29.2%) stddev-sans-first:21.83 13:59:07 INFO - PROCESS | 2738 | Values: 74.0 73.0 128.0 109.0 73.0 73.0 74.0 112.0 106.0 77.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.50 stddev:24.60 (26.0%) stddev-sans-first:25.50 13:59:07 INFO - PROCESS | 2738 | Values: 95.0 94.0 146.0 94.0 95.0 95.0 141.0 95.0 94.0 149.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 13:59:07 INFO - PROCESS | 2738 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:59:07 INFO - PROCESS | 2738 | Values: 146.0 147.0 147.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 13:59:07 INFO - PROCESS | 2738 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 97.0 95.0 95.0 94.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:64.50 stddev:6.84 (10.6%) stddev-sans-first:7.22 13:59:07 INFO - PROCESS | 2738 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 64.0 85.0 61.0 62.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:59:07 INFO - PROCESS | 2738 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.94 (3.7%) stddev-sans-first:3.00 13:59:07 INFO - PROCESS | 2738 | Values: 78.0 81.0 79.0 88.0 80.0 78.0 81.0 79.0 79.0 79.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.00 stddev:9.81 (7.2%) stddev-sans-first:10.41 13:59:07 INFO - PROCESS | 2738 | Values: 139.0 136.0 132.0 132.0 141.0 135.0 138.0 132.0 165.0 135.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:177.50 stddev:3.41 (1.9%) stddev-sans-first:3.37 13:59:07 INFO - PROCESS | 2738 | Values: 174.0 179.0 177.0 178.0 176.0 177.0 183.0 173.0 175.0 183.0 13:59:07 INFO - PROCESS | 2738 | 13:59:07 INFO - PROCESS | 2738 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.35 (1.8%) stddev-sans-first:1.42 13:59:07 INFO - PROCESS | 2738 | Values: 74.0 76.0 73.0 73.0 74.0 73.0 75.0 74.0 73.0 71.0 13:59:07 INFO - PROCESS | 2738 | -------- Summary: end -------- 13:59:07 INFO - PROCESS | 2738 | 13:59:08 INFO - TEST-INFO | 2738: exit 0 13:59:08 INFO - TEST-OK | kraken | took 63669ms 13:59:08 INFO - SUITE-END | took 1182s 13:59:08 INFO - Completed test suite (00:19:42) 13:59:08 INFO - javascript benchmark 13:59:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.5317242896276, 2652.244110428528, 2658.468306338733, 2672.3052006478324, 2686.408990022195, 4521.0731799981, 4522.366868638389, 4531.252343363345, 4536.977315113424, 4605.055963527478, 4526.321051842226, 4534.795934182961, 4557.931631025529, 4675.696079754822, 4743.359646447729, 4215.725977811448, 4217.599328063829, 4233.132207897389, 4250.043740158455, 4376.19040477511, 4314.568543145676, 4320.308750599905, 4346.5436129206455, 4350.825966961318, 4385.451818522684, 4177.603127702879, 4243.151369726067, 4262.211490874198, 4286.657067434598, 4311.310190369526, 4237.80929858154, 4256.936145957813, 4260.38224457455, 4263.8081286342185, 4301.806418711166, 4233.491980962273, 4249.87250382489, 4256.553061928515, 4260.659147268242, 4265.125649241898, 4424.712393694432, 4576.8626941191815, 4578.0, 4613.0, 4627.421572303462, 4789.928151077736, 4822.68652537584, 4835.178019736653, 4845.224764037737, 4855.781489832931, 4845.055214233226, 4852.150873597142, 4859.951400485986, 4885.267209918541, 4890.926636100461, 4588.197065513556, 4639.791209395517, 4642.373279607277, 4662.743549104798, 4686.367340409001, 5126.87182820425, 5170.870728231825, 5175.585953123741, 5175.896482070338, 5227.3988491323225, 4797.496262892346, 4821.63837712173, 4942.332785074041, 4953.529414705597, 4958.42978057528, 4990.8253211137435, 5026.0, 5054.949450505522, 5062.873428164326, 5065.214891691794, 4938.481459446778, 4955.876103097379, 4958.330625365602, 4961.925571116436, 5010.724410157403, 4787.2101103318255, 4935.580475659609, 4938.8271410501175, 4964.205727083649, 5001.299818025479, 4087.652549533323, 4179.540250572434, 4210.789460526961, 4246.044639955985, 4250.256205164084, 3694.3165514379925, 3700.3709369407266, 3709.3879509880567, 3733.010752150682, 3739.9813000934823, 4169.4162817205615, 4269.082147338338, 4273.978630106892, 4282.657387409, 4318.784060796947, 4947.431045429749, 4991.101601711654, 4995.375578052744, 5018.473060328686, 5025.447200807908, 4212.347086201644, 4216.91566168681, 4226.281532139544, 4232.746035237896, 4263.16868210696, 4318.287482565404, 4461.442319709971, 4462.933056004163, 4469.061497085583, 4479.820807167677, 4656.324832899143, 4660.39414876064, 4661.696989695659, 4700.365450664117, 4705.1765940960195, 4931.211006238985, 4936.555709986119, 4941.283513890394, 4955.2567114933045, 4993.251012348177, 4494.393256910275, 4632.444106707217, 4666.906661866811, 4703.576678098988, 4724.574788269072, 4886.584640305472, 4903.5586797188425, 4904.215325547895, 4929.507049295042, 4950.430700469492, 4934.259861020732, 4979.701217926936, 4980.651354405157, 4983.725895075806, 4984.675996060245, 4640.373549570765, 4827.613790896649, 4880.902381952412, 4907.582855457326, 4916.680415772963, 4787.305840653155, 4790.185668436444, 4808.2787581863, 4811.615070794258, 4860.076585448754, 4730.172219861579, 4733.7396443194575, 4737.952620473751, 4745.501722319107, 4793.736344500946, 4762.880927976828, 4768.76156192182, 4808.735519546319, 4847.2729090636685, 4858.0, 4717.127331443694, 4761.500042495488, 4799.232122860326, 4805.567498925114, 4818.7831547581145], "value": 4548.715276715607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.1860996713772, 573.5927491481049, 589.6815719511465, 598.2521847690385, 605.476263032477, 26198.345041373974, 26690.733092669067, 26736.46527069462, 26748.465030699375, 26781.86609066957, 33436.0, 34360.0, 34745.13137171572, 35865.2826943461, 35949.64050359496, 7531.209223031585, 7703.4222433317445, 7715.189905059972, 7717.112532058829, 7718.343940765042, 7247.0, 7610.543367397946, 7795.532268063935, 7810.0237470316215, 9342.532873356338, 9580.281478889112, 9744.464054477, 9746.951265243664, 9748.902510974905, 9754.219662426989, 9537.952310238474, 9678.27412944032, 9683.612655493771, 9689.660861869801, 9691.951540242324, 9508.714738557854, 9648.372855764354, 9653.951730241373, 9655.71032869008, 9661.275404344702, 34328.65671343305, 34770.0, 34851.477227841606, 34905.47641785375, 38522.422163667565, 2387.4866903615807, 2454.662209096047, 3223.097532690827, 3276.541284220187, 3306.437905556061, 27875.442491150265, 27901.0, 28143.296417589518, 28687.71312286892, 28982.710172898212, 3493.266414053052, 3533.2050288685095, 3558.822058897045, 3573.213892943548, 3646.9270614587826, 187304.0, 188169.0, 188615.0, 188932.0, 189882.05058974755, 55919.0, 56743.71628141833, 56782.148267776014, 56806.71596642073, 56825.0, 61449.38550614526, 61544.0, 61562.69218653878, 61697.0, 61771.69114154491, 12983.415746291439, 13306.26815525136, 13311.467541298432, 13313.534026309033, 13327.333633318296, 10032.69901902944, 10082.899171008343, 10094.747631309128, 10099.69700908974, 10107.039831216023, 16215.83784162167, 18804.0, 18949.315205438314, 19535.588590115734, 20271.391858244275, 7254.854902902018, 7296.270372962767, 7382.18795932447, 7388.298111679382, 7561.621918904033, 887.8179973105628, 939.6664184214642, 976.1848856205006, 990.7176454710373, 1030.5362586835954, 26799.330016749347, 28115.43769124606, 28597.42805143927, 28616.85691571529, 28756.137315880558, 946.1768261612303, 984.7045886234101, 1011.529638717985, 1044.237706474278, 1074.978500429987, 12968.36728076341, 13550.796738048937, 13575.185488870502, 13597.32013399326, 13668.31658417095, 340220.0, 642532.0, 642621.0, 644010.0, 645087.0, 47354.5264547357, 47901.520984790404, 48222.758886205345, 48274.0, 48371.0, 1131.1403333466624, 1263.7788387032417, 1277.5783991282854, 1285.7364240330896, 1289.3553223388305, 25519.744802551737, 27662.6961430388, 27738.861305693343, 28111.43777124487, 29376.412471750016, 41259.38110928398, 41871.7906410466, 42114.57885421229, 42144.15711685688, 42159.0, 265985.0, 267886.0, 268565.0, 268935.0, 269861.0, 32491.18772030718, 37675.246495070496, 38785.0, 39532.20935581215, 39991.0, 38491.42262866003, 39828.60171398249, 39932.600673992885, 40087.1982560353, 40433.0, 33511.49732753962, 33650.83174584111, 33965.3206935855, 34234.82882585571, 34660.82669586636, 33990.32019359648, 36672.26655466929, 36882.07794805151, 36895.44656830203, 37001.259974800894, 36357.27285454329, 36650.0, 36682.41469816273, 36876.446853297755, 37809.24381512409, 29632.259193520335, 31633.525497118022, 31716.841415792773, 31800.522992154674, 31921.840390798825, 23961.28116156518, 25043.87478062598, 25982.480350392507, 26371.4725705481, 26496.735032649427], "value": 17698.188211635937, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9761465504742, 369.80400387794464, 371.4817829128366, 376.8266597365212, 387.7053439386069, 15823.84176158238, 16413.671726565462, 17571.385001524948, 17612.82387176128, 17638.91180544097, 15980.76028859568, 16193.35226590938, 16963.236654350552, 16989.83010169898, 16991.0, 4884.120858245523, 4981.227909674007, 5054.797808087672, 5061.6962982221, 5064.442911279756, 3628.2380700053022, 3831.5019047523783, 4929.186684197103, 5433.701146436944, 5775.162601422791, 5651.378348381675, 5677.517411020048, 5715.342735585419, 5736.627119237257, 5737.340205876315, 5433.755481003344, 5632.9436705632825, 5637.774489020434, 5669.177969194444, 5711.571632127607, 3287.556179915705, 4703.529647035269, 4970.925436118461, 4974.751262436864, 4975.203967365204, 18225.08874556267, 19043.143058562397, 19055.333063342856, 19129.0, 19146.80853191464, 661.3683931845077, 1936.5255512399413, 1955.2836008311494, 2041.4181958142008, 2201.460642142685, 12865.871341286562, 13118.278494682789, 13231.404586793617, 13400.731985360335, 13530.93234533821, 1714.6056407026329, 1811.1668632428966, 1841.272697284565, 1862.3854128137818, 1888.726134710473, 63718.68140659313, 63848.68075659638, 63917.68041159764, 64060.679696601685, 65833.3416665832, 9110.0, 9473.147416732527, 9511.57197926095, 9599.280053995979, 9646.083622055894, 12855.871441285468, 12997.805032924514, 13000.479980800852, 13013.869861301266, 13025.088243822842, 6871.759488417882, 6921.584704917721, 6995.685194166274, 7032.0, 7107.147142342952, 6600.80197594073, 6621.801345959629, 6625.039369291426, 6704.765333213314, 6744.42672372844, 5898.0, 5933.554983376264, 5977.820665380045, 6022.307434644984, 6076.779306967314, 1594.2347673116737, 1675.5392267126394, 1701.3109690575336, 1706.9231884565224, 1719.071701281319, 777.3004296133525, 874.8556488179506, 922.5848368234322, 944.8063147054837, 969.3166317745972, 16170.514884553482, 16766.413175538797, 16778.6644267114, 16988.150592470327, 17266.395676151526, 930.5161316115582, 933.7525555727738, 937.7702462896634, 942.0767647705287, 946.9593027026631, 7648.80877978055, 10140.54367553447, 10157.593696252216, 10171.389716617026, 10235.385876847413, 389919.0, 400336.0, 401296.0, 403308.0, 403593.0, 68281.0, 69760.0, 70286.64856675787, 73961.0, 76401.0, 872.1104473437059, 1001.6694490818013, 1032.7056788815303, 1066.7173199102244, 1073.1522097543009, 11381.886181138414, 14578.416863325348, 15000.099994000395, 15102.622434439227, 15678.294476748346, 34336.0, 34667.0, 35077.64922350744, 35662.0, 35891.461628076126, 47580.52419475761, 48370.758146209046, 48520.27219591638, 48522.27216591824, 48593.0, 4600.2409602416565, 4676.08816280822, 4924.778384972613, 7068.363847253772, 7556.9798077258865, 8839.204471597586, 10900.618478353219, 10993.175511836804, 11692.479977602858, 11908.880911190778, 8703.825923481369, 9143.177114059767, 10571.735706607089, 10811.35131892089, 10835.783284334428, 10139.290249682452, 10471.94764026175, 10488.213383996079, 10566.154707623218, 10662.453944177896, 10297.0, 10494.842577361498, 10534.051935325551, 10603.098736607166, 10753.946230269112, 7829.138794732461, 8030.478018928751, 8045.919540804517, 8123.878141827996, 8191.017077950684, 7792.688292468464, 9710.126088652056, 10024.699259022242, 10227.642032529124, 10460.058594726512], "value": 8125.033159863022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1189.8988585970192, 1449.1594874972518, 1450.6373406648338, 1610.9194540272983, 1785.5089850291167, 7136.643167841607, 7353.154387245469, 7401.666924988375, 7406.111266648003, 7428.071491063617, 7190.8561828763395, 7336.523125996807, 7368.300011498913, 7368.778936631897, 7368.926310736891, 1818.5271829324404, 1879.915403806832, 1881.868269221155, 2193.385851961449, 2230.096810791632, 1838.485224137237, 2196.374033400481, 2295.0, 2295.6326987681973, 2299.494111295512, 2203.724534433196, 2213.712217411742, 2229.2754854672216, 2234.0, 2234.1733558583346, 1777.3423833181805, 2193.8903054847274, 2222.799948004671, 2224.6218142915745, 2226.0205509575735, 2169.349195241421, 2239.55208958209, 2239.7088378510853, 2241.4284357488737, 2243.2260869999823, 7317.780466586011, 7379.077615298088, 7386.446016548726, 7387.889181662279, 7388.741394051182, 4307.892302692427, 4482.103579284156, 4488.506264310923, 4492.056668099703, 4517.548245175489, 2727.686316073637, 2787.080263513036, 2875.971240287591, 2892.6673432555317, 2901.2746813296676, 943.6272672294474, 960.9279304052154, 968.3221744778613, 971.7667759737612, 1005.6832097889142, 9898.257630677728, 10099.343542669776, 10108.797824043551, 10125.746856328577, 10261.897381026169, 4037.5962403759977, 4314.546972567835, 4318.632916202158, 4322.9351559726, 4352.368906508602, 9000.909990900138, 9004.0, 9037.63849446028, 9061.275097992146, 9064.320175986695, 4682.672212945129, 4697.577218050392, 4700.7179569225955, 4730.2668086445965, 4734.100520901018, 3601.9639803602154, 3715.16408808016, 4069.328560787496, 4266.850660226877, 4300.333448315516, 3108.7202151806446, 3253.5933008373954, 3446.2590543033366, 3548.609652938175, 3550.2721942001826, 1056.8414737789394, 1066.1950227578284, 1076.2950267574752, 1077.9730506737237, 1082.5074591061048, 790.6046976511744, 813.2680587471323, 850.6724910909345, 869.682565863468, 889.217488610032, 5025.275643832354, 5128.769205385766, 5263.0, 5339.41266460689, 5423.322084739408, 889.3196704521047, 899.2176806178667, 912.7581190984395, 922.1470140120362, 945.7919257763418, 3613.638636136365, 3743.812809359521, 3749.7750134991443, 3806.923861522754, 3811.8856434307013, 9011.63953441868, 9184.357095003286, 9337.766555836022, 9356.95321523388, 9365.203957663674, 9234.95382523083, 9249.260059195249, 9255.444673319622, 9257.305702072372, 9258.166764991183, 6783.966080169567, 6970.581765094111, 7131.393831524379, 7164.0, 7164.247753985861, 5339.3058902344, 5459.235707000944, 5476.67139971603, 5484.204790305464, 5584.972075139598, 8531.402801803813, 8565.357598180037, 8646.481211127353, 8683.696070637498, 8728.08355122703, 8100.108988011432, 8370.58147092655, 8398.748037558884, 8499.150084991452, 8500.362472814688, 6556.377144171296, 6669.533132680665, 6676.031975363642, 6677.565958212701, 6679.76620818269, 6365.9681701593045, 7057.682404291717, 7097.290270972861, 7261.237570055279, 7286.453515986216, 6855.897161542481, 6888.035675005403, 6907.896381554381, 7001.544899581511, 7008.053912721921, 6728.461723062242, 6833.58998460094, 6838.589684618939, 6889.2421833599265, 6950.4787140965645, 6171.074338849208, 6211.534134939988, 6254.749810007549, 6256.124142620128, 6265.498760099273, 4643.7213767172725, 4771.6898401603785, 4857.53853383928, 4875.268709693574, 4986.227134794112, 4784.497627749036, 4852.684575502581, 4923.261510773413, 4953.752312384294, 5034.672746271481], "value": 4089.910721195589, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.32732170919707, 302.780484148992, 306.16569847166465, 310.0512431958207, 313.2857085844274, 4897.70613763174, 4996.700197988123, 5000.449950505446, 5010.774515146818, 5016.573591244749, 4906.460289368176, 4949.80737424362, 4950.504949505057, 4956.2565615157655, 4962.00759848031, 3702.389105797547, 3790.374588192945, 3833.0609000794843, 3910.8435662573606, 3951.802409879509, 3904.258190943726, 3936.075022369741, 3941.0935484838506, 3958.604139586033, 3961.8019099045077, 3676.191237927665, 3897.532296124469, 3911.5918269422987, 3913.788709379206, 3923.0584659681613, 3751.3060083884434, 3881.204353107606, 3887.105965627893, 3891.1633998690136, 3896.7467114637457, 3437.4500079987083, 3452.2577645806273, 3453.1539772755586, 3457.3258214648154, 3473.7047350974944, 4767.451743049559, 4792.9760351198365, 4802.567768900815, 4802.783874725646, 4817.181079216542, 4287.2711639021445, 4482.977585112086, 4493.28107502798, 4495.842645507391, 4503.279475283972, 5206.0, 5207.114790485626, 5222.086134926372, 5241.9213711794355, 5265.236540701615, 3787.2010794872217, 3787.3750831112834, 3795.0, 3796.544414670257, 3802.2395520895657, 5326.307580014612, 5453.127499600085, 5457.208704737831, 5496.835094947158, 5518.0, 3891.3579259421876, 3893.9415908761393, 3916.96083039166, 3920.1179734559496, 3922.4508568800393, 3947.881563553098, 3960.9207815844097, 3963.1083006323347, 3964.52425708911, 3972.7020473464604, 4364.170807546556, 4443.289073748249, 4467.128909862546, 4483.7533935633855, 4488.60853135529, 5236.439221329532, 5252.579793616502, 5252.632315737862, 5256.342957130359, 5275.103232450492, 1342.2013901728455, 1373.7939309103715, 1377.7864431013209, 1387.6461502316845, 1387.7363300972784, 895.4000819450853, 923.6213152607532, 943.2831048403262, 949.6154057606681, 961.274237950343, 4548.476925153584, 4549.840755573539, 4551.840685576055, 4557.840475583405, 4562.828833960432, 5371.334886185295, 5372.113601255827, 5377.435369286247, 5384.138537833927, 5385.569154467633, 4337.6963612546815, 4518.43519560055, 4548.13585418776, 4552.954470455319, 4563.1101935123, 2840.6875243723175, 2873.3822228221034, 2875.511163102278, 2875.8418286994415, 2880.423915216965, 5015.974920125449, 5065.949340506548, 5066.898662026739, 5068.251453248697, 5086.3896332440345, 5331.70675612845, 5463.644863083966, 5481.945180548223, 5654.547636189095, 5659.5755318351285, 5148.613853960893, 5168.250603662523, 5169.379674439091, 5174.9482505174465, 5175.378954525481, 5514.779408823762, 5514.972425137848, 5516.0071187186695, 5520.613557050968, 5526.226328313959, 5218.399884013387, 5406.432324605859, 5414.10667239901, 5417.241586177859, 5429.294191755047, 5141.305923700402, 5141.89449268409, 5162.9483705162465, 5173.896522069463, 5174.560162386088, 3727.1986522897705, 3763.830627621709, 3794.1273507094074, 3798.981005094957, 3815.771053736785, 5396.541293989898, 5478.753456094406, 5492.148716948879, 5504.889902202013, 5526.115821468546, 5292.655977361459, 5312.335958005249, 5318.813841515528, 5321.787128514816, 5336.78652853897, 5129.461406552258, 5315.096433606219, 5323.893522129459, 5327.360716714019, 5343.4122246553625, 4948.554630083309, 5220.843374698765, 5229.764660590358, 5241.947580524146, 5246.868828279324, 5173.689578625294, 5336.866578335417, 5340.184337325328, 5351.5451186648015, 5351.785928562814, 5189.844304670866, 5192.5586325162785, 5199.688018718889, 5226.555742761908, 5237.580993520585], "value": 3973.1018828414926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.7012009535662, 676.681959479045, 684.254162962371, 742.2095468326232, 748.4050180106815, 11228.045616122628, 11339.716507087307, 11355.034822040116, 11372.431378431076, 11420.31478111313, 10986.297123945782, 11026.283291586042, 11114.444277786099, 11124.165687573424, 11126.276792008533, 643.2152773616181, 785.0461689047805, 791.4064451661254, 800.8638531449639, 808.1675873849914, 810.1898101898101, 814.6659869453525, 815.5759005317232, 816.8325493273865, 817.1624085312543, 846.6232526525698, 846.7502086884354, 848.1984524624232, 848.2111636178352, 848.3255811629738, 663.8141320430287, 820.3601191070974, 843.3421930893882, 845.0957475501216, 845.9577021148918, 616.9907451388233, 617.0836308082494, 617.1267656266377, 617.1637431280595, 617.1822335405606, 11490.942545287304, 11513.65459036222, 11521.884781152165, 11546.942265288704, 11548.076153907667, 12083.697907552294, 12506.249625022529, 12533.498660053587, 12662.620121396372, 12844.678883027998, 9936.205103591696, 10044.694189755284, 10144.137748291405, 10166.694999150037, 10169.847452288222, 3323.4682450807995, 3348.096014076186, 3410.2667926395943, 3412.7269818414466, 3466.41071017925, 45233.0, 45540.089198216185, 45563.77218113921, 45650.0, 45722.31416528755, 9686.70939871805, 9770.51147442625, 9843.0, 10358.119559837498, 10373.377597344033, 16458.341666333454, 16672.33310667584, 16683.749743753855, 16693.499195024167, 16701.415450459175, 6687.933120668828, 6705.932940670628, 6806.18325800907, 6855.5543889647015, 7031.226565077837, 3831.65515103642, 3836.405357169643, 3839.865604703822, 3912.217556488714, 3949.170674158459, 2872.727090926359, 2949.439606474763, 2956.1131660501765, 2958.2456473599095, 2958.2456473599095, 448.13733562891304, 518.284767021508, 528.4583302115362, 530.082956485275, 562.8986782379129, 554.9334079910436, 586.2905883880467, 608.6652341212316, 623.741147423814, 639.5906619763355, 7881.842363152819, 8013.879791803128, 8077.798055048671, 8113.229243221885, 8209.795926505689, 472.5369138244471, 538.1927109335996, 622.9205084217832, 625.0686477149015, 628.1676778268812, 3415.8292085395633, 3702.3520883845217, 3723.6090210528046, 3748.681362084199, 3768.4158955361963, 51053.0, 51860.740696297034, 51958.0, 52136.47863521392, 52540.21189682158, 24004.15985440501, 24294.05647548192, 24329.878350608134, 44348.3347749784, 47554.76222618865, 41671.374929376085, 42573.0, 43229.56770432255, 43272.9181770452, 43661.0, 7132.964335178291, 7134.143902731706, 7268.854622907618, 7319.780406587811, 7328.3770879473705, 25119.372015699024, 25180.622290665287, 25654.0, 25943.87028064923, 30184.5472317911, 33213.50179747354, 33765.32469350648, 34091.48862767011, 34408.0, 35204.823975879954, 10674.634939417605, 11058.22592418523, 11103.888961110286, 11155.721106972065, 11185.776284474428, 11321.886781132413, 11801.996830269523, 11833.526658933546, 11969.16215864881, 12076.396180191132, 11264.324140551593, 11342.60300889465, 11646.0, 11739.765204696028, 11920.821187682364, 10595.629152979609, 10828.5127169276, 11183.776324473627, 11204.71988200269, 11211.495482703462, 11508.13688973347, 11868.82196767032, 11918.284902905853, 12292.81560776607, 12325.691857703629, 9850.261230407892, 10002.649907253211, 10082.949585252027, 10190.643327483502, 10246.846297305696, 8808.471491710518, 9195.25361327391, 9414.170636207307, 10016.348937319051, 10120.443375614412], "value": 5812.997748794413, "unit": "score"}], "name": "dromaeo_css", "value": 6287.663197128361, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 107.0, 113.0, 114.0, 114.0, 103.0, 112.0, 115.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 144.0, 158.0, 183.0, 142.0, 164.0, 159.0, 132.0, 191.0, 140.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 164.0, 162.0, 163.0, 170.0, 165.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 128.0, 109.0, 73.0, 73.0, 74.0, 112.0, 106.0, 77.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 146.0, 94.0, 95.0, 95.0, 141.0, 95.0, 94.0, 149.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 97.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 85.0, 61.0, 62.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 79.0, 88.0, 80.0, 78.0, 81.0, 79.0, 79.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 132.0, 132.0, 141.0, 135.0, 138.0, 132.0, 165.0, 135.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 177.0, 178.0, 176.0, 177.0, 183.0, 173.0, 175.0, 183.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 73.0, 74.0, 73.0, 75.0, 74.0, 73.0, 71.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1589.7999999999997, "alertThreshold": 2.0}]} 13:59:08 INFO - Return code: 0 13:59:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:59:08 ERROR - # TBPL SUCCESS # 13:59:08 INFO - Running post-action listener: _resource_record_post_action 13:59:08 INFO - Running post-run listener: _resource_record_post_run 13:59:09 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517935104; Read time: 12; Write time: 426144 13:59:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234496000; Read time: 0; Write time: 252308 13:59:10 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283439104; Read time: 12; Write time: 173836 13:59:10 INFO - Running post-run listener: _upload_blobber_files 13:59:10 INFO - Blob upload gear active. 13:59:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:59:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:59:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:11 INFO - (blobuploader) - INFO - Done attempting. 13:59:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:59:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:12 INFO - (blobuploader) - INFO - Done attempting. 13:59:12 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:12 INFO - Return code: 0 13:59:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fef1437f7168675715c0bcd52f0180bc15f2e2ad3953432388a4b7f3fb32293de8456dfa6e15a65633d58c1d8b6f0ae29e830a6955fbcbd30497a28338dd51f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d5a0023cd76624aae3520341f3f368190149ca7de3c7febd25c1f0bd3b0efbe5e9a13893e64c95e55e062ae11d7fc9582c1b65bc00ea75af93cb54d377b50b0"} 13:59:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:12 INFO - Contents: 13:59:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fef1437f7168675715c0bcd52f0180bc15f2e2ad3953432388a4b7f3fb32293de8456dfa6e15a65633d58c1d8b6f0ae29e830a6955fbcbd30497a28338dd51f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d5a0023cd76624aae3520341f3f368190149ca7de3c7febd25c1f0bd3b0efbe5e9a13893e64c95e55e062ae11d7fc9582c1b65bc00ea75af93cb54d377b50b0"} 13:59:12 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:12 INFO - Copying logs to upload dir... 13:59:12 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.565040 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-21 13:59:11.903038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:11.906412) ========= 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=d2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fef1437f7168675715c0bcd52f0180bc15f2e2ad3953432388a4b7f3fb32293de8456dfa6e15a65633d58c1d8b6f0ae29e830a6955fbcbd30497a28338dd51f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d5a0023cd76624aae3520341f3f368190149ca7de3c7febd25c1f0bd3b0efbe5e9a13893e64c95e55e062ae11d7fc9582c1b65bc00ea75af93cb54d377b50b0"} build_url:https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0fef1437f7168675715c0bcd52f0180bc15f2e2ad3953432388a4b7f3fb32293de8456dfa6e15a65633d58c1d8b6f0ae29e830a6955fbcbd30497a28338dd51f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d5a0023cd76624aae3520341f3f368190149ca7de3c7febd25c1f0bd3b0efbe5e9a13893e64c95e55e062ae11d7fc9582c1b65bc00ea75af93cb54d377b50b0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:11.930647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:11.930976) ========= 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=d2a8c569965ab8367867b893000001a1-1461268670.272554-2031172619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:12.016976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 13:59:12.017298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 13:59:12.017708) ========= ========= Total master_lag: 0.18 =========