builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1461679782.19 results: success (0) buildid: 20160426061401 builduid: 28a4a926f735499b9531a45ec38e4077 revision: cad94457610bda2d32741f2e939f25c67a50b536 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.194807) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.195395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.195781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.215735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.216054) ========= 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=41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 07:09:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.6M=0s 2016-04-26 07:09:42 (33.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.352596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.352988) ========= 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=41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017537 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.406169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:42.406560) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cad94457610bda2d32741f2e939f25c67a50b536 --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 cad94457610bda2d32741f2e939f25c67a50b536 --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=41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 07:09:42,406 truncating revision to first 12 chars 2016-04-26 07:09:42,406 Setting DEBUG logging. 2016-04-26 07:09:42,406 attempt 1/10 2016-04-26 07:09:42,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cad94457610b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 07:09:43,062 unpacking tar archive at: fx-team-cad94457610b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.946556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:43.366195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:43.366513) ========= script_repo_revision: cad94457610bda2d32741f2e939f25c67a50b536 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:43.366898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:43.367174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 07:09:43.375839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-26 07:09:43.376253) ========= /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=41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:43 INFO - MultiFileLogger online at 20160426 07:09:43 in /builds/slave/test 07:09:43 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 07:09:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:43 INFO - {'append_to_log': False, 07:09:43 INFO - 'base_work_dir': '/builds/slave/test', 07:09:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:09:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:43 INFO - 'branch': 'Fx-Team-Non-PGO', 07:09:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:43 INFO - 'config_files': ('talos/linux_config.py',), 07:09:43 INFO - 'default_actions': ('clobber', 07:09:43 INFO - 'read-buildbot-config', 07:09:43 INFO - 'download-and-extract', 07:09:43 INFO - 'populate-webroot', 07:09:43 INFO - 'create-virtualenv', 07:09:43 INFO - 'install', 07:09:43 INFO - 'run-tests'), 07:09:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:43 INFO - 'download_minidump_stackwalk': True, 07:09:43 INFO - 'download_symbols': 'ondemand', 07:09:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:43 INFO - 'installer_path': 'installer.exe', 07:09:43 INFO - 'log_level': 'info', 07:09:43 INFO - 'log_name': 'talos', 07:09:43 INFO - 'log_to_console': True, 07:09:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:43 INFO - 'opt_config_files': (), 07:09:43 INFO - 'pip_index': False, 07:09:43 INFO - 'sps_profile': False, 07:09:43 INFO - 'sps_profile_interval': 0, 07:09:43 INFO - 'suite': 'dromaeojs', 07:09:43 INFO - 'system_bits': '32', 07:09:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:43 INFO - 'title': 'talos-linux64-ix-026', 07:09:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:43 INFO - 'use_talos_json': True, 07:09:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:43 INFO - 'work_dir': 'build'} 07:09:43 INFO - ##### 07:09:43 INFO - ##### Running clobber step. 07:09:43 INFO - ##### 07:09:43 INFO - Running pre-action listener: _resource_record_pre_action 07:09:43 INFO - Running main action method: clobber 07:09:43 INFO - rmtree: /builds/slave/test/build 07:09:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:43 INFO - Running post-action listener: _resource_record_post_action 07:09:43 INFO - ##### 07:09:43 INFO - ##### Running read-buildbot-config step. 07:09:43 INFO - ##### 07:09:43 INFO - Running pre-action listener: _resource_record_pre_action 07:09:43 INFO - Running main action method: read_buildbot_config 07:09:43 INFO - Using buildbot properties: 07:09:43 INFO - { 07:09:43 INFO - "project": "", 07:09:43 INFO - "product": "firefox", 07:09:43 INFO - "script_repo_revision": "production", 07:09:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:09:43 INFO - "repository": "", 07:09:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:09:43 INFO - "buildid": "20160426061401", 07:09:43 INFO - "pgo_build": "False", 07:09:43 INFO - "basedir": "/builds/slave/test", 07:09:43 INFO - "buildnumber": 1604, 07:09:43 INFO - "slavename": "talos-linux64-ix-026", 07:09:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:09:43 INFO - "platform": "ubuntu64_hw", 07:09:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:09:43 INFO - "branch": "fx-team", 07:09:43 INFO - "repo_path": "integration/fx-team", 07:09:43 INFO - "revision": "cad94457610bda2d32741f2e939f25c67a50b536", 07:09:43 INFO - "stage_platform": "linux64", 07:09:43 INFO - "builduid": "28a4a926f735499b9531a45ec38e4077", 07:09:43 INFO - "slavebuilddir": "test" 07:09:43 INFO - } 07:09:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:09:43 INFO - Running post-action listener: _resource_record_post_action 07:09:43 INFO - ##### 07:09:43 INFO - ##### Running download-and-extract step. 07:09:43 INFO - ##### 07:09:43 INFO - Running pre-action listener: _resource_record_pre_action 07:09:43 INFO - Running main action method: download_and_extract 07:09:43 INFO - mkdir: /builds/slave/test/build/tests 07:09:43 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')]} 07:09:43 INFO - https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:44 INFO - Downloaded 1361 bytes. 07:09:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:44 INFO - Using the following test package requirements: 07:09:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'jsshell-linux-x86_64.zip'], 07:09:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:44 INFO - https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:45 INFO - Downloaded 22291062 bytes. 07:09:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:47 INFO - Return code: 0 07:09:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09: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')]} 07:09:47 INFO - https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:48 INFO - Downloaded 22291062 bytes. 07:09:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:49 INFO - Return code: 0 07:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:49 INFO - https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:09:50 INFO - Downloaded 10840145 bytes. 07:09:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:09:51 INFO - Return code: 0 07:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:51 INFO - https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:09:53 INFO - Downloaded 54816724 bytes. 07:09:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:53 INFO - mkdir: /builds/slave/test/properties 07:09:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:53 INFO - Contents: 07:09:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:54 INFO - Running post-action listener: _resource_record_post_action 07:09:54 INFO - Running post-action listener: set_extra_try_arguments 07:09:54 INFO - ##### 07:09:54 INFO - ##### Running populate-webroot step. 07:09:54 INFO - ##### 07:09:54 INFO - Running pre-action listener: _resource_record_pre_action 07:09:54 INFO - Running main action method: populate_webroot 07:09:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:54 INFO - '--tppagecycles', 07:09:54 INFO - '7'], 07:09:54 INFO - 'tests': ['tsvgm']}}, 07:09:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['damp', 'tps']}, 07:09:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'tests': ['damp', 'tps']}, 07:09:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['dromaeo_dom']}, 07:09:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['a11yr', 07:09:54 INFO - 'ts_paint', 07:09:54 INFO - 'tpaint', 07:09:54 INFO - 'sessionrestore', 07:09:54 INFO - 'sessionrestore_no_auto_restore', 07:09:54 INFO - 'tabpaint']}, 07:09:54 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:54 INFO - 'ts_paint', 07:09:54 INFO - 'tpaint', 07:09:54 INFO - 'sessionrestore', 07:09:54 INFO - 'sessionrestore_no_auto_restore', 07:09:54 INFO - 'tabpaint']}, 07:09:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:54 INFO - 'ts_paint', 07:09:54 INFO - 'tpaint', 07:09:54 INFO - 'sessionrestore', 07:09:54 INFO - 'sessionrestore_no_auto_restore', 07:09:54 INFO - 'tabpaint']}, 07:09:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:54 INFO - 'ts_paint', 07:09:54 INFO - 'tpaint', 07:09:54 INFO - 'sessionrestore', 07:09:54 INFO - 'sessionrestore_no_auto_restore', 07:09:54 INFO - 'tabpaint']}, 07:09:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['a11yr', 07:09:54 INFO - 'ts_paint', 07:09:54 INFO - 'tpaint', 07:09:54 INFO - 'sessionrestore', 07:09:54 INFO - 'sessionrestore_no_auto_restore', 07:09:54 INFO - 'tabpaint']}, 07:09:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['a11yr', 07:09:54 INFO - 'ts_paint', 07:09:54 INFO - 'tpaint', 07:09:54 INFO - 'sessionrestore', 07:09:54 INFO - 'sessionrestore_no_auto_restore', 07:09:54 INFO - 'tabpaint']}, 07:09:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['tsvgx', 07:09:54 INFO - 'tsvgr_opacity', 07:09:54 INFO - 'tart', 07:09:54 INFO - 'tscrollx', 07:09:54 INFO - 'cart']}, 07:09:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:54 INFO - 'tsvgr_opacity', 07:09:54 INFO - 'tart', 07:09:54 INFO - 'tscrollx', 07:09:54 INFO - 'cart']}, 07:09:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'talos_options': ['--disable-e10s'], 07:09:54 INFO - 'tests': ['tp5o']}, 07:09:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'tests': ['tp5o']}, 07:09:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'talos_options': ['--disable-e10s', 07:09:54 INFO - '--xperf_path', 07:09:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:54 INFO - 'tests': ['tp5n']}, 07:09:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:54 INFO - 'talos_options': ['--xperf_path', 07:09:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:54 INFO - 'tests': ['tp5n']}}, 07:09:54 INFO - 'talos.zip': {'path': '', 07:09:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:54 INFO - Running post-action listener: _resource_record_post_action 07:09:54 INFO - ##### 07:09:54 INFO - ##### Running create-virtualenv step. 07:09:54 INFO - ##### 07:09:54 INFO - Running pre-action listener: _resource_record_pre_action 07:09:54 INFO - Running main action method: create_virtualenv 07:09:54 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:54 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 07:09:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:54 INFO - Using real prefix '/usr' 07:09:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:54 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:56 INFO - Installing pip.................done. 07:09:56 INFO - Return code: 0 07:09:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:56 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:09:56 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 07:09:56 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 07:09:56 INFO - Using env: {'DISPLAY': ':0', 07:09:56 INFO - 'HOME': '/home/cltbld', 07:09:56 INFO - 'LANG': 'en_US.UTF-8', 07:09:56 INFO - 'LANGUAGE': 'en_US:en', 07:09:56 INFO - 'LOGNAME': 'cltbld', 07:09:56 INFO - 'MAIL': '/var/mail/cltbld', 07:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:56 INFO - 'MOZ_NO_REMOTE': '1', 07:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:56 INFO - 'NO_EM_RESTART': '1', 07:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:56 INFO - 'PWD': '/builds/slave/test', 07:09:56 INFO - 'SHELL': '/bin/bash', 07:09:56 INFO - 'SHLVL': '1', 07:09:56 INFO - 'TERM': 'linux', 07:09:56 INFO - 'TMOUT': '86400', 07:09:56 INFO - 'USER': 'cltbld', 07:09:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:56 INFO - '_': '/tools/buildbot/bin/python'} 07:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:57 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 07:09:57 INFO - Cleaning up... 07:09:57 INFO - Return code: 0 07:09:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:09:57 INFO - Using env: {'DISPLAY': ':0', 07:09:57 INFO - 'HOME': '/home/cltbld', 07:09:57 INFO - 'LANG': 'en_US.UTF-8', 07:09:57 INFO - 'LANGUAGE': 'en_US:en', 07:09:57 INFO - 'LOGNAME': 'cltbld', 07:09:57 INFO - 'MAIL': '/var/mail/cltbld', 07:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:57 INFO - 'MOZ_NO_REMOTE': '1', 07:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:57 INFO - 'NO_EM_RESTART': '1', 07:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:57 INFO - 'PWD': '/builds/slave/test', 07:09:57 INFO - 'SHELL': '/bin/bash', 07:09:57 INFO - 'SHLVL': '1', 07:09:57 INFO - 'TERM': 'linux', 07:09:57 INFO - 'TMOUT': '86400', 07:09:57 INFO - 'USER': 'cltbld', 07:09:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:57 INFO - '_': '/tools/buildbot/bin/python'} 07:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:57 INFO - Downloading/unpacking psutil>=0.7.1 07:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:59 INFO - Installing collected packages: psutil 07:09:59 INFO - Running setup.py install for psutil 07:09:59 INFO - building 'psutil._psutil_linux' extension 07:09:59 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 07:09:59 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 07:09:59 INFO - building 'psutil._psutil_posix' extension 07:09:59 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 07:09:59 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 07:09:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:00 INFO - Successfully installed psutil 07:10:00 INFO - Cleaning up... 07:10:00 INFO - Return code: 0 07:10:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:10:00 INFO - Using env: {'DISPLAY': ':0', 07:10:00 INFO - 'HOME': '/home/cltbld', 07:10:00 INFO - 'LANG': 'en_US.UTF-8', 07:10:00 INFO - 'LANGUAGE': 'en_US:en', 07:10:00 INFO - 'LOGNAME': 'cltbld', 07:10:00 INFO - 'MAIL': '/var/mail/cltbld', 07:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:00 INFO - 'MOZ_NO_REMOTE': '1', 07:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:00 INFO - 'NO_EM_RESTART': '1', 07:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:00 INFO - 'PWD': '/builds/slave/test', 07:10:00 INFO - 'SHELL': '/bin/bash', 07:10:00 INFO - 'SHLVL': '1', 07:10:00 INFO - 'TERM': 'linux', 07:10:00 INFO - 'TMOUT': '86400', 07:10:00 INFO - 'USER': 'cltbld', 07:10:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:00 INFO - '_': '/tools/buildbot/bin/python'} 07:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:10:02 INFO - Installing collected packages: mozsystemmonitor 07:10:02 INFO - Running setup.py install for mozsystemmonitor 07:10:02 INFO - Successfully installed mozsystemmonitor 07:10:02 INFO - Cleaning up... 07:10:02 INFO - Return code: 0 07:10:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:02 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:02 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 07:10:02 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 07:10:02 INFO - Using env: {'DISPLAY': ':0', 07:10:02 INFO - 'HOME': '/home/cltbld', 07:10:02 INFO - 'LANG': 'en_US.UTF-8', 07:10:02 INFO - 'LANGUAGE': 'en_US:en', 07:10:02 INFO - 'LOGNAME': 'cltbld', 07:10:02 INFO - 'MAIL': '/var/mail/cltbld', 07:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:02 INFO - 'MOZ_NO_REMOTE': '1', 07:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:02 INFO - 'NO_EM_RESTART': '1', 07:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:02 INFO - 'PWD': '/builds/slave/test', 07:10:02 INFO - 'SHELL': '/bin/bash', 07:10:02 INFO - 'SHLVL': '1', 07:10:02 INFO - 'TERM': 'linux', 07:10:02 INFO - 'TMOUT': '86400', 07:10:02 INFO - 'USER': 'cltbld', 07:10:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:02 INFO - '_': '/tools/buildbot/bin/python'} 07:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:05 INFO - Downloading docopt-0.6.1.tar.gz 07:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:05 INFO - Running setup.py install for blobuploader 07:10:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:05 INFO - Running setup.py install for requests 07:10:05 INFO - Running setup.py install for docopt 07:10:05 INFO - Successfully installed blobuploader requests docopt 07:10:05 INFO - Cleaning up... 07:10:05 INFO - Return code: 0 07:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:05 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:05 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 07:10:05 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 07:10:05 INFO - Using env: {'DISPLAY': ':0', 07:10:05 INFO - 'HOME': '/home/cltbld', 07:10:05 INFO - 'LANG': 'en_US.UTF-8', 07:10:05 INFO - 'LANGUAGE': 'en_US:en', 07:10:05 INFO - 'LOGNAME': 'cltbld', 07:10:05 INFO - 'MAIL': '/var/mail/cltbld', 07:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:05 INFO - 'MOZ_NO_REMOTE': '1', 07:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:05 INFO - 'NO_EM_RESTART': '1', 07:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:05 INFO - 'PWD': '/builds/slave/test', 07:10:05 INFO - 'SHELL': '/bin/bash', 07:10:05 INFO - 'SHLVL': '1', 07:10:05 INFO - 'TERM': 'linux', 07:10:05 INFO - 'TMOUT': '86400', 07:10:05 INFO - 'USER': 'cltbld', 07:10:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:05 INFO - '_': '/tools/buildbot/bin/python'} 07:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:06 INFO - Running setup.py (path:/tmp/pip-IvS8mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:06 INFO - Running setup.py (path:/tmp/pip-Cmlr8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:06 INFO - Running setup.py (path:/tmp/pip-ibaYo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:06 INFO - Running setup.py (path:/tmp/pip-ndmAIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:06 INFO - Running setup.py (path:/tmp/pip-dWGSQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:06 INFO - Running setup.py (path:/tmp/pip-0ML3O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:06 INFO - Running setup.py (path:/tmp/pip-iiPcWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:06 INFO - Running setup.py (path:/tmp/pip-JJuL8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:06 INFO - Running setup.py (path:/tmp/pip-xZt44Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:06 INFO - Running setup.py (path:/tmp/pip-YdzfnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:06 INFO - Running setup.py (path:/tmp/pip-Ao5Ldk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:06 INFO - Running setup.py (path:/tmp/pip-PBqPbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:06 INFO - Running setup.py (path:/tmp/pip-8BSQUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:06 INFO - Running setup.py (path:/tmp/pip-61UVGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:07 INFO - Running setup.py (path:/tmp/pip-ULTvTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:07 INFO - Running setup.py (path:/tmp/pip-RMbYPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:07 INFO - Running setup.py (path:/tmp/pip-tSnjCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:07 INFO - Running setup.py install for manifestparser 07:10:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Running setup.py install for mozcrash 07:10:07 INFO - Running setup.py install for mozdebug 07:10:07 INFO - Running setup.py install for mozdevice 07:10:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Running setup.py install for mozfile 07:10:07 INFO - Running setup.py install for mozhttpd 07:10:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Running setup.py install for mozinfo 07:10:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Running setup.py install for mozInstall 07:10:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Running setup.py install for mozleak 07:10:08 INFO - Running setup.py install for mozlog 07:10:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Running setup.py install for moznetwork 07:10:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Running setup.py install for mozprocess 07:10:08 INFO - Running setup.py install for mozprofile 07:10:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Running setup.py install for mozrunner 07:10:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Running setup.py install for mozscreenshot 07:10:08 INFO - Running setup.py install for moztest 07:10:08 INFO - Running setup.py install for mozversion 07:10:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:09 INFO - Cleaning up... 07:10:09 INFO - Return code: 0 07:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:09 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')]} 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:09 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')]} 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:09 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:09 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 07:10:09 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 07:10:09 INFO - Using env: {'DISPLAY': ':0', 07:10:09 INFO - 'HOME': '/home/cltbld', 07:10:09 INFO - 'LANG': 'en_US.UTF-8', 07:10:09 INFO - 'LANGUAGE': 'en_US:en', 07:10:09 INFO - 'LOGNAME': 'cltbld', 07:10:09 INFO - 'MAIL': '/var/mail/cltbld', 07:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:09 INFO - 'MOZ_NO_REMOTE': '1', 07:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:09 INFO - 'NO_EM_RESTART': '1', 07:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:09 INFO - 'PWD': '/builds/slave/test', 07:10:09 INFO - 'SHELL': '/bin/bash', 07:10:09 INFO - 'SHLVL': '1', 07:10:09 INFO - 'TERM': 'linux', 07:10:09 INFO - 'TMOUT': '86400', 07:10:09 INFO - 'USER': 'cltbld', 07:10:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:09 INFO - '_': '/tools/buildbot/bin/python'} 07:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:09 INFO - Running setup.py (path:/tmp/pip-qGlLjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:09 INFO - Running setup.py (path:/tmp/pip-i7VNag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:09 INFO - Running setup.py (path:/tmp/pip-ERBDsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:09 INFO - Running setup.py (path:/tmp/pip-ZrU8tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:09 INFO - Running setup.py (path:/tmp/pip-ArbqxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:09 INFO - Running setup.py (path:/tmp/pip-8IKDHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:09 INFO - Running setup.py (path:/tmp/pip-29IBXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:09 INFO - Running setup.py (path:/tmp/pip-aO8dHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:09 INFO - Running setup.py (path:/tmp/pip-jZkN2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:09 INFO - Running setup.py (path:/tmp/pip-BN0IHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:09 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)) 07:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:09 INFO - Running setup.py (path:/tmp/pip-YhlD5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:10 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)) 07:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:10 INFO - Running setup.py (path:/tmp/pip-MSJYnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:10 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)) 07:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:10 INFO - Running setup.py (path:/tmp/pip-cC4wI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:10 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)) 07:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:10 INFO - Running setup.py (path:/tmp/pip-33BvZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:10 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)) 07:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:10 INFO - Running setup.py (path:/tmp/pip-3H1yma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:10 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)) 07:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:10 INFO - Running setup.py (path:/tmp/pip-fZUUKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:10 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)) 07:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:10 INFO - Running setup.py (path:/tmp/pip-xhlmLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:10 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)) 07:10:10 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)) 07:10:10 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)) 07:10:10 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)) 07:10:10 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)) 07:10:10 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)) 07:10:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:12 INFO - Downloading blessings-1.6.tar.gz 07:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:12 INFO - Installing collected packages: blessings 07:10:12 INFO - Running setup.py install for blessings 07:10:12 INFO - Successfully installed blessings 07:10:12 INFO - Cleaning up... 07:10:12 INFO - Return code: 0 07:10:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:12 INFO - Reading from file tmpfile_stdout 07:10:12 INFO - Current package versions: 07:10:12 INFO - argparse == 1.2.1 07:10:12 INFO - blessings == 1.6 07:10:12 INFO - blobuploader == 1.2.4 07:10:12 INFO - docopt == 0.6.1 07:10:12 INFO - manifestparser == 1.1 07:10:12 INFO - mozInstall == 1.12 07:10:12 INFO - mozcrash == 0.17 07:10:12 INFO - mozdebug == 0.1 07:10:12 INFO - mozdevice == 0.48 07:10:12 INFO - mozfile == 1.2 07:10:12 INFO - mozhttpd == 0.7 07:10:12 INFO - mozinfo == 0.9 07:10:12 INFO - mozleak == 0.1 07:10:12 INFO - mozlog == 3.1 07:10:12 INFO - moznetwork == 0.27 07:10:12 INFO - mozprocess == 0.22 07:10:12 INFO - mozprofile == 0.28 07:10:12 INFO - mozrunner == 6.11 07:10:12 INFO - mozscreenshot == 0.1 07:10:12 INFO - mozsystemmonitor == 0.0 07:10:12 INFO - moztest == 0.7 07:10:12 INFO - mozversion == 1.4 07:10:12 INFO - psutil == 3.1.1 07:10:12 INFO - requests == 1.2.3 07:10:12 INFO - wsgiref == 0.1.2 07:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:12 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')]} 07:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:12 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')]} 07:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:12 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:12 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 07:10:12 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 07:10:12 INFO - Using env: {'DISPLAY': ':0', 07:10:12 INFO - 'HOME': '/home/cltbld', 07:10:12 INFO - 'LANG': 'en_US.UTF-8', 07:10:12 INFO - 'LANGUAGE': 'en_US:en', 07:10:12 INFO - 'LOGNAME': 'cltbld', 07:10:12 INFO - 'MAIL': '/var/mail/cltbld', 07:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:12 INFO - 'MOZ_NO_REMOTE': '1', 07:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:12 INFO - 'NO_EM_RESTART': '1', 07:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:12 INFO - 'PWD': '/builds/slave/test', 07:10:12 INFO - 'SHELL': '/bin/bash', 07:10:12 INFO - 'SHLVL': '1', 07:10:12 INFO - 'TERM': 'linux', 07:10:12 INFO - 'TMOUT': '86400', 07:10:12 INFO - 'USER': 'cltbld', 07:10:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:12 INFO - '_': '/tools/buildbot/bin/python'} 07:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 INFO - Cleaning up... 07:10:13 INFO - Return code: 0 07:10:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:13 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:13 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 07:10:13 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 07:10:13 INFO - Using env: {'DISPLAY': ':0', 07:10:13 INFO - 'HOME': '/home/cltbld', 07:10:13 INFO - 'LANG': 'en_US.UTF-8', 07:10:13 INFO - 'LANGUAGE': 'en_US:en', 07:10:13 INFO - 'LOGNAME': 'cltbld', 07:10:13 INFO - 'MAIL': '/var/mail/cltbld', 07:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:13 INFO - 'MOZ_NO_REMOTE': '1', 07:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:13 INFO - 'NO_EM_RESTART': '1', 07:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:13 INFO - 'PWD': '/builds/slave/test', 07:10:13 INFO - 'SHELL': '/bin/bash', 07:10:13 INFO - 'SHLVL': '1', 07:10:13 INFO - 'TERM': 'linux', 07:10:13 INFO - 'TMOUT': '86400', 07:10:13 INFO - 'USER': 'cltbld', 07:10:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:13 INFO - '_': '/tools/buildbot/bin/python'} 07:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:13 INFO - Downloading/unpacking jsonschema 07:10:13 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 07:10:13 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 07:10:13 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 07:10:13 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 07:10:13 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 07:10:13 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 07:10:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:15 INFO - Downloading/unpacking functools32 (from jsonschema) 07:10:15 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 07:10:15 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 07:10:15 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 07:10:15 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 07:10:15 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 07:10:15 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 07:10:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:15 INFO - warning: no files found matching '*.txt' 07:10:15 INFO - no previously-included directories found matching 'build' 07:10:15 INFO - no previously-included directories found matching 'dist' 07:10:15 INFO - no previously-included directories found matching '.git*' 07:10:15 INFO - Installing collected packages: jsonschema, functools32 07:10:15 INFO - Running setup.py install for functools32 07:10:15 INFO - warning: no files found matching '*.txt' 07:10:15 INFO - no previously-included directories found matching 'build' 07:10:15 INFO - no previously-included directories found matching 'dist' 07:10:15 INFO - no previously-included directories found matching '.git*' 07:10:15 INFO - Successfully installed jsonschema functools32 07:10:15 INFO - Cleaning up... 07:10:15 INFO - Return code: 0 07:10:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:15 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 0x7f1afb7fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, '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': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', '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 07:10:15 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 07:10:15 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 07:10:15 INFO - Using env: {'DISPLAY': ':0', 07:10:15 INFO - 'HOME': '/home/cltbld', 07:10:15 INFO - 'LANG': 'en_US.UTF-8', 07:10:15 INFO - 'LANGUAGE': 'en_US:en', 07:10:15 INFO - 'LOGNAME': 'cltbld', 07:10:15 INFO - 'MAIL': '/var/mail/cltbld', 07:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:15 INFO - 'MOZ_NO_REMOTE': '1', 07:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:15 INFO - 'NO_EM_RESTART': '1', 07:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:15 INFO - 'PWD': '/builds/slave/test', 07:10:15 INFO - 'SHELL': '/bin/bash', 07:10:15 INFO - 'SHLVL': '1', 07:10:15 INFO - 'TERM': 'linux', 07:10:15 INFO - 'TMOUT': '86400', 07:10:15 INFO - 'USER': 'cltbld', 07:10:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:15 INFO - '_': '/tools/buildbot/bin/python'} 07:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:16 INFO - Downloading/unpacking flake8 07:10:16 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 07:10:16 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 07:10:16 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 07:10:16 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 07:10:16 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 07:10:16 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 07:10:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:10:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:10:17 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 07:10:17 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 07:10:17 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 07:10:17 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 07:10:17 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 07:10:17 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 07:10:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:10:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:10:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:18 INFO - no previously-included directories found matching 'docs/_build' 07:10:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:10:18 INFO - Running setup.py install for pep8 07:10:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:18 INFO - no previously-included directories found matching 'docs/_build' 07:10:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:10:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:10:18 INFO - Cleaning up... 07:10:18 INFO - Return code: 0 07:10:18 INFO - Running post-action listener: _resource_record_post_action 07:10:18 INFO - Running post-action listener: _start_resource_monitoring 07:10:18 INFO - Starting resource monitoring. 07:10:18 INFO - ##### 07:10:18 INFO - ##### Running install step. 07:10:18 INFO - ##### 07:10:18 INFO - Running pre-action listener: _resource_record_pre_action 07:10:18 INFO - Running main action method: install 07:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:19 INFO - Reading from file tmpfile_stdout 07:10:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:19 INFO - Reading from file tmpfile_stdout 07:10:19 INFO - Output received: 07:10:19 INFO - Usage: mozinstall [options] installer 07:10:19 INFO - Options: 07:10:19 INFO - -h, --help show this help message and exit 07:10:19 INFO - -d DEST, --destination=DEST 07:10:19 INFO - Directory to install application into. [default: 07:10:19 INFO - "/builds/slave/test"] 07:10:19 INFO - --app=APP Application being installed. [default: firefox] 07:10:19 INFO - mkdir: /builds/slave/test/build/application 07:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:35 INFO - Reading from file tmpfile_stdout 07:10:35 INFO - Output received: 07:10:35 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:35 INFO - Running post-action listener: _resource_record_post_action 07:10:35 INFO - ##### 07:10:35 INFO - ##### Running run-tests step. 07:10:35 INFO - ##### 07:10:35 INFO - Running pre-action listener: _resource_record_pre_action 07:10:35 INFO - Running main action method: run_tests 07:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:35 INFO - Python 2.7.3 07:10:35 INFO - Return code: 0 07:10:35 INFO - grabbing minidump binary from tooltool 07:10:35 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')]} 07:10:35 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 0x1624410>, '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 0x1625310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16257a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:35 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 07:10:35 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 07:10:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:35 INFO - Return code: 0 07:10:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:10:36 INFO - Return code: 0 07:10:36 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/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 07:10:36 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/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 07:10:36 INFO - Using env: {'DISPLAY': ':0', 07:10:36 INFO - 'HOME': '/home/cltbld', 07:10:36 INFO - 'LANG': 'en_US.UTF-8', 07:10:36 INFO - 'LANGUAGE': 'en_US:en', 07:10:36 INFO - 'LOGNAME': 'cltbld', 07:10:36 INFO - 'MAIL': '/var/mail/cltbld', 07:10:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:36 INFO - 'MOZ_NO_REMOTE': '1', 07:10:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:36 INFO - 'NO_EM_RESTART': '1', 07:10:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:36 INFO - 'PWD': '/builds/slave/test', 07:10:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:36 INFO - 'SHELL': '/bin/bash', 07:10:36 INFO - 'SHLVL': '1', 07:10:36 INFO - 'TERM': 'linux', 07:10:36 INFO - 'TMOUT': '86400', 07:10:36 INFO - 'USER': 'cltbld', 07:10:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314', 07:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:36 INFO - '_': '/tools/buildbot/bin/python'} 07:10:36 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/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 07:10:36 INFO - mozversion application_buildid: 20160426061401 07:10:36 INFO - mozversion application_changeset: cad94457610bda2d32741f2e939f25c67a50b536 07:10:36 INFO - mozversion application_display_name: Nightly 07:10:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:36 INFO - mozversion application_name: Firefox 07:10:36 INFO - mozversion application_remotingname: firefox 07:10:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:10:36 INFO - mozversion application_vendor: Mozilla 07:10:36 INFO - mozversion application_version: 49.0a1 07:10:36 INFO - mozversion platform_buildid: 20160426061401 07:10:36 INFO - mozversion platform_changeset: cad94457610bda2d32741f2e939f25c67a50b536 07:10:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:10:36 INFO - mozversion platform_version: 49.0a1 07:10:36 INFO - using testdate: 1461679836 07:10:36 INFO - actual date: 1461679836 07:10:36 INFO - starting webserver on 'localhost:51409' 07:10:36 INFO - SUITE-START | Running 2 tests 07:10:36 INFO - TEST-START | dromaeo_css 07:10:36 INFO - operating with platform_type : linux_ 07:10:36 INFO - Initialising browser for dromaeo_css test... 07:10:36 INFO - TEST-INFO | started process 7076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWyRlA0/profile http://localhost:51409/getInfo.html) 07:10:40 INFO - PROCESS | 7076 | __metrics Screen width/height:1600/1200 07:10:40 INFO - PROCESS | 7076 | colorDepth:24 07:10:40 INFO - PROCESS | 7076 | Browser inner width/height: 1024/697 07:10:40 INFO - PROCESS | 7076 | __metrics 07:10:41 ERROR - PROCESS | 7076 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:10:42 INFO - TEST-INFO | 7076: exit 0 07:10:42 INFO - Browser initialized. 07:10:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:42 INFO - TEST-INFO | started process 7157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWyRlA0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:54 INFO - PROCESS | 7157 | RSS: Main: 156053504 07:10:54 INFO - PROCESS | 7157 | 07:11:45 INFO - PROCESS | 7157 | 1461679905281 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] 07:13:57 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51409/tests/dromaeo/cssquery-ext.html) 07:13:58 INFO - PROCESS | 7157 | RSS: Main: 259428352 07:13:58 INFO - PROCESS | 7157 | 07:17:00 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-ext.html (next: http://localhost:51409/tests/dromaeo/cssquery-jquery.html) 07:17:01 INFO - PROCESS | 7157 | RSS: Main: 238243840 07:17:01 INFO - PROCESS | 7157 | 07:20:03 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51409/tests/dromaeo/cssquery-mootools.html) 07:20:04 INFO - PROCESS | 7157 | RSS: Main: 247300096 07:20:04 INFO - PROCESS | 7157 | 07:23:06 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51409/tests/dromaeo/cssquery-prototype.html) 07:23:06 INFO - PROCESS | 7157 | RSS: Main: 228970496 07:23:06 INFO - PROCESS | 7157 | 07:26:09 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51409/tests/dromaeo/cssquery-yui.html) 07:26:10 INFO - PROCESS | 7157 | RSS: Main: 217174016 07:26:10 INFO - PROCESS | 7157 | 07:29:12 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-yui.html (next: http://localhost:51409/tests/dromaeo/cssquery-dojo.html) 07:29:13 INFO - PROCESS | 7157 | RSS: Main: 267636736 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | __start_tp_report 07:29:13 INFO - PROCESS | 7157 | _x_x_mozilla_page_load 07:29:13 INFO - PROCESS | 7157 | _x_x_mozilla_page_load_details 07:29:13 INFO - PROCESS | 7157 | |i|pagename|runs| 07:29:13 INFO - PROCESS | 7157 | |0;dojo.html;2584.3409930467733;2632.749888760567;2644.986775066124;2649.947001059979;2675.010246208903;4496.797644106015;4561.680682352233;4575.88560285993;4578.70238434502;4587.24310488769;4533.3426653135275;4537.705049171802;4545.522720114382;4666.533346665332;4717.009428020111;4195.160967806436;4196.853110141138;4239.830406783725;4266.7013309068225;4276;4260.147970405916;4285.764282964436;4329.047609525915;4330.783460826962;4333.956660433387;4098;4188.748675079505;4188.91622167558;4230.555791641864;4285.550017248175;4168.520620128694;4179.853705120307;4186.372044193365;4192.140611174702;4193.329067349209;4204.264253755611;4254.149170165979;4259.595338442843;4275.935860962088;4309.913801723979;4473.329000649928;4484.551544845522;4506.752128632924;4529.297958816389;4573.679842411033;4798.54413830689;4894.1679914414635;4929.1374009548545;4939.8024079036795;4941.110600091982;4939.975300123477;4954.157793175169;4957.529034741694;4968.801247950078;5020.322256495399;4591.288350305708;4602.401687780567;4605.217113090749;4607.424071991001;4631.8842028948875;4833.984863178702;4895.461499235082;4991.5258050485145;5043.067032598908;5069.695818250917;4863.537963893425;4885.2427873679635;4888.413390393104;4890.633202509826;4910.459849416561;4962.454130045692;4963.255511673206;4964.553190212898;4971.37857767779;5001.7749201285305;4738.810447582058;4828.37231159947;4917.606591472673;4925.926111108336;4926.433460152129;4853.864299708188;4854.441739199967;4872.4883887192045;4873.707577545359;4926.704397736147;4237.851675191354;4242.787860606957;4245.320748680197;4252.787360631956;4286.271333873249;3622.945655815165;3676.816159192083;3708.9443658345144;3754;3788.431735239736;4285.91428171441;4291.3777502262;4304.182205380967;4309.439772829513;4352.521222665504;4954.182559877652;4954.455009948902;4954.5540901319055;4955.132851750929;4992.076465853828;4181.330987042059;4260.637845783143;4289.24938135825;4319.244132276839;4331.956680433155;4373.6282415994365;4388.890277743082;4397.758123303249;4434.2240107981615;4437.467503899488;4550.431196100488;4596.287575425815;4603.3785438965315;4604.056168485519;4604.953950460519;4833.95166048335;4915.901681966412;4916.483769204182;4944.777485013255;4969.577585905238;4691.7184968901975;4708.964027913854;4710.152172608963;4711.858644240679;4744.240921452689;4644.047970166175;4743.288506724019;4867.561919427269;4870.4155501340065;4919.926201107058;4796.25658023007;4816.181249187716;4820.975895120502;4854.247591623304;4869.6591238612955;4709.128811169944;4711.128441238382;4711.858644240679;4756.429228492603;4760.143174228534;4475.1273501666865;4699.3890794197905;4708.552687494683;4719.221328480762;4776.068666609977;4677.181493238738;4709.788059537397;4710.175719249186;4738.431388233434;4760;4783.545563171493;4791.065742180242;4800.303955926441;4810.134175848241;4841.588464980516;4578.908421831611;4685.367475390779;4731.219348807408;4763.809447622057;4775.42694876617 07:29:13 INFO - PROCESS | 7157 | |1;ext.html;571.5656101362963;588.3528119069023;597.2713289786461;605.3613437823095;614.5851550203612;23051.538969220626;28977;29470;29542.556861647092;29644.110676679735;33379.49930751041;34260.48609270863;34312.82843585779;34355.82822085886;34368.656313436855;7052.788416347517;7478.252174782519;7670.539767613933;9347.29895257855;9661.323707340489;9502.192313653313;9673.322867399285;9679.854802177973;9693.757656058584;9698.903010969905;9886.060824221688;10040.598376064985;10046.648367307145;10050.54772535234;10051;6859.691313890862;9354.953225233865;9595.952020239854;9602.471864047475;9608.951955240249;9709.805803883954;9856.162226210781;9875.209983201326;9882.308238423313;9896.55465504054;35022.82488587566;35496.46755298672;35574.82212588946;35698.8215058923;35709.64290357115;2870.942581148365;2910.6798252192452;2953.350262942171;3236.8057916525086;3552.8401221945073;27709;28002.299942501395;28009.879188240186;28048.29879253035;28405.57391639127;3340.2150494633743;3376.57792775903;3410.2667926395943;3456.4988076728987;3488.075659950115;192756;193465;193466;193973;194873;31617.36765264682;32064.198395040312;50359.74820125876;50658;50711;32969.17577060593;33002.83498582492;33104.83447582747;33108.83445582805;33128.50307245393;9899.703008909744;11763.117766167572;11815.645530634094;11854.644360669194;11866.34735089561;9566.378185417925;9744.12302892743;9754.951225243829;9757.560909759079;9757.658481953098;7639.503432276884;7649.38804895607;7749.380049596019;7752.728654497066;7758.650860711282;2980.1208643450236;3139.042592009459;3155.763317751178;3160.6365267994015;3187.6971687689634;834.0741776627938;878.508035500122;893.84357737397;919.2829592917535;1000.6397696829135;27020.864895675397;27679.584806227922;27691;27963;28018.2995425116;1026.7535791410007;1038.5638032026568;1074.237291523012;1089.0742868561817;1093.2456604942722;14410.495632652806;14416.567502974927;14474.565763027125;14720.852791472162;14905.627359316104;272889;277007;277941;278249;278520;46564.534354656695;47406.52593474021;47562.52437475581;47597.76201118972;47666.523334766905;1039.3971496531992;1174.2074099982478;1194.307301764957;1240.7580521798163;1257.0697683714168;24522.63216051725;25109.74890251147;25310.74689253084;25526.48947021012;26936.86531567408;35765.28469430649;36322.091947700465;36501.269974599825;36715.44926826046;36807.26385472329;204287;208141;208905;209028;209802;18227.088645567404;18541;18627.627447451247;18640.254389824255;22464.77535224627;37940.62059379371;38768.80615597017;39486;40230.798846005586;40494.59505405026;33408.1647958803;33872;34377.53092098011;34430.82784586061;34547.82726086454;33527.497087544194;33983.660163398046;34237.14407139841;34537.65462345445;34695.306093878484;33907.83046084754;34499;34754;35078.47382289216;35184;30014.399712006074;30333.848330758206;30878.53682194814;31207.375852482368;31264;23336.430205492237;23585.29244122679;23954.52090958206;24128.87935560381;24373.878130609944 07:29:13 INFO - PROCESS | 7157 | |2;jquery.html;375.14467015205327;385.38723429746705;388.9066624010235;389.851856294608;391.89418856908634;10144.391336519813;10735.302205356666;10736.78526429471;10738.409387483685;15169.772453413194;15397.614214720674;15576.143312117829;17535.82464175361;17683.381081662144;17700.822991770077;5023.748812559375;5659.292588426447;5898.056310990242;5901.852453688649;5903.3211180714125;5746.597738158331;5927.347991720907;5928.40715928408;5930.762769489215;5937.406259374071;6552.475801935833;6875.553089049221;6898.1377327834025;6903.930960690404;6906.75826346078;6759.256481787;6788.966055169742;6854.074699915523;6893.827654308632;6927.064846245793;6530.726508330878;6700.162479690039;6706.631135287557;6716.597004179765;6746.966265168692;20370;20805.479863003548;21435.356939291847;21462.89268553663;22438;1889.8393636540911;2000.839932805372;2238.473958619723;2342.2036507587504;2433.6471211674207;12393.752124957451;12566.30885301308;12611.117221794479;13056.086073974826;13239.338033098307;1791.08654586162;1811.7554130192386;1865.8693891427606;1896.8713615398954;1902.8192321729553;68062.65968670175;71292;71533.64233178853;71809.2819071813;72112.27887721108;15733.246681830633;15750.9212453937;15802.762958555631;16085.793565482401;16109.597260068593;28172.43655126886;28361.29096772597;28514.857425713155;28539.429211415656;28616.856915715704;8170.403411212143;8606;8649.91350086491;8783.25342345895;8804.735857924272;7076.787696369117;7138.571685698875;7204.495685302083;7241.746538871114;7246.746363877239;8119.228673276029;8288.378371622153;8399.95800020996;8500.83228776658;8503.404761666625;3167.588213532226;3296.583234008731;3401.8639254429545;3467.289205712823;3571.142925697866;690.3855568544;766.9156392796788;772.1352085664092;790.0795573157322;844.4806444036996;14754.188519631523;15117.924410377878;15136.924315378352;15250.542483725507;15379.61550961235;777.9222077792175;784.9686012559433;790.213737331359;827.9420440569223;845.6321500147455;8494.872576911352;8846.380753347205;8863.64545418176;8955;8978.595963181542;356278;358522;361673;361768;366589;65625;65834.34165658282;67048.6647566759;67413.32586674168;68871.49028077742;930.0745757970863;933.1042199488431;953.9427634341962;978.2907392140784;980.7989362180735;14188.645283867985;14253.572392828231;14287.64280892986;14360.425582976564;14688.192149431883;32057.67942320547;32185.839070804497;32302;32678;32791.34417311688;41521.37717934294;43065;43673.56326436695;43889.47449930391;43892.341614876445;7411.777646670608;7501.962490187732;7771.057235691077;7878.330341921001;7990.440669153103;11069.335839849635;11103.833442498208;11170.664880053611;11583.015443687382;11802.763944720886;9904.356216845881;10006.549705263134;10334.638287659896;10361.63734269297;10471.3193642413;9354.859677104985;9670.613175473183;9787.657431989846;10010.098081364518;10450.895491044992;9904.405735655884;10314.845277320996;10548.472576371305;10736.516856741622;10782.622608208674;7784.92215077842;7864.84270314602;7868.763937081897;7946.404019698662;7956.12482626899;10063.949680251551;10390.324628899098;10501.107405870282;10569.947150264199;10606.204534659777 07:29:13 INFO - PROCESS | 7157 | |3;mootools.html;1135.8239472881705;1226.1662069792544;1227.2145826670928;1288.4874494735266;1461.9049761765484;5987;7230.638468076595;7461.253874612536;7462.514936529122;7463.962680186598;7000.264972177924;7163.176234732994;7163.355298023177;7166.5700057996555;7167.175774785901;2170.630992731232;2203.206845535614;2204.6252137136644;2204.90077946492;2205.503761653631;2089.8641588296787;2141.892905354734;2153.827693784501;2154.5906277807167;2182.3671135370723;2161.729783777028;2168.56628674265;2182.1925887421676;2183.7816218378116;2205.184081889695;2087.728595282611;2104.8947552622385;2104.95790084199;2105.084288334564;2105.3894370632497;2034.267663641103;2080.44868109951;2081.937541873731;2083.656196727538;2088.3421722157623;7311.451641126883;7388.150362708304;7470.925290747077;7471.626418679044;7477.364424023965;4352.651787856964;4508.391367165424;4523.7285762854335;4527.569880861346;4534.02518458533;2732.9863350683318;2844.4737723521007;2890.85545722713;2901.144162472076;2907.9273018174713;857.7555396711907;858.8282343531256;867.4968518259394;882.1311008656468;887.7292425810125;9406.153446189808;9465.337426380087;9479.431234125974;9498.525073746285;9504.04959504051;3844.615538446189;3898.3567711327314;3963.1875465529497;3972.7219094663096;3975.383815508601;7488.9625551871895;7678.769636910902;7703.229677032252;7718.421118416141;7729.690812367442;4185.665146788249;4186.28833098374;4186.979065104655;4189.853355132555;4192.413062171298;3424.178197232646;3859.421086836941;3904.316744569689;3972.1857019310974;3998;3307.801531908045;3314.1880239341517;3384.1370450534955;3390.559227300435;3407.693307602328;988.461288597716;1056.746380868586;1061.6125114333367;1064.755106325534;1065.8294672852462;591.5385998920849;705.8411857332162;709.4147328454046;748.3451979517922;848.0755975986204;4785.042991401733;4924.3105965164905;5084.211947148124;5112.9744351278005;5203.219517072469;448.44616898130784;450.1312466938774;455.24883941496137;462.4820201374482;603.9672160605414;3327.8169700666695;3471.0801637566065;3474.1488335358;3494.7378946579106;3592.0660628236847;8742.650293988168;9152.679656212;9270.72187834366;9290.349675522648;9297.814043719087;9097.40866843653;9130.452172869649;9174.449533027906;9198.586063627154;9199.310051746146;6937.132858392701;7012.193597736224;7079.964600176966;7085.645717714094;7100.46746494015;4789.9042019160115;4895.7062576245535;4905.90188196227;4940.456549779593;4957.330760347307;8148.348132149533;8156.265936065783;8350.62422191015;8368.24685778283;8459.450135741157;8499.405041647025;8580.05619381855;8595.140485951355;8631.093735157718;8698.739037828875;5321.361436627474;5935.821925342247;6059;6122.755089796358;6135.294441139147;7038.472114591324;7099.325564071405;7103.360697537247;7104.18301895268;7117.893231601426;6066.817995460143;6204.751809927552;6234.189555357774;6280.8429789253805;6337.588056776479;6263.123162757309;6390;6406.199225096863;6485.870282594227;6527.934720652733;6002.969985150046;6156.199694039746;6197.566170368212;6201.255849298113;6204.658743769136;4161.188568229288;4178.519470260837;4232.534421213602;4249.051328140627;4319.308910574293;4508.256137737237;4551.613112885442;4564.77176141185;4581.702189357681;4633.166030114477 07:29:13 INFO - PROCESS | 7157 | |4;prototype.html;294.82605262894896;295.6363672682601;299.4475193268419;318.73385722921347;320.82194382117945;4614.907701845961;4676.620396982889;4716.292556116584;4741.93306506036;4768.403949506312;4692.671512994092;4718.136336147229;4720.291956206571;4728.1962066448705;4734.455537613176;3542.36237477254;3563.910902227452;3666.7616604920727;3720.5535335759746;3764.3788774852114;3745.681617062553;3752.4558938953837;3755.568109667382;3761.13493896404;3769.943450848226;3498.9300213995707;3715.349813782591;3718.0890681783003;3718.7582807117587;3737.1965027519077;3599.406097993841;3710.591834898159;3725.329440700673;3733.2533493301175;3743.7940913249895;3321.618013928381;3330.4837750148768;3333.4833100869405;3342.6490218526947;3360.5295258663805;4516.209663308908;4517.096580683877;4521.434820647419;4521.59305662492;4538.160440318518;4062.7968601569805;4266.189424009459;4269.167512335096;4294.506131794852;4302.870913872589;4920.188168952119;4938.209886418192;4940.28365886948;4950.257461380822;4973.477784832613;3641.6904563112166;3649.996251030961;3650.2699460108083;3677.0991107178643;3685.1892583631557;4977.900441991176;5118.948810511884;5135.922961155586;5204.869878253036;5223.369758018179;3686.7234957378305;3696.7966761828357;3703.2408356287438;3703.5555733312176;3725.1432170600915;3773.396256598931;3776.4712940188397;3783;3802.3535998880257;3805.3150432921784;4241.915161696748;4245.978770106191;4248.553901840324;4251.5748425157235;4273.572642735764;4842.249451335048;4917.139500587455;4955.306257124005;4956.900861982812;5019.648624596316;1360.6462319796924;1362.6184668292894;1372.61566761307;1375.2229990055587;1378.9310534473236;890.1543533643065;939.1922946266205;939.5724945150077;947.2232769129248;951.1344676344494;4625.699329543569;4626.398568186181;4653.557911998355;4660.231061874821;4661.091087237956;5380.91928621071;5389.056915039852;5393.114683644231;5401.432849550819;5401.540869026098;4481.148581769454;4650.255959046604;4654.743989080633;4656.371389862393;4662.440507139165;2829.221963959886;2837.7156389106553;2841.962683620505;2852.985735071353;2876.7267109624554;5028.64799464034;5035.672681275779;5039.647224694236;5040.495950405004;5080.77136528857;5250.556097073335;5405.243265942771;5444.101723215705;5447.346318441812;5456.809011684572;5021.874453138701;5023.120953833138;5028.296038554606;5030.547250747451;5054.393472783289;5196.116660167856;5244.134717771678;5259.973700131475;5279.10255256615;5293.100172970681;5033.798648054037;5227.294315267391;5230.7384630769075;5237.502437268454;5249.658772179796;5024.743814046488;5032.421271553671;5049.166887463674;5054.494550544916;5069.721165335942;3835.7890316032885;3851.383778595411;3856.382978723391;3857.826397812049;3865.2849222893856;5175.378954525481;5212.047681753281;5240.947590524046;5263.578913686973;5267.60492963037;5054.393472783289;5095.617828662791;5096.592272618108;5100.6429549931145;5135.794568217229;5117.334746482933;5132.640715149903;5133.614978876524;5136.101182293159;5151.7166555839785;4672.205725026822;4688.601468875184;4765.523447655207;4900.92648610264;4914.238293064581;4990.251462280542;4990.426100998432;4995.17579599362;5001.324556273689;5023.949760502348;4907.190313598217;4912.828051018198;4929.285253638131;4929.654924155275;4937.407511098691 07:29:13 INFO - PROCESS | 7157 | |5;yui.html;706.9010338552604;727.1201845766623;765.1583258415743;769.7036640893258;784.3019712455919;13576.117552359103;14029.859701402984;14055;14078.366473508691;14087.29563521825;11449.885501144987;11478.770424591525;11493.942530287337;11509.194356395055;11553.884461155387;513.9614528910328;800.6037011679227;810.6878851642116;818.8239528501371;819.81554150316;814.5601375257354;817.0399780258202;817.8159914019358;818.7134502923959;818.97133600324;707.3457052226695;712.657924196386;712.9500934934557;714.2250658036011;714.4463041143104;576.9278840144982;709.14902117459;709.6026225313841;824.2993455562784;850.2645211891731;619.0837560410572;619.2259675405743;619.5446346934999;619.683961179797;620.2494981072862;12320.938395308056;12355.814662780065;12381.876181238162;12388.070894682935;12390.62828115158;11087.889121108847;11533.192676512648;11672.649820505398;11690.357030363326;11891.464884080151;9416.1525462708;9598.232141428669;9694.17599504043;9825.606975720963;9844.60621575136;3255.788373755698;3258.413485572596;3285.0801775502896;3311.4701647736247;3314.767966242364;42753.78623106896;44083.338749918774;44249;44282;44382.11235775299;9564.856527152098;9800.31397802147;9835.901640983642;9871.358361706467;9974.551145198484;16861.91569042147;16902.83097169037;16921.069341186354;16951.576210594587;17043.062631555134;6285.340039295899;6302.905456418157;6423.74305027803;6437.517186211053;6446.033095035782;3441.690247877703;3568.1436455251073;3611.2777444511203;3621.619729928372;3681.8586238266225;2667.7999150063824;2741.465414244203;2744.19046381318;2758.1311886755607;2759.6274502942247;497.80585571627097;503.32051730164716;505.3935277666815;509.6330641937799;523.5549782684687;486.73716193255245;538.7888186408968;544.923710680505;562.8395907166438;577.053632043449;8041.3164880984605;8202.917970820215;8300.875486867702;8310.792230194293;8505.872411913826;475.40099474662173;485.25513337027496;574.3825387708231;577.711144427786;595.3094410483818;3371.4268574342423;3596.9280614387567;3597.982010089933;3692.372296709566;3711.31340701971;52042.73978630082;53681;53820.73089634527;53851;53932.46067539353;44958.77520612442;46586.76706616445;47044.5295547047;47409;48364.27453588199;42942.78528607337;43360.13279734451;43526.34710479345;44338.556614433444;44545.331820022075;7210.351068403869;7370.520916140434;7452.627368631438;7460.850782984418;7462.701491940262;28848.567271490523;29701;29748;30068.920347132356;30076.699233007388;38127;39682.603173969044;39828.20343593054;40228.1954360917;40410.595894040685;9415.717528474157;9514.952425237829;9570.47362395075;9594.856077158987;9614.423134611945;10336.741581460523;10597.788044239227;10655.520501577603;10716.517756701123;11097.667069987914;8529.786755331166;9791.559379827782;10087.29388942767;10523.78952420932;10660.89339106599;10941.234113612289;10994.615188468366;11102.44487775592;11309.773804523698;11570;10678.199135064746;10695.358278503314;10816.459177041274;10834.945825270823;11022.338659680445;9313.487758173365;9327.906720932704;9417.717468475958;9567.473788941676;9678.903210967801;8948.73153805387;9366.297527685587;9408.43549387039;9504.144626983605;9674.516274186404 07:29:13 INFO - PROCESS | 7157 | __end_tp_report 07:29:13 INFO - PROCESS | 7157 | __start_cc_report 07:29:13 INFO - PROCESS | 7157 | _x_x_mozilla_cycle_collect,981 07:29:13 INFO - PROCESS | 7157 | __end_cc_report 07:29:13 INFO - PROCESS | 7157 | __startTimestamp1461680953239__endTimestamp 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | ------- Summary: start ------- 07:29:13 INFO - PROCESS | 7157 | Number of tests: 6 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | [#0] dojo.html Cycles:165 Average:4544.23 Median:4677.18 stddev:455.34 (9.7%) stddev-sans-first:430.00 07:29:13 INFO - PROCESS | 7157 | Values: 2584.3 2632.7 2645.0 2649.9 2675.0 4496.8 4561.7 4575.9 4578.7 4587.2 4533.3 4537.7 4545.5 4666.5 4717.0 4195.2 4196.9 4239.8 4266.7 4276.0 4260.1 4285.8 4329.0 4330.8 4334.0 4098.0 4188.7 4188.9 4230.6 4285.6 4168.5 4179.9 4186.4 4192.1 4193.3 4204.3 4254.1 4259.6 4275.9 4309.9 4473.3 4484.6 4506.8 4529.3 4573.7 4798.5 4894.2 4929.1 4939.8 4941.1 4940.0 4954.2 4957.5 4968.8 5020.3 4591.3 4602.4 4605.2 4607.4 4631.9 4834.0 4895.5 4991.5 5043.1 5069.7 4863.5 4885.2 4888.4 4890.6 4910.5 4962.5 4963.3 4964.6 4971.4 5001.8 4738.8 4828.4 4917.6 4925.9 4926.4 4853.9 4854.4 4872.5 4873.7 4926.7 4237.9 4242.8 4245.3 4252.8 4286.3 3622.9 3676.8 3708.9 3754.0 3788.4 4285.9 4291.4 4304.2 4309.4 4352.5 4954.2 4954.5 4954.6 4955.1 4992.1 4181.3 4260.6 4289.2 4319.2 4332.0 4373.6 4388.9 4397.8 4434.2 4437.5 4550.4 4596.3 4603.4 4604.1 4605.0 4834.0 4915.9 4916.5 4944.8 4969.6 4691.7 4709.0 4710.2 4711.9 4744.2 4644.0 4743.3 4867.6 4870.4 4919.9 4796.3 4816.2 4821.0 4854.2 4869.7 4709.1 4711.1 4711.9 4756.4 4760.1 4475.1 4699.4 4708.6 4719.2 4776.1 4677.2 4709.8 4710.2 4738.4 4760.0 4783.5 4791.1 4800.3 4810.1 4841.6 4578.9 4685.4 4731.2 4763.8 4775.4 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | [#1] ext.html Cycles:180 Average:37151.55 Median:18359.86 stddev:59745.50 (325.4%) stddev-sans-first:59849.97 07:29:13 INFO - PROCESS | 7157 | Values: 571.6 588.4 597.3 605.4 614.6 23051.5 28977.0 29470.0 29542.6 29644.1 33379.5 34260.5 34312.8 34355.8 34368.7 7052.8 7478.3 7670.5 9347.3 9661.3 9502.2 9673.3 9679.9 9693.8 9698.9 9886.1 10040.6 10046.6 10050.5 10051.0 6859.7 9355.0 9596.0 9602.5 9609.0 9709.8 9856.2 9875.2 9882.3 9896.6 35022.8 35496.5 35574.8 35698.8 35709.6 2870.9 2910.7 2953.4 3236.8 3552.8 27709.0 28002.3 28009.9 28048.3 28405.6 3340.2 3376.6 3410.3 3456.5 3488.1 192756.0 193465.0 193466.0 193973.0 194873.0 31617.4 32064.2 50359.7 50658.0 50711.0 32969.2 33002.8 33104.8 33108.8 33128.5 9899.7 11763.1 11815.6 11854.6 11866.3 9566.4 9744.1 9755.0 9757.6 9757.7 7639.5 7649.4 7749.4 7752.7 7758.7 2980.1 3139.0 3155.8 3160.6 3187.7 834.1 878.5 893.8 919.3 1000.6 27020.9 27679.6 27691.0 27963.0 28018.3 1026.8 1038.6 1074.2 1089.1 1093.2 14410.5 14416.6 14474.6 14720.9 14905.6 272889.0 277007.0 277941.0 278249.0 278520.0 46564.5 47406.5 47562.5 47597.8 47666.5 1039.4 1174.2 1194.3 1240.8 1257.1 24522.6 25109.7 25310.7 25526.5 26936.9 35765.3 36322.1 36501.3 36715.4 36807.3 204287.0 208141.0 208905.0 209028.0 209802.0 18227.1 18541.0 18627.6 18640.3 22464.8 37940.6 38768.8 39486.0 40230.8 40494.6 33408.2 33872.0 34377.5 34430.8 34547.8 33527.5 33983.7 34237.1 34537.7 34695.3 33907.8 34499.0 34754.0 35078.5 35184.0 30014.4 30333.8 30878.5 31207.4 31264.0 23336.4 23585.3 23954.5 24128.9 24373.9 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | [#2] jquery.html Cycles:180 Average:23716.85 Median:42293.19 stddev:59373.62 (140.4%) stddev-sans-first:59514.31 07:29:13 INFO - PROCESS | 7157 | Values: 375.1 385.4 388.9 389.9 391.9 10144.4 10735.3 10736.8 10738.4 15169.8 15397.6 15576.1 17535.8 17683.4 17700.8 5023.7 5659.3 5898.1 5901.9 5903.3 5746.6 5927.3 5928.4 5930.8 5937.4 6552.5 6875.6 6898.1 6903.9 6906.8 6759.3 6789.0 6854.1 6893.8 6927.1 6530.7 6700.2 6706.6 6716.6 6747.0 20370.0 20805.5 21435.4 21462.9 22438.0 1889.8 2000.8 2238.5 2342.2 2433.6 12393.8 12566.3 12611.1 13056.1 13239.3 1791.1 1811.8 1865.9 1896.9 1902.8 68062.7 71292.0 71533.6 71809.3 72112.3 15733.2 15750.9 15802.8 16085.8 16109.6 28172.4 28361.3 28514.9 28539.4 28616.9 8170.4 8606.0 8649.9 8783.3 8804.7 7076.8 7138.6 7204.5 7241.7 7246.7 8119.2 8288.4 8400.0 8500.8 8503.4 3167.6 3296.6 3401.9 3467.3 3571.1 690.4 766.9 772.1 790.1 844.5 14754.2 15117.9 15136.9 15250.5 15379.6 777.9 785.0 790.2 827.9 845.6 8494.9 8846.4 8863.6 8955.0 8978.6 356278.0 358522.0 361673.0 361768.0 366589.0 65625.0 65834.3 67048.7 67413.3 68871.5 930.1 933.1 953.9 978.3 980.8 14188.6 14253.6 14287.6 14360.4 14688.2 32057.7 32185.8 32302.0 32678.0 32791.3 41521.4 43065.0 43673.6 43889.5 43892.3 7411.8 7502.0 7771.1 7878.3 7990.4 11069.3 11103.8 11170.7 11583.0 11802.8 9904.4 10006.5 10334.6 10361.6 10471.3 9354.9 9670.6 9787.7 10010.1 10450.9 9904.4 10314.8 10548.5 10736.5 10782.6 7784.9 7864.8 7868.8 7946.4 7956.1 10063.9 10390.3 10501.1 10569.9 10606.2 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | [#3] mootools.html Cycles:180 Average:4799.87 Median:5098.59 stddev:2662.98 (52.2%) stddev-sans-first:2656.21 07:29:13 INFO - PROCESS | 7157 | Values: 1135.8 1226.2 1227.2 1288.5 1461.9 5987.0 7230.6 7461.3 7462.5 7464.0 7000.3 7163.2 7163.4 7166.6 7167.2 2170.6 2203.2 2204.6 2204.9 2205.5 2089.9 2141.9 2153.8 2154.6 2182.4 2161.7 2168.6 2182.2 2183.8 2205.2 2087.7 2104.9 2105.0 2105.1 2105.4 2034.3 2080.4 2081.9 2083.7 2088.3 7311.5 7388.2 7470.9 7471.6 7477.4 4352.7 4508.4 4523.7 4527.6 4534.0 2733.0 2844.5 2890.9 2901.1 2907.9 857.8 858.8 867.5 882.1 887.7 9406.2 9465.3 9479.4 9498.5 9504.0 3844.6 3898.4 3963.2 3972.7 3975.4 7489.0 7678.8 7703.2 7718.4 7729.7 4185.7 4186.3 4187.0 4189.9 4192.4 3424.2 3859.4 3904.3 3972.2 3998.0 3307.8 3314.2 3384.1 3390.6 3407.7 988.5 1056.7 1061.6 1064.8 1065.8 591.5 705.8 709.4 748.3 848.1 4785.0 4924.3 5084.2 5113.0 5203.2 448.4 450.1 455.2 462.5 604.0 3327.8 3471.1 3474.1 3494.7 3592.1 8742.7 9152.7 9270.7 9290.3 9297.8 9097.4 9130.5 9174.4 9198.6 9199.3 6937.1 7012.2 7080.0 7085.6 7100.5 4789.9 4895.7 4905.9 4940.5 4957.3 8148.3 8156.3 8350.6 8368.2 8459.5 8499.4 8580.1 8595.1 8631.1 8698.7 5321.4 5935.8 6059.0 6122.8 6135.3 7038.5 7099.3 7103.4 7104.2 7117.9 6066.8 6204.8 6234.2 6280.8 6337.6 6263.1 6390.0 6406.2 6485.9 6527.9 6003.0 6156.2 6197.6 6201.3 6204.7 4161.2 4178.5 4232.5 4249.1 4319.3 4508.3 4551.6 4564.8 4581.7 4633.2 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | [#4] prototype.html Cycles:180 Average:4218.02 Median:4717.21 stddev:1212.61 (25.7%) stddev-sans-first:1179.71 07:29:13 INFO - PROCESS | 7157 | Values: 294.8 295.6 299.4 318.7 320.8 4614.9 4676.6 4716.3 4741.9 4768.4 4692.7 4718.1 4720.3 4728.2 4734.5 3542.4 3563.9 3666.8 3720.6 3764.4 3745.7 3752.5 3755.6 3761.1 3769.9 3498.9 3715.3 3718.1 3718.8 3737.2 3599.4 3710.6 3725.3 3733.3 3743.8 3321.6 3330.5 3333.5 3342.6 3360.5 4516.2 4517.1 4521.4 4521.6 4538.2 4062.8 4266.2 4269.2 4294.5 4302.9 4920.2 4938.2 4940.3 4950.3 4973.5 3641.7 3650.0 3650.3 3677.1 3685.2 4977.9 5118.9 5135.9 5204.9 5223.4 3686.7 3696.8 3703.2 3703.6 3725.1 3773.4 3776.5 3783.0 3802.4 3805.3 4241.9 4246.0 4248.6 4251.6 4273.6 4842.2 4917.1 4955.3 4956.9 5019.6 1360.6 1362.6 1372.6 1375.2 1378.9 890.2 939.2 939.6 947.2 951.1 4625.7 4626.4 4653.6 4660.2 4661.1 5380.9 5389.1 5393.1 5401.4 5401.5 4481.1 4650.3 4654.7 4656.4 4662.4 2829.2 2837.7 2842.0 2853.0 2876.7 5028.6 5035.7 5039.6 5040.5 5080.8 5250.6 5405.2 5444.1 5447.3 5456.8 5021.9 5023.1 5028.3 5030.5 5054.4 5196.1 5244.1 5260.0 5279.1 5293.1 5033.8 5227.3 5230.7 5237.5 5249.7 5024.7 5032.4 5049.2 5054.5 5069.7 3835.8 3851.4 3856.4 3857.8 3865.3 5175.4 5212.0 5240.9 5263.6 5267.6 5054.4 5095.6 5096.6 5100.6 5135.8 5117.3 5132.6 5133.6 5136.1 5151.7 4672.2 4688.6 4765.5 4900.9 4914.2 4990.3 4990.4 4995.2 5001.3 5023.9 4907.2 4912.8 4929.3 4929.7 4937.4 07:29:13 INFO - PROCESS | 7157 | 07:29:13 INFO - PROCESS | 7157 | [#5] yui.html Cycles:180 Average:12649.91 Median:492.27 stddev:14593.08 (2964.4%) stddev-sans-first:14606.45 07:29:13 INFO - PROCESS | 7157 | Values: 706.9 727.1 765.2 769.7 784.3 13576.1 14029.9 14055.0 14078.4 14087.3 11449.9 11478.8 11493.9 11509.2 11553.9 514.0 800.6 810.7 818.8 819.8 814.6 817.0 817.8 818.7 819.0 707.3 712.7 713.0 714.2 714.4 576.9 709.1 709.6 824.3 850.3 619.1 619.2 619.5 619.7 620.2 12320.9 12355.8 12381.9 12388.1 12390.6 11087.9 11533.2 11672.6 11690.4 11891.5 9416.2 9598.2 9694.2 9825.6 9844.6 3255.8 3258.4 3285.1 3311.5 3314.8 42753.8 44083.3 44249.0 44282.0 44382.1 9564.9 9800.3 9835.9 9871.4 9974.6 16861.9 16902.8 16921.1 16951.6 17043.1 6285.3 6302.9 6423.7 6437.5 6446.0 3441.7 3568.1 3611.3 3621.6 3681.9 2667.8 2741.5 2744.2 2758.1 2759.6 497.8 503.3 505.4 509.6 523.6 486.7 538.8 544.9 562.8 577.1 8041.3 8202.9 8300.9 8310.8 8505.9 475.4 485.3 574.4 577.7 595.3 3371.4 3596.9 3598.0 3692.4 3711.3 52042.7 53681.0 53820.7 53851.0 53932.5 44958.8 46586.8 47044.5 47409.0 48364.3 42942.8 43360.1 43526.3 44338.6 44545.3 7210.4 7370.5 7452.6 7460.9 7462.7 28848.6 29701.0 29748.0 30068.9 30076.7 38127.0 39682.6 39828.2 40228.2 40410.6 9415.7 9515.0 9570.5 9594.9 9614.4 10336.7 10597.8 10655.5 10716.5 11097.7 8529.8 9791.6 10087.3 10523.8 10660.9 10941.2 10994.6 11102.4 11309.8 11570.0 10678.2 10695.4 10816.5 10834.9 11022.3 9313.5 9327.9 9417.7 9567.5 9678.9 8948.7 9366.3 9408.4 9504.1 9674.5 07:29:13 INFO - PROCESS | 7157 | -------- Summary: end -------- 07:29:13 INFO - PROCESS | 7157 | 07:29:14 INFO - TEST-INFO | 7157: exit 0 07:29:14 INFO - TEST-OK | dromaeo_css | took 1117670ms 07:29:14 INFO - TEST-START | kraken 07:29:14 INFO - operating with platform_type : linux_ 07:29:14 INFO - Initialising browser for kraken test... 07:29:14 INFO - TEST-INFO | started process 7332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphlc7LY/profile http://localhost:51409/getInfo.html) 07:29:18 INFO - PROCESS | 7332 | __metrics Screen width/height:1600/1200 07:29:18 INFO - PROCESS | 7332 | colorDepth:24 07:29:18 INFO - PROCESS | 7332 | Browser inner width/height: 1024/697 07:29:18 INFO - PROCESS | 7332 | __metrics 07:29:18 ERROR - PROCESS | 7332 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:29:19 INFO - TEST-INFO | 7332: exit 0 07:29:19 INFO - Browser initialized. 07:29:19 INFO - Running cycle 1/1 for kraken test... 07:29:19 INFO - TEST-INFO | started process 7418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphlc7LY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:31 INFO - PROCESS | 7418 | RSS: Main: 155893760 07:29:31 INFO - PROCESS | 7418 | 07:29:34 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:35 INFO - PROCESS | 7418 | RSS: Main: 211251200 07:29:35 INFO - PROCESS | 7418 | 07:29:38 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-dft) 07:29:38 INFO - PROCESS | 7418 | RSS: Main: 196395008 07:29:38 INFO - PROCESS | 7418 | 07:29:42 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-fft) 07:29:42 INFO - PROCESS | 7418 | RSS: Main: 267341824 07:29:42 INFO - PROCESS | 7418 | 07:29:44 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-oscillator) 07:29:45 INFO - PROCESS | 7418 | RSS: Main: 175230976 07:29:45 INFO - PROCESS | 7418 | 07:29:47 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:48 INFO - PROCESS | 7418 | RSS: Main: 178855936 07:29:48 INFO - PROCESS | 7418 | 07:29:51 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51409/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:51 INFO - PROCESS | 7418 | RSS: Main: 215969792 07:29:51 INFO - PROCESS | 7418 | 07:29:55 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51409/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:56 INFO - PROCESS | 7418 | RSS: Main: 215359488 07:29:56 INFO - PROCESS | 7418 | 07:29:58 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51409/tests/kraken/driver.html?testName=json-parse-financial) 07:29:59 INFO - PROCESS | 7418 | RSS: Main: 216489984 07:29:59 INFO - PROCESS | 7418 | 07:30:01 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:01 INFO - PROCESS | 7418 | RSS: Main: 201711616 07:30:01 INFO - PROCESS | 7418 | 07:30:03 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:04 INFO - PROCESS | 7418 | RSS: Main: 205840384 07:30:04 INFO - PROCESS | 7418 | 07:30:06 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:07 INFO - PROCESS | 7418 | RSS: Main: 217690112 07:30:07 INFO - PROCESS | 7418 | 07:30:09 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:10 INFO - PROCESS | 7418 | RSS: Main: 225181696 07:30:10 INFO - PROCESS | 7418 | 07:30:13 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:14 INFO - PROCESS | 7418 | RSS: Main: 221220864 07:30:14 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51409/tests/kraken/driver.html?testName=ai-astar) 07:30:16 INFO - PROCESS | 7418 | RSS: Main: 285212672 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | __start_tp_report 07:30:16 INFO - PROCESS | 7418 | _x_x_mozilla_page_load 07:30:16 INFO - PROCESS | 7418 | _x_x_mozilla_page_load_details 07:30:16 INFO - PROCESS | 7418 | |i|pagename|runs| 07:30:16 INFO - PROCESS | 7418 | |0;ai-astar;113;114;110;113;113;113;103;113;115;113 07:30:16 INFO - PROCESS | 7418 | |1;audio-beat-detection;155;132;160;201;132;155;153;141;186;139 07:30:16 INFO - PROCESS | 7418 | |2;audio-dft;159;161;162;162;161;161;161;160;162;160 07:30:16 INFO - PROCESS | 7418 | |3;audio-fft;77;73;111;120;74;73;73;116;102;78 07:30:16 INFO - PROCESS | 7418 | |4;audio-oscillator;95;95;148;95;95;95;146;94;95;142 07:30:16 INFO - PROCESS | 7418 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 07:30:16 INFO - PROCESS | 7418 | |6;imaging-darkroom;146;147;146;146;147;147;146;146;147;146 07:30:16 INFO - PROCESS | 7418 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;94 07:30:16 INFO - PROCESS | 7418 | |8;json-parse-financial;66;66;67;66;66;65;66;91;63;65 07:30:16 INFO - PROCESS | 7418 | |9;json-stringify-tinderbox;64;65;65;65;66;64;65;66;65;65 07:30:16 INFO - PROCESS | 7418 | |10;stanford-crypto-aes;80;77;78;86;80;81;82;80;80;80 07:30:16 INFO - PROCESS | 7418 | |11;stanford-crypto-ccm;136;134;134;134;134;132;136;135;196;143 07:30:16 INFO - PROCESS | 7418 | |12;stanford-crypto-pbkdf2;216;219;220;218;219;221;222;214;213;218 07:30:16 INFO - PROCESS | 7418 | |13;stanford-crypto-sha256-iterative;77;76;74;76;73;76;75;74;72;73 07:30:16 INFO - PROCESS | 7418 | __end_tp_report 07:30:16 INFO - PROCESS | 7418 | __start_cc_report 07:30:16 INFO - PROCESS | 7418 | _x_x_mozilla_cycle_collect,1887 07:30:16 INFO - PROCESS | 7418 | __end_cc_report 07:30:16 INFO - PROCESS | 7418 | __startTimestamp1461681016670__endTimestamp 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | ------- Summary: start ------- 07:30:16 INFO - PROCESS | 7418 | Number of tests: 14 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.40 (3.0%) stddev-sans-first:3.59 07:30:16 INFO - PROCESS | 7418 | Values: 113.0 114.0 110.0 113.0 113.0 113.0 103.0 113.0 115.0 113.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:155.00 stddev:22.64 (14.6%) stddev-sans-first:24.02 07:30:16 INFO - PROCESS | 7418 | Values: 155.0 132.0 160.0 201.0 132.0 155.0 153.0 141.0 186.0 139.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.78 07:30:16 INFO - PROCESS | 7418 | Values: 159.0 161.0 162.0 162.0 161.0 161.0 161.0 160.0 162.0 160.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#3] audio-fft Cycles:10 Average:89.70 Median:73.00 stddev:19.99 (27.4%) stddev-sans-first:20.67 07:30:16 INFO - PROCESS | 7418 | Values: 77.0 73.0 111.0 120.0 74.0 73.0 73.0 116.0 102.0 78.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:24.43 (25.7%) stddev-sans-first:25.30 07:30:16 INFO - PROCESS | 7418 | Values: 95.0 95.0 148.0 95.0 95.0 95.0 146.0 94.0 95.0 142.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:30:16 INFO - PROCESS | 7418 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:30:16 INFO - PROCESS | 7418 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:30:16 INFO - PROCESS | 7418 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:66.00 stddev:8.12 (12.3%) stddev-sans-first:8.57 07:30:16 INFO - PROCESS | 7418 | Values: 66.0 66.0 67.0 66.0 66.0 65.0 66.0 91.0 63.0 65.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 07:30:16 INFO - PROCESS | 7418 | Values: 64.0 65.0 65.0 65.0 66.0 64.0 65.0 66.0 65.0 65.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.41 (3.0%) stddev-sans-first:2.55 07:30:16 INFO - PROCESS | 7418 | Values: 80.0 77.0 78.0 86.0 80.0 81.0 82.0 80.0 80.0 80.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:135.50 stddev:19.41 (14.3%) stddev-sans-first:20.49 07:30:16 INFO - PROCESS | 7418 | Values: 136.0 134.0 134.0 134.0 134.0 132.0 136.0 135.0 196.0 143.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.00 Median:219.00 stddev:2.91 (1.3%) stddev-sans-first:2.99 07:30:16 INFO - PROCESS | 7418 | Values: 216.0 219.0 220.0 218.0 219.0 221.0 222.0 214.0 213.0 218.0 07:30:16 INFO - PROCESS | 7418 | 07:30:16 INFO - PROCESS | 7418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.50 stddev:1.65 (2.2%) stddev-sans-first:1.50 07:30:16 INFO - PROCESS | 7418 | Values: 77.0 76.0 74.0 76.0 73.0 76.0 75.0 74.0 72.0 73.0 07:30:16 INFO - PROCESS | 7418 | -------- Summary: end -------- 07:30:16 INFO - PROCESS | 7418 | 07:30:17 INFO - TEST-INFO | 7418: exit 0 07:30:17 INFO - TEST-OK | kraken | took 63644ms 07:30:17 INFO - SUITE-END | took 1181s 07:30:17 INFO - Completed test suite (00:19:41) 07:30:17 INFO - javascript benchmark 07:30:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.3409930467733, 2632.749888760567, 2644.986775066124, 2649.947001059979, 2675.010246208903, 4496.797644106015, 4561.680682352233, 4575.88560285993, 4578.70238434502, 4587.24310488769, 4533.3426653135275, 4537.705049171802, 4545.522720114382, 4666.533346665332, 4717.009428020111, 4195.160967806436, 4196.853110141138, 4239.830406783725, 4266.7013309068225, 4276.0, 4260.147970405916, 4285.764282964436, 4329.047609525915, 4330.783460826962, 4333.956660433387, 4098.0, 4188.748675079505, 4188.91622167558, 4230.555791641864, 4285.550017248175, 4168.520620128694, 4179.853705120307, 4186.372044193365, 4192.140611174702, 4193.329067349209, 4204.264253755611, 4254.149170165979, 4259.595338442843, 4275.935860962088, 4309.913801723979, 4473.329000649928, 4484.551544845522, 4506.752128632924, 4529.297958816389, 4573.679842411033, 4798.54413830689, 4894.1679914414635, 4929.1374009548545, 4939.8024079036795, 4941.110600091982, 4939.975300123477, 4954.157793175169, 4957.529034741694, 4968.801247950078, 5020.322256495399, 4591.288350305708, 4602.401687780567, 4605.217113090749, 4607.424071991001, 4631.8842028948875, 4833.984863178702, 4895.461499235082, 4991.5258050485145, 5043.067032598908, 5069.695818250917, 4863.537963893425, 4885.2427873679635, 4888.413390393104, 4890.633202509826, 4910.459849416561, 4962.454130045692, 4963.255511673206, 4964.553190212898, 4971.37857767779, 5001.7749201285305, 4738.810447582058, 4828.37231159947, 4917.606591472673, 4925.926111108336, 4926.433460152129, 4853.864299708188, 4854.441739199967, 4872.4883887192045, 4873.707577545359, 4926.704397736147, 4237.851675191354, 4242.787860606957, 4245.320748680197, 4252.787360631956, 4286.271333873249, 3622.945655815165, 3676.816159192083, 3708.9443658345144, 3754.0, 3788.431735239736, 4285.91428171441, 4291.3777502262, 4304.182205380967, 4309.439772829513, 4352.521222665504, 4954.182559877652, 4954.455009948902, 4954.5540901319055, 4955.132851750929, 4992.076465853828, 4181.330987042059, 4260.637845783143, 4289.24938135825, 4319.244132276839, 4331.956680433155, 4373.6282415994365, 4388.890277743082, 4397.758123303249, 4434.2240107981615, 4437.467503899488, 4550.431196100488, 4596.287575425815, 4603.3785438965315, 4604.056168485519, 4604.953950460519, 4833.95166048335, 4915.901681966412, 4916.483769204182, 4944.777485013255, 4969.577585905238, 4691.7184968901975, 4708.964027913854, 4710.152172608963, 4711.858644240679, 4744.240921452689, 4644.047970166175, 4743.288506724019, 4867.561919427269, 4870.4155501340065, 4919.926201107058, 4796.25658023007, 4816.181249187716, 4820.975895120502, 4854.247591623304, 4869.6591238612955, 4709.128811169944, 4711.128441238382, 4711.858644240679, 4756.429228492603, 4760.143174228534, 4475.1273501666865, 4699.3890794197905, 4708.552687494683, 4719.221328480762, 4776.068666609977, 4677.181493238738, 4709.788059537397, 4710.175719249186, 4738.431388233434, 4760.0, 4783.545563171493, 4791.065742180242, 4800.303955926441, 4810.134175848241, 4841.588464980516, 4578.908421831611, 4685.367475390779, 4731.219348807408, 4763.809447622057, 4775.42694876617], "value": 4516.716025830924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.5656101362963, 588.3528119069023, 597.2713289786461, 605.3613437823095, 614.5851550203612, 23051.538969220626, 28977.0, 29470.0, 29542.556861647092, 29644.110676679735, 33379.49930751041, 34260.48609270863, 34312.82843585779, 34355.82822085886, 34368.656313436855, 7052.788416347517, 7478.252174782519, 7670.539767613933, 9347.29895257855, 9661.323707340489, 9502.192313653313, 9673.322867399285, 9679.854802177973, 9693.757656058584, 9698.903010969905, 9886.060824221688, 10040.598376064985, 10046.648367307145, 10050.54772535234, 10051.0, 6859.691313890862, 9354.953225233865, 9595.952020239854, 9602.471864047475, 9608.951955240249, 9709.805803883954, 9856.162226210781, 9875.209983201326, 9882.308238423313, 9896.55465504054, 35022.82488587566, 35496.46755298672, 35574.82212588946, 35698.8215058923, 35709.64290357115, 2870.942581148365, 2910.6798252192452, 2953.350262942171, 3236.8057916525086, 3552.8401221945073, 27709.0, 28002.299942501395, 28009.879188240186, 28048.29879253035, 28405.57391639127, 3340.2150494633743, 3376.57792775903, 3410.2667926395943, 3456.4988076728987, 3488.075659950115, 192756.0, 193465.0, 193466.0, 193973.0, 194873.0, 31617.36765264682, 32064.198395040312, 50359.74820125876, 50658.0, 50711.0, 32969.17577060593, 33002.83498582492, 33104.83447582747, 33108.83445582805, 33128.50307245393, 9899.703008909744, 11763.117766167572, 11815.645530634094, 11854.644360669194, 11866.34735089561, 9566.378185417925, 9744.12302892743, 9754.951225243829, 9757.560909759079, 9757.658481953098, 7639.503432276884, 7649.38804895607, 7749.380049596019, 7752.728654497066, 7758.650860711282, 2980.1208643450236, 3139.042592009459, 3155.763317751178, 3160.6365267994015, 3187.6971687689634, 834.0741776627938, 878.508035500122, 893.84357737397, 919.2829592917535, 1000.6397696829135, 27020.864895675397, 27679.584806227922, 27691.0, 27963.0, 28018.2995425116, 1026.7535791410007, 1038.5638032026568, 1074.237291523012, 1089.0742868561817, 1093.2456604942722, 14410.495632652806, 14416.567502974927, 14474.565763027125, 14720.852791472162, 14905.627359316104, 272889.0, 277007.0, 277941.0, 278249.0, 278520.0, 46564.534354656695, 47406.52593474021, 47562.52437475581, 47597.76201118972, 47666.523334766905, 1039.3971496531992, 1174.2074099982478, 1194.307301764957, 1240.7580521798163, 1257.0697683714168, 24522.63216051725, 25109.74890251147, 25310.74689253084, 25526.48947021012, 26936.86531567408, 35765.28469430649, 36322.091947700465, 36501.269974599825, 36715.44926826046, 36807.26385472329, 204287.0, 208141.0, 208905.0, 209028.0, 209802.0, 18227.088645567404, 18541.0, 18627.627447451247, 18640.254389824255, 22464.77535224627, 37940.62059379371, 38768.80615597017, 39486.0, 40230.798846005586, 40494.59505405026, 33408.1647958803, 33872.0, 34377.53092098011, 34430.82784586061, 34547.82726086454, 33527.497087544194, 33983.660163398046, 34237.14407139841, 34537.65462345445, 34695.306093878484, 33907.83046084754, 34499.0, 34754.0, 35078.47382289216, 35184.0, 30014.399712006074, 30333.848330758206, 30878.53682194814, 31207.375852482368, 31264.0, 23336.430205492237, 23585.29244122679, 23954.52090958206, 24128.87935560381, 24373.878130609944], "value": 15567.049177983792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.14467015205327, 385.38723429746705, 388.9066624010235, 389.851856294608, 391.89418856908634, 10144.391336519813, 10735.302205356666, 10736.78526429471, 10738.409387483685, 15169.772453413194, 15397.614214720674, 15576.143312117829, 17535.82464175361, 17683.381081662144, 17700.822991770077, 5023.748812559375, 5659.292588426447, 5898.056310990242, 5901.852453688649, 5903.3211180714125, 5746.597738158331, 5927.347991720907, 5928.40715928408, 5930.762769489215, 5937.406259374071, 6552.475801935833, 6875.553089049221, 6898.1377327834025, 6903.930960690404, 6906.75826346078, 6759.256481787, 6788.966055169742, 6854.074699915523, 6893.827654308632, 6927.064846245793, 6530.726508330878, 6700.162479690039, 6706.631135287557, 6716.597004179765, 6746.966265168692, 20370.0, 20805.479863003548, 21435.356939291847, 21462.89268553663, 22438.0, 1889.8393636540911, 2000.839932805372, 2238.473958619723, 2342.2036507587504, 2433.6471211674207, 12393.752124957451, 12566.30885301308, 12611.117221794479, 13056.086073974826, 13239.338033098307, 1791.08654586162, 1811.7554130192386, 1865.8693891427606, 1896.8713615398954, 1902.8192321729553, 68062.65968670175, 71292.0, 71533.64233178853, 71809.2819071813, 72112.27887721108, 15733.246681830633, 15750.9212453937, 15802.762958555631, 16085.793565482401, 16109.597260068593, 28172.43655126886, 28361.29096772597, 28514.857425713155, 28539.429211415656, 28616.856915715704, 8170.403411212143, 8606.0, 8649.91350086491, 8783.25342345895, 8804.735857924272, 7076.787696369117, 7138.571685698875, 7204.495685302083, 7241.746538871114, 7246.746363877239, 8119.228673276029, 8288.378371622153, 8399.95800020996, 8500.83228776658, 8503.404761666625, 3167.588213532226, 3296.583234008731, 3401.8639254429545, 3467.289205712823, 3571.142925697866, 690.3855568544, 766.9156392796788, 772.1352085664092, 790.0795573157322, 844.4806444036996, 14754.188519631523, 15117.924410377878, 15136.924315378352, 15250.542483725507, 15379.61550961235, 777.9222077792175, 784.9686012559433, 790.213737331359, 827.9420440569223, 845.6321500147455, 8494.872576911352, 8846.380753347205, 8863.64545418176, 8955.0, 8978.595963181542, 356278.0, 358522.0, 361673.0, 361768.0, 366589.0, 65625.0, 65834.34165658282, 67048.6647566759, 67413.32586674168, 68871.49028077742, 930.0745757970863, 933.1042199488431, 953.9427634341962, 978.2907392140784, 980.7989362180735, 14188.645283867985, 14253.572392828231, 14287.64280892986, 14360.425582976564, 14688.192149431883, 32057.67942320547, 32185.839070804497, 32302.0, 32678.0, 32791.34417311688, 41521.37717934294, 43065.0, 43673.56326436695, 43889.47449930391, 43892.341614876445, 7411.777646670608, 7501.962490187732, 7771.057235691077, 7878.330341921001, 7990.440669153103, 11069.335839849635, 11103.833442498208, 11170.664880053611, 11583.015443687382, 11802.763944720886, 9904.356216845881, 10006.549705263134, 10334.638287659896, 10361.63734269297, 10471.3193642413, 9354.859677104985, 9670.613175473183, 9787.657431989846, 10010.098081364518, 10450.895491044992, 9904.405735655884, 10314.845277320996, 10548.472576371305, 10736.516856741622, 10782.622608208674, 7784.92215077842, 7864.84270314602, 7868.763937081897, 7946.404019698662, 7956.12482626899, 10063.949680251551, 10390.324628899098, 10501.107405870282, 10569.947150264199, 10606.204534659777], "value": 8883.696533155467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1135.8239472881705, 1226.1662069792544, 1227.2145826670928, 1288.4874494735266, 1461.9049761765484, 5987.0, 7230.638468076595, 7461.253874612536, 7462.514936529122, 7463.962680186598, 7000.264972177924, 7163.176234732994, 7163.355298023177, 7166.5700057996555, 7167.175774785901, 2170.630992731232, 2203.206845535614, 2204.6252137136644, 2204.90077946492, 2205.503761653631, 2089.8641588296787, 2141.892905354734, 2153.827693784501, 2154.5906277807167, 2182.3671135370723, 2161.729783777028, 2168.56628674265, 2182.1925887421676, 2183.7816218378116, 2205.184081889695, 2087.728595282611, 2104.8947552622385, 2104.95790084199, 2105.084288334564, 2105.3894370632497, 2034.267663641103, 2080.44868109951, 2081.937541873731, 2083.656196727538, 2088.3421722157623, 7311.451641126883, 7388.150362708304, 7470.925290747077, 7471.626418679044, 7477.364424023965, 4352.651787856964, 4508.391367165424, 4523.7285762854335, 4527.569880861346, 4534.02518458533, 2732.9863350683318, 2844.4737723521007, 2890.85545722713, 2901.144162472076, 2907.9273018174713, 857.7555396711907, 858.8282343531256, 867.4968518259394, 882.1311008656468, 887.7292425810125, 9406.153446189808, 9465.337426380087, 9479.431234125974, 9498.525073746285, 9504.04959504051, 3844.615538446189, 3898.3567711327314, 3963.1875465529497, 3972.7219094663096, 3975.383815508601, 7488.9625551871895, 7678.769636910902, 7703.229677032252, 7718.421118416141, 7729.690812367442, 4185.665146788249, 4186.28833098374, 4186.979065104655, 4189.853355132555, 4192.413062171298, 3424.178197232646, 3859.421086836941, 3904.316744569689, 3972.1857019310974, 3998.0, 3307.801531908045, 3314.1880239341517, 3384.1370450534955, 3390.559227300435, 3407.693307602328, 988.461288597716, 1056.746380868586, 1061.6125114333367, 1064.755106325534, 1065.8294672852462, 591.5385998920849, 705.8411857332162, 709.4147328454046, 748.3451979517922, 848.0755975986204, 4785.042991401733, 4924.3105965164905, 5084.211947148124, 5112.9744351278005, 5203.219517072469, 448.44616898130784, 450.1312466938774, 455.24883941496137, 462.4820201374482, 603.9672160605414, 3327.8169700666695, 3471.0801637566065, 3474.1488335358, 3494.7378946579106, 3592.0660628236847, 8742.650293988168, 9152.679656212, 9270.72187834366, 9290.349675522648, 9297.814043719087, 9097.40866843653, 9130.452172869649, 9174.449533027906, 9198.586063627154, 9199.310051746146, 6937.132858392701, 7012.193597736224, 7079.964600176966, 7085.645717714094, 7100.46746494015, 4789.9042019160115, 4895.7062576245535, 4905.90188196227, 4940.456549779593, 4957.330760347307, 8148.348132149533, 8156.265936065783, 8350.62422191015, 8368.24685778283, 8459.450135741157, 8499.405041647025, 8580.05619381855, 8595.140485951355, 8631.093735157718, 8698.739037828875, 5321.361436627474, 5935.821925342247, 6059.0, 6122.755089796358, 6135.294441139147, 7038.472114591324, 7099.325564071405, 7103.360697537247, 7104.18301895268, 7117.893231601426, 6066.817995460143, 6204.751809927552, 6234.189555357774, 6280.8429789253805, 6337.588056776479, 6263.123162757309, 6390.0, 6406.199225096863, 6485.870282594227, 6527.934720652733, 6002.969985150046, 6156.199694039746, 6197.566170368212, 6201.255849298113, 6204.658743769136, 4161.188568229288, 4178.519470260837, 4232.534421213602, 4249.051328140627, 4319.308910574293, 4508.256137737237, 4551.613112885442, 4564.77176141185, 4581.702189357681, 4633.166030114477], "value": 3827.5342064783226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.82605262894896, 295.6363672682601, 299.4475193268419, 318.73385722921347, 320.82194382117945, 4614.907701845961, 4676.620396982889, 4716.292556116584, 4741.93306506036, 4768.403949506312, 4692.671512994092, 4718.136336147229, 4720.291956206571, 4728.1962066448705, 4734.455537613176, 3542.36237477254, 3563.910902227452, 3666.7616604920727, 3720.5535335759746, 3764.3788774852114, 3745.681617062553, 3752.4558938953837, 3755.568109667382, 3761.13493896404, 3769.943450848226, 3498.9300213995707, 3715.349813782591, 3718.0890681783003, 3718.7582807117587, 3737.1965027519077, 3599.406097993841, 3710.591834898159, 3725.329440700673, 3733.2533493301175, 3743.7940913249895, 3321.618013928381, 3330.4837750148768, 3333.4833100869405, 3342.6490218526947, 3360.5295258663805, 4516.209663308908, 4517.096580683877, 4521.434820647419, 4521.59305662492, 4538.160440318518, 4062.7968601569805, 4266.189424009459, 4269.167512335096, 4294.506131794852, 4302.870913872589, 4920.188168952119, 4938.209886418192, 4940.28365886948, 4950.257461380822, 4973.477784832613, 3641.6904563112166, 3649.996251030961, 3650.2699460108083, 3677.0991107178643, 3685.1892583631557, 4977.900441991176, 5118.948810511884, 5135.922961155586, 5204.869878253036, 5223.369758018179, 3686.7234957378305, 3696.7966761828357, 3703.2408356287438, 3703.5555733312176, 3725.1432170600915, 3773.396256598931, 3776.4712940188397, 3783.0, 3802.3535998880257, 3805.3150432921784, 4241.915161696748, 4245.978770106191, 4248.553901840324, 4251.5748425157235, 4273.572642735764, 4842.249451335048, 4917.139500587455, 4955.306257124005, 4956.900861982812, 5019.648624596316, 1360.6462319796924, 1362.6184668292894, 1372.61566761307, 1375.2229990055587, 1378.9310534473236, 890.1543533643065, 939.1922946266205, 939.5724945150077, 947.2232769129248, 951.1344676344494, 4625.699329543569, 4626.398568186181, 4653.557911998355, 4660.231061874821, 4661.091087237956, 5380.91928621071, 5389.056915039852, 5393.114683644231, 5401.432849550819, 5401.540869026098, 4481.148581769454, 4650.255959046604, 4654.743989080633, 4656.371389862393, 4662.440507139165, 2829.221963959886, 2837.7156389106553, 2841.962683620505, 2852.985735071353, 2876.7267109624554, 5028.64799464034, 5035.672681275779, 5039.647224694236, 5040.495950405004, 5080.77136528857, 5250.556097073335, 5405.243265942771, 5444.101723215705, 5447.346318441812, 5456.809011684572, 5021.874453138701, 5023.120953833138, 5028.296038554606, 5030.547250747451, 5054.393472783289, 5196.116660167856, 5244.134717771678, 5259.973700131475, 5279.10255256615, 5293.100172970681, 5033.798648054037, 5227.294315267391, 5230.7384630769075, 5237.502437268454, 5249.658772179796, 5024.743814046488, 5032.421271553671, 5049.166887463674, 5054.494550544916, 5069.721165335942, 3835.7890316032885, 3851.383778595411, 3856.382978723391, 3857.826397812049, 3865.2849222893856, 5175.378954525481, 5212.047681753281, 5240.947590524046, 5263.578913686973, 5267.60492963037, 5054.393472783289, 5095.617828662791, 5096.592272618108, 5100.6429549931145, 5135.794568217229, 5117.334746482933, 5132.640715149903, 5133.614978876524, 5136.101182293159, 5151.7166555839785, 4672.205725026822, 4688.601468875184, 4765.523447655207, 4900.92648610264, 4914.238293064581, 4990.251462280542, 4990.426100998432, 4995.17579599362, 5001.324556273689, 5023.949760502348, 4907.190313598217, 4912.828051018198, 4929.285253638131, 4929.654924155275, 4937.407511098691], "value": 3841.6667227710204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.9010338552604, 727.1201845766623, 765.1583258415743, 769.7036640893258, 784.3019712455919, 13576.117552359103, 14029.859701402984, 14055.0, 14078.366473508691, 14087.29563521825, 11449.885501144987, 11478.770424591525, 11493.942530287337, 11509.194356395055, 11553.884461155387, 513.9614528910328, 800.6037011679227, 810.6878851642116, 818.8239528501371, 819.81554150316, 814.5601375257354, 817.0399780258202, 817.8159914019358, 818.7134502923959, 818.97133600324, 707.3457052226695, 712.657924196386, 712.9500934934557, 714.2250658036011, 714.4463041143104, 576.9278840144982, 709.14902117459, 709.6026225313841, 824.2993455562784, 850.2645211891731, 619.0837560410572, 619.2259675405743, 619.5446346934999, 619.683961179797, 620.2494981072862, 12320.938395308056, 12355.814662780065, 12381.876181238162, 12388.070894682935, 12390.62828115158, 11087.889121108847, 11533.192676512648, 11672.649820505398, 11690.357030363326, 11891.464884080151, 9416.1525462708, 9598.232141428669, 9694.17599504043, 9825.606975720963, 9844.60621575136, 3255.788373755698, 3258.413485572596, 3285.0801775502896, 3311.4701647736247, 3314.767966242364, 42753.78623106896, 44083.338749918774, 44249.0, 44282.0, 44382.11235775299, 9564.856527152098, 9800.31397802147, 9835.901640983642, 9871.358361706467, 9974.551145198484, 16861.91569042147, 16902.83097169037, 16921.069341186354, 16951.576210594587, 17043.062631555134, 6285.340039295899, 6302.905456418157, 6423.74305027803, 6437.517186211053, 6446.033095035782, 3441.690247877703, 3568.1436455251073, 3611.2777444511203, 3621.619729928372, 3681.8586238266225, 2667.7999150063824, 2741.465414244203, 2744.19046381318, 2758.1311886755607, 2759.6274502942247, 497.80585571627097, 503.32051730164716, 505.3935277666815, 509.6330641937799, 523.5549782684687, 486.73716193255245, 538.7888186408968, 544.923710680505, 562.8395907166438, 577.053632043449, 8041.3164880984605, 8202.917970820215, 8300.875486867702, 8310.792230194293, 8505.872411913826, 475.40099474662173, 485.25513337027496, 574.3825387708231, 577.711144427786, 595.3094410483818, 3371.4268574342423, 3596.9280614387567, 3597.982010089933, 3692.372296709566, 3711.31340701971, 52042.73978630082, 53681.0, 53820.73089634527, 53851.0, 53932.46067539353, 44958.77520612442, 46586.76706616445, 47044.5295547047, 47409.0, 48364.27453588199, 42942.78528607337, 43360.13279734451, 43526.34710479345, 44338.556614433444, 44545.331820022075, 7210.351068403869, 7370.520916140434, 7452.627368631438, 7460.850782984418, 7462.701491940262, 28848.567271490523, 29701.0, 29748.0, 30068.920347132356, 30076.699233007388, 38127.0, 39682.603173969044, 39828.20343593054, 40228.1954360917, 40410.595894040685, 9415.717528474157, 9514.952425237829, 9570.47362395075, 9594.856077158987, 9614.423134611945, 10336.741581460523, 10597.788044239227, 10655.520501577603, 10716.517756701123, 11097.667069987914, 8529.786755331166, 9791.559379827782, 10087.29388942767, 10523.78952420932, 10660.89339106599, 10941.234113612289, 10994.615188468366, 11102.44487775592, 11309.773804523698, 11570.0, 10678.199135064746, 10695.358278503314, 10816.459177041274, 10834.945825270823, 11022.338659680445, 9313.487758173365, 9327.906720932704, 9417.717468475958, 9567.473788941676, 9678.903210967801, 8948.73153805387, 9366.297527685587, 9408.43549387039, 9504.144626983605, 9674.516274186404], "value": 5756.0161294735, "unit": "score"}], "name": "dromaeo_css", "value": 6126.402412443724, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 113.0, 113.0, 113.0, 103.0, 113.0, 115.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 160.0, 201.0, 132.0, 155.0, 153.0, 141.0, 186.0, 139.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 111.0, 120.0, 74.0, 73.0, 73.0, 116.0, 102.0, 78.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 148.0, 95.0, 95.0, 95.0, 146.0, 94.0, 95.0, 142.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 91.0, 63.0, 65.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 78.0, 86.0, 80.0, 81.0, 82.0, 80.0, 80.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 134.0, 134.0, 134.0, 132.0, 136.0, 135.0, 196.0, 143.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 219.0, 220.0, 218.0, 219.0, 221.0, 222.0, 214.0, 213.0, 218.0], "value": 218.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 76.0, 73.0, 76.0, 75.0, 74.0, 72.0, 73.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1633.6, "alertThreshold": 2.0}]} 07:30:17 INFO - Return code: 0 07:30:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:30:17 ERROR - # TBPL SUCCESS # 07:30:17 INFO - Running post-action listener: _resource_record_post_action 07:30:17 INFO - Running post-run listener: _resource_record_post_run 07:30:19 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 491520; Write bytes: 298700800; Read time: 380; Write time: 156384 07:30:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20385792; Read time: 0; Write time: 29604 07:30:19 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 491520; Write bytes: 278315008; Read time: 380; Write time: 126780 07:30:19 INFO - Running post-run listener: _upload_blobber_files 07:30:19 INFO - Blob upload gear active. 07:30:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:19 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 07:30:19 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'] 07:30:19 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 07:30:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:30:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:30:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:20 INFO - (blobuploader) - INFO - Done attempting. 07:30:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:21 INFO - (blobuploader) - INFO - Done attempting. 07:30:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:21 INFO - Return code: 0 07:30:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1077ffca1c36a360d5b27abe6f54cb82666943779f095861b00ccd3ef3411f4d068bae82016c2f3b3bf1ff730a3aa9a632c3b5ed23d842a509c6f97204b1ecbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da8564587cd5a27a274f1b68b157737fac8d734a3fa738115a0371851c446d8276707986829cb385b5140edf145eda1215aa89b7cf84225ec964070667385c0f"} 07:30:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:21 INFO - Contents: 07:30:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1077ffca1c36a360d5b27abe6f54cb82666943779f095861b00ccd3ef3411f4d068bae82016c2f3b3bf1ff730a3aa9a632c3b5ed23d842a509c6f97204b1ecbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da8564587cd5a27a274f1b68b157737fac8d734a3fa738115a0371851c446d8276707986829cb385b5140edf145eda1215aa89b7cf84225ec964070667385c0f"} 07:30:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:21 INFO - Copying logs to upload dir... 07:30:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.907916 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-26 07:30:21.300953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 07:30:21.304488) ========= 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=41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314 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/1077ffca1c36a360d5b27abe6f54cb82666943779f095861b00ccd3ef3411f4d068bae82016c2f3b3bf1ff730a3aa9a632c3b5ed23d842a509c6f97204b1ecbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da8564587cd5a27a274f1b68b157737fac8d734a3fa738115a0371851c446d8276707986829cb385b5140edf145eda1215aa89b7cf84225ec964070667385c0f"} build_url:https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/AyDjKdxvSlyuSANzHslw8Q/artifacts/public/build/firefox-49.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/1077ffca1c36a360d5b27abe6f54cb82666943779f095861b00ccd3ef3411f4d068bae82016c2f3b3bf1ff730a3aa9a632c3b5ed23d842a509c6f97204b1ecbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da8564587cd5a27a274f1b68b157737fac8d734a3fa738115a0371851c446d8276707986829cb385b5140edf145eda1215aa89b7cf84225ec964070667385c0f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 07:30:21.329347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:30:21.329672) ========= 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=41bf3e9aed84707956354da8000001c5-1461679746.744707-996818314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:30:21.414896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 07:30:21.415298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 07:30:21.415665) ========= ========= Total master_lag: 0.18 =========