builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1461716552.85 results: success (0) buildid: 20160426143018 builduid: 96ad2f1af0e3460682eb5c206f8975d8 revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:32.854621) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:32.855015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:32.855282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:32.885488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:32.885824) ========= 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=920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 17:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-26 17:22:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:33.005392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:33.005675) ========= 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=920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020433 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:33.054951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 17:22:33.055270) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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=920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 17:22:33,507 truncating revision to first 12 chars 2016-04-26 17:22:33,508 Setting DEBUG logging. 2016-04-26 17:22:33,508 attempt 1/10 2016-04-26 17:22:33,508 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/937d57e8b4f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 17:22:34,688 unpacking tar archive at: fx-team-937d57e8b4f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.482893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 17:22:34.550831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:34.551157) ========= script_repo_revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:34.551573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:34.551836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:34.560490) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-26 17:22:34.560810) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:35 INFO - MultiFileLogger online at 20160426 17:22:35 in /builds/slave/test 17:22:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:22:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:35 INFO - {'append_to_log': False, 17:22:35 INFO - 'base_work_dir': '/builds/slave/test', 17:22:35 INFO - 'blob_upload_branch': 'Fx-Team', 17:22:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:35 INFO - 'branch': 'Fx-Team', 17:22:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:35 INFO - 'config_files': ('talos/linux_config.py',), 17:22:35 INFO - 'default_actions': ('clobber', 17:22:35 INFO - 'read-buildbot-config', 17:22:35 INFO - 'download-and-extract', 17:22:35 INFO - 'populate-webroot', 17:22:35 INFO - 'create-virtualenv', 17:22:35 INFO - 'install', 17:22:35 INFO - 'run-tests'), 17:22:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:35 INFO - 'download_minidump_stackwalk': True, 17:22:35 INFO - 'download_symbols': 'ondemand', 17:22:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:22:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:22:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:22:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:22:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:35 INFO - 'installer_path': 'installer.exe', 17:22:35 INFO - 'log_level': 'info', 17:22:35 INFO - 'log_name': 'talos', 17:22:35 INFO - 'log_to_console': True, 17:22:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:35 INFO - 'opt_config_files': (), 17:22:35 INFO - 'pip_index': False, 17:22:35 INFO - 'sps_profile': False, 17:22:35 INFO - 'sps_profile_interval': 0, 17:22:35 INFO - 'suite': 'dromaeojs', 17:22:35 INFO - 'system_bits': '32', 17:22:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:35 INFO - 'title': 'talos-linux64-ix-053', 17:22:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:35 INFO - 'use_talos_json': True, 17:22:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:35 INFO - 'work_dir': 'build'} 17:22:35 INFO - ##### 17:22:35 INFO - ##### Running clobber step. 17:22:35 INFO - ##### 17:22:35 INFO - Running pre-action listener: _resource_record_pre_action 17:22:35 INFO - Running main action method: clobber 17:22:35 INFO - rmtree: /builds/slave/test/build 17:22:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:35 INFO - Running post-action listener: _resource_record_post_action 17:22:35 INFO - ##### 17:22:35 INFO - ##### Running read-buildbot-config step. 17:22:35 INFO - ##### 17:22:35 INFO - Running pre-action listener: _resource_record_pre_action 17:22:35 INFO - Running main action method: read_buildbot_config 17:22:35 INFO - Using buildbot properties: 17:22:35 INFO - { 17:22:35 INFO - "project": "", 17:22:35 INFO - "product": "firefox", 17:22:35 INFO - "script_repo_revision": "production", 17:22:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:22:35 INFO - "repository": "", 17:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:22:35 INFO - "buildid": "20160426143018", 17:22:35 INFO - "pgo_build": "True", 17:22:35 INFO - "basedir": "/builds/slave/test", 17:22:35 INFO - "buildnumber": 613, 17:22:35 INFO - "slavename": "talos-linux64-ix-053", 17:22:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:22:35 INFO - "platform": "ubuntu64_hw", 17:22:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:22:35 INFO - "branch": "fx-team", 17:22:35 INFO - "repo_path": "integration/fx-team", 17:22:35 INFO - "revision": "937d57e8b4f0fa5f16231563ab0425eee9d40c82", 17:22:35 INFO - "stage_platform": "linux64-pgo", 17:22:35 INFO - "builduid": "96ad2f1af0e3460682eb5c206f8975d8", 17:22:35 INFO - "slavebuilddir": "test" 17:22:35 INFO - } 17:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:22:35 INFO - Running post-action listener: _resource_record_post_action 17:22:35 INFO - ##### 17:22:35 INFO - ##### Running download-and-extract step. 17:22:35 INFO - ##### 17:22:35 INFO - Running pre-action listener: _resource_record_pre_action 17:22:35 INFO - Running main action method: download_and_extract 17:22:35 INFO - mkdir: /builds/slave/test/build/tests 17:22: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')]} 17:22:35 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:42 INFO - Downloaded 1361 bytes. 17:22:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:42 INFO - Using the following test package requirements: 17:22:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:22:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:22:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'jsshell-linux-x86_64.zip'], 17:22:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:22:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:22:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:22:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:22:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:22:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:42 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:51 INFO - Downloaded 23863733 bytes. 17:22:51 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'] 17:22:51 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 17:22:52 INFO - Return code: 0 17:22:52 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 17:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:52 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:54 INFO - Downloaded 23863733 bytes. 17:22:54 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'] 17:22:54 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 17:22:55 INFO - Return code: 0 17:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:55 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:56 INFO - Downloaded 10840145 bytes. 17:22:56 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'] 17:22:56 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 17:22:56 INFO - Return code: 0 17:22: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')]} 17:22:56 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:22:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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 17:22:58 INFO - Downloaded 58368294 bytes. 17:22:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:58 INFO - mkdir: /builds/slave/test/properties 17:22:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:58 INFO - Contents: 17:22:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:59 INFO - Running post-action listener: _resource_record_post_action 17:22:59 INFO - Running post-action listener: set_extra_try_arguments 17:22:59 INFO - ##### 17:22:59 INFO - ##### Running populate-webroot step. 17:22:59 INFO - ##### 17:22:59 INFO - Running pre-action listener: _resource_record_pre_action 17:22:59 INFO - Running main action method: populate_webroot 17:22:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:22:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:22:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:22:59 INFO - '--tppagecycles', 17:22:59 INFO - '7'], 17:22:59 INFO - 'tests': ['tsvgm']}}, 17:22:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:22:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:22:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['damp', 'tps']}, 17:22:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'tests': ['damp', 'tps']}, 17:22:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['dromaeo_dom']}, 17:22:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['a11yr', 17:22:59 INFO - 'ts_paint', 17:22:59 INFO - 'tpaint', 17:22:59 INFO - 'sessionrestore', 17:22:59 INFO - 'sessionrestore_no_auto_restore', 17:22:59 INFO - 'tabpaint']}, 17:22:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:59 INFO - 'ts_paint', 17:22:59 INFO - 'tpaint', 17:22:59 INFO - 'sessionrestore', 17:22:59 INFO - 'sessionrestore_no_auto_restore', 17:22:59 INFO - 'tabpaint']}, 17:22:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:22:59 INFO - 'ts_paint', 17:22:59 INFO - 'tpaint', 17:22:59 INFO - 'sessionrestore', 17:22:59 INFO - 'sessionrestore_no_auto_restore', 17:22:59 INFO - 'tabpaint']}, 17:22:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:22:59 INFO - 'ts_paint', 17:22:59 INFO - 'tpaint', 17:22:59 INFO - 'sessionrestore', 17:22:59 INFO - 'sessionrestore_no_auto_restore', 17:22:59 INFO - 'tabpaint']}, 17:22:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['a11yr', 17:22:59 INFO - 'ts_paint', 17:22:59 INFO - 'tpaint', 17:22:59 INFO - 'sessionrestore', 17:22:59 INFO - 'sessionrestore_no_auto_restore', 17:22:59 INFO - 'tabpaint']}, 17:22:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['a11yr', 17:22:59 INFO - 'ts_paint', 17:22:59 INFO - 'tpaint', 17:22:59 INFO - 'sessionrestore', 17:22:59 INFO - 'sessionrestore_no_auto_restore', 17:22:59 INFO - 'tabpaint']}, 17:22:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['tsvgx', 17:22:59 INFO - 'tsvgr_opacity', 17:22:59 INFO - 'tart', 17:22:59 INFO - 'tscrollx', 17:22:59 INFO - 'cart']}, 17:22:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:59 INFO - 'tsvgr_opacity', 17:22:59 INFO - 'tart', 17:22:59 INFO - 'tscrollx', 17:22:59 INFO - 'cart']}, 17:22:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'talos_options': ['--disable-e10s'], 17:22:59 INFO - 'tests': ['tp5o']}, 17:22:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'tests': ['tp5o']}, 17:22:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'talos_options': ['--disable-e10s', 17:22:59 INFO - '--xperf_path', 17:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:59 INFO - 'tests': ['tp5n']}, 17:22:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:59 INFO - 'talos_options': ['--xperf_path', 17:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:59 INFO - 'tests': ['tp5n']}}, 17:22:59 INFO - 'talos.zip': {'path': '', 17:22:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:22:59 INFO - Running post-action listener: _resource_record_post_action 17:22:59 INFO - ##### 17:22:59 INFO - ##### Running create-virtualenv step. 17:22:59 INFO - ##### 17:22:59 INFO - Running pre-action listener: _resource_record_pre_action 17:22:59 INFO - Running main action method: create_virtualenv 17:22:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:22:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:22:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:59 INFO - Using real prefix '/usr' 17:22:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:23:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:23:02 INFO - Installing pip.................done. 17:23:02 INFO - Return code: 0 17:23:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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')]} 17:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23: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', 'pip>=1.5'] in /builds/slave/test/build 17:23: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 pip>=1.5 17:23:02 INFO - Using env: {'DISPLAY': ':0', 17:23:02 INFO - 'HOME': '/home/cltbld', 17:23:02 INFO - 'LANG': 'en_US.UTF-8', 17:23:02 INFO - 'LANGUAGE': 'en_US:en', 17:23:02 INFO - 'LOGNAME': 'cltbld', 17:23:02 INFO - 'MAIL': '/var/mail/cltbld', 17:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:02 INFO - 'MOZ_NO_REMOTE': '1', 17:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:02 INFO - 'NO_EM_RESTART': '1', 17:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:02 INFO - 'PWD': '/builds/slave/test', 17:23:02 INFO - 'SHELL': '/bin/bash', 17:23:02 INFO - 'SHLVL': '1', 17:23:02 INFO - 'TERM': 'linux', 17:23:02 INFO - 'TMOUT': '86400', 17:23:02 INFO - 'USER': 'cltbld', 17:23:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:02 INFO - '_': '/tools/buildbot/bin/python'} 17:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:23:02 INFO - Cleaning up... 17:23:02 INFO - Return code: 0 17:23:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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')]} 17:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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', '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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:23: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 psutil>=0.7.1 17:23:02 INFO - Using env: {'DISPLAY': ':0', 17:23:02 INFO - 'HOME': '/home/cltbld', 17:23:02 INFO - 'LANG': 'en_US.UTF-8', 17:23:02 INFO - 'LANGUAGE': 'en_US:en', 17:23:02 INFO - 'LOGNAME': 'cltbld', 17:23:02 INFO - 'MAIL': '/var/mail/cltbld', 17:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:02 INFO - 'MOZ_NO_REMOTE': '1', 17:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:02 INFO - 'NO_EM_RESTART': '1', 17:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:02 INFO - 'PWD': '/builds/slave/test', 17:23:02 INFO - 'SHELL': '/bin/bash', 17:23:02 INFO - 'SHLVL': '1', 17:23:02 INFO - 'TERM': 'linux', 17:23:02 INFO - 'TMOUT': '86400', 17:23:02 INFO - 'USER': 'cltbld', 17:23:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:02 INFO - '_': '/tools/buildbot/bin/python'} 17:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:02 INFO - Downloading/unpacking psutil>=0.7.1 17:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:23:04 INFO - Installing collected packages: psutil 17:23:04 INFO - Running setup.py install for psutil 17:23:04 INFO - building 'psutil._psutil_linux' extension 17:23:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:23:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:23:04 INFO - building 'psutil._psutil_posix' extension 17:23:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:23:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:23:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:23:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:23:05 INFO - Successfully installed psutil 17:23:05 INFO - Cleaning up... 17:23:05 INFO - Return code: 0 17:23:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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')]} 17:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:23:05 INFO - Using env: {'DISPLAY': ':0', 17:23:05 INFO - 'HOME': '/home/cltbld', 17:23:05 INFO - 'LANG': 'en_US.UTF-8', 17:23:05 INFO - 'LANGUAGE': 'en_US:en', 17:23:05 INFO - 'LOGNAME': 'cltbld', 17:23:05 INFO - 'MAIL': '/var/mail/cltbld', 17:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:05 INFO - 'MOZ_NO_REMOTE': '1', 17:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:05 INFO - 'NO_EM_RESTART': '1', 17:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:05 INFO - 'PWD': '/builds/slave/test', 17:23:05 INFO - 'SHELL': '/bin/bash', 17:23:05 INFO - 'SHLVL': '1', 17:23:05 INFO - 'TERM': 'linux', 17:23:05 INFO - 'TMOUT': '86400', 17:23:05 INFO - 'USER': 'cltbld', 17:23:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:05 INFO - '_': '/tools/buildbot/bin/python'} 17:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:23:07 INFO - Installing collected packages: mozsystemmonitor 17:23:07 INFO - Running setup.py install for mozsystemmonitor 17:23:07 INFO - Successfully installed mozsystemmonitor 17:23:07 INFO - Cleaning up... 17:23:07 INFO - Return code: 0 17:23:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:23:07 INFO - Using env: {'DISPLAY': ':0', 17:23:07 INFO - 'HOME': '/home/cltbld', 17:23:07 INFO - 'LANG': 'en_US.UTF-8', 17:23:07 INFO - 'LANGUAGE': 'en_US:en', 17:23:07 INFO - 'LOGNAME': 'cltbld', 17:23:07 INFO - 'MAIL': '/var/mail/cltbld', 17:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:07 INFO - 'MOZ_NO_REMOTE': '1', 17:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:07 INFO - 'NO_EM_RESTART': '1', 17:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:07 INFO - 'PWD': '/builds/slave/test', 17:23:07 INFO - 'SHELL': '/bin/bash', 17:23:07 INFO - 'SHLVL': '1', 17:23:07 INFO - 'TERM': 'linux', 17:23:07 INFO - 'TMOUT': '86400', 17:23:07 INFO - 'USER': 'cltbld', 17:23:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:07 INFO - '_': '/tools/buildbot/bin/python'} 17:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:23:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:23:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23:10 INFO - Downloading docopt-0.6.1.tar.gz 17:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:23:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:23:10 INFO - Running setup.py install for blobuploader 17:23:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:23:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:23:10 INFO - Running setup.py install for requests 17:23:10 INFO - Running setup.py install for docopt 17:23:10 INFO - Successfully installed blobuploader requests docopt 17:23:10 INFO - Cleaning up... 17:23:10 INFO - Return code: 0 17:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:10 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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:23:10 INFO - Using env: {'DISPLAY': ':0', 17:23:10 INFO - 'HOME': '/home/cltbld', 17:23:10 INFO - 'LANG': 'en_US.UTF-8', 17:23:10 INFO - 'LANGUAGE': 'en_US:en', 17:23:10 INFO - 'LOGNAME': 'cltbld', 17:23:10 INFO - 'MAIL': '/var/mail/cltbld', 17:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:10 INFO - 'MOZ_NO_REMOTE': '1', 17:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:10 INFO - 'NO_EM_RESTART': '1', 17:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:10 INFO - 'PWD': '/builds/slave/test', 17:23:10 INFO - 'SHELL': '/bin/bash', 17:23:10 INFO - 'SHLVL': '1', 17:23:10 INFO - 'TERM': 'linux', 17:23:10 INFO - 'TMOUT': '86400', 17:23:10 INFO - 'USER': 'cltbld', 17:23:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:10 INFO - '_': '/tools/buildbot/bin/python'} 17:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:11 INFO - Running setup.py (path:/tmp/pip-_4450w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:11 INFO - Running setup.py (path:/tmp/pip-fUAA6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:11 INFO - Running setup.py (path:/tmp/pip-GWtYH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:11 INFO - Running setup.py (path:/tmp/pip-HsYLrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:11 INFO - Running setup.py (path:/tmp/pip-qHnD6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:11 INFO - Running setup.py (path:/tmp/pip-fGMqbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:11 INFO - Running setup.py (path:/tmp/pip-Vfv3gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:11 INFO - Running setup.py (path:/tmp/pip-SHOkHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:11 INFO - Running setup.py (path:/tmp/pip-MruBqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:11 INFO - Running setup.py (path:/tmp/pip-Elq_8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:11 INFO - Running setup.py (path:/tmp/pip-1eTdZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:11 INFO - Running setup.py (path:/tmp/pip-4JCxc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:12 INFO - Running setup.py (path:/tmp/pip-rUPHWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:12 INFO - Running setup.py (path:/tmp/pip-8NftaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:12 INFO - Running setup.py (path:/tmp/pip-Q93086-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:12 INFO - Running setup.py (path:/tmp/pip-6YO7l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:12 INFO - Running setup.py (path:/tmp/pip-TvQpYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:12 INFO - Running setup.py install for manifestparser 17:23:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:12 INFO - Running setup.py install for mozcrash 17:23:12 INFO - Running setup.py install for mozdebug 17:23:12 INFO - Running setup.py install for mozdevice 17:23:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:23:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:12 INFO - Running setup.py install for mozfile 17:23:12 INFO - Running setup.py install for mozhttpd 17:23:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for mozinfo 17:23:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for mozInstall 17:23:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for mozleak 17:23:13 INFO - Running setup.py install for mozlog 17:23:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for moznetwork 17:23:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for mozprocess 17:23:13 INFO - Running setup.py install for mozprofile 17:23:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for mozrunner 17:23:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:13 INFO - Running setup.py install for mozscreenshot 17:23:13 INFO - Running setup.py install for moztest 17:23:14 INFO - Running setup.py install for mozversion 17:23:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:14 INFO - Cleaning up... 17:23:14 INFO - Return code: 0 17:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:14 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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:23:14 INFO - Using env: {'DISPLAY': ':0', 17:23:14 INFO - 'HOME': '/home/cltbld', 17:23:14 INFO - 'LANG': 'en_US.UTF-8', 17:23:14 INFO - 'LANGUAGE': 'en_US:en', 17:23:14 INFO - 'LOGNAME': 'cltbld', 17:23:14 INFO - 'MAIL': '/var/mail/cltbld', 17:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:14 INFO - 'MOZ_NO_REMOTE': '1', 17:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:14 INFO - 'NO_EM_RESTART': '1', 17:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:14 INFO - 'PWD': '/builds/slave/test', 17:23:14 INFO - 'SHELL': '/bin/bash', 17:23:14 INFO - 'SHLVL': '1', 17:23:14 INFO - 'TERM': 'linux', 17:23:14 INFO - 'TMOUT': '86400', 17:23:14 INFO - 'USER': 'cltbld', 17:23:14 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:14 INFO - '_': '/tools/buildbot/bin/python'} 17:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:14 INFO - Running setup.py (path:/tmp/pip-Cq7pZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:14 INFO - Running setup.py (path:/tmp/pip-SU7yMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:14 INFO - Running setup.py (path:/tmp/pip-HZUL7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:14 INFO - Running setup.py (path:/tmp/pip-zg79zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:14 INFO - Running setup.py (path:/tmp/pip-PXR37n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:14 INFO - Running setup.py (path:/tmp/pip-zcHhoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:14 INFO - Running setup.py (path:/tmp/pip-0WbQq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:14 INFO - Running setup.py (path:/tmp/pip-n22yU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:14 INFO - Running setup.py (path:/tmp/pip-x2MA6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:15 INFO - Running setup.py (path:/tmp/pip-hDoT5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:15 INFO - Running setup.py (path:/tmp/pip-Czkk5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:15 INFO - Running setup.py (path:/tmp/pip-9N_KV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:15 INFO - Running setup.py (path:/tmp/pip-LeeRkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:15 INFO - Running setup.py (path:/tmp/pip-THBxIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:15 INFO - Running setup.py (path:/tmp/pip-lZqhwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:15 INFO - Running setup.py (path:/tmp/pip-jRdIPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:15 INFO - Running setup.py (path:/tmp/pip-ds1WDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:23:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23:17 INFO - Downloading blessings-1.6.tar.gz 17:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:17 INFO - Installing collected packages: blessings 17:23:17 INFO - Running setup.py install for blessings 17:23:17 INFO - Successfully installed blessings 17:23:17 INFO - Cleaning up... 17:23:17 INFO - Return code: 0 17:23:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:17 INFO - Reading from file tmpfile_stdout 17:23:17 INFO - Current package versions: 17:23:17 INFO - argparse == 1.2.1 17:23:17 INFO - blessings == 1.6 17:23:17 INFO - blobuploader == 1.2.4 17:23:17 INFO - docopt == 0.6.1 17:23:17 INFO - manifestparser == 1.1 17:23:17 INFO - mozInstall == 1.12 17:23:17 INFO - mozcrash == 0.17 17:23:17 INFO - mozdebug == 0.1 17:23:17 INFO - mozdevice == 0.48 17:23:17 INFO - mozfile == 1.2 17:23:17 INFO - mozhttpd == 0.7 17:23:17 INFO - mozinfo == 0.9 17:23:17 INFO - mozleak == 0.1 17:23:17 INFO - mozlog == 3.1 17:23:17 INFO - moznetwork == 0.27 17:23:17 INFO - mozprocess == 0.22 17:23:17 INFO - mozprofile == 0.28 17:23:17 INFO - mozrunner == 6.11 17:23:17 INFO - mozscreenshot == 0.1 17:23:17 INFO - mozsystemmonitor == 0.0 17:23:17 INFO - moztest == 0.7 17:23:17 INFO - mozversion == 1.4 17:23:17 INFO - psutil == 3.1.1 17:23:17 INFO - requests == 1.2.3 17:23:17 INFO - wsgiref == 0.1.2 17:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:17 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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:23:17 INFO - Using env: {'DISPLAY': ':0', 17:23:17 INFO - 'HOME': '/home/cltbld', 17:23:17 INFO - 'LANG': 'en_US.UTF-8', 17:23:17 INFO - 'LANGUAGE': 'en_US:en', 17:23:17 INFO - 'LOGNAME': 'cltbld', 17:23:17 INFO - 'MAIL': '/var/mail/cltbld', 17:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:17 INFO - 'MOZ_NO_REMOTE': '1', 17:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:17 INFO - 'NO_EM_RESTART': '1', 17:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:17 INFO - 'PWD': '/builds/slave/test', 17:23:17 INFO - 'SHELL': '/bin/bash', 17:23:17 INFO - 'SHLVL': '1', 17:23:17 INFO - 'TERM': 'linux', 17:23:17 INFO - 'TMOUT': '86400', 17:23:17 INFO - 'USER': 'cltbld', 17:23:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:17 INFO - '_': '/tools/buildbot/bin/python'} 17:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:23:18 INFO - Cleaning up... 17:23:18 INFO - Return code: 0 17:23:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:18 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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:23:18 INFO - Using env: {'DISPLAY': ':0', 17:23:18 INFO - 'HOME': '/home/cltbld', 17:23:18 INFO - 'LANG': 'en_US.UTF-8', 17:23:18 INFO - 'LANGUAGE': 'en_US:en', 17:23:18 INFO - 'LOGNAME': 'cltbld', 17:23:18 INFO - 'MAIL': '/var/mail/cltbld', 17:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:18 INFO - 'MOZ_NO_REMOTE': '1', 17:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:18 INFO - 'NO_EM_RESTART': '1', 17:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:18 INFO - 'PWD': '/builds/slave/test', 17:23:18 INFO - 'SHELL': '/bin/bash', 17:23:18 INFO - 'SHLVL': '1', 17:23:18 INFO - 'TERM': 'linux', 17:23:18 INFO - 'TMOUT': '86400', 17:23:18 INFO - 'USER': 'cltbld', 17:23:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:18 INFO - '_': '/tools/buildbot/bin/python'} 17:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:18 INFO - Downloading/unpacking jsonschema 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:23:20 INFO - Downloading/unpacking functools32 (from jsonschema) 17:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:20 INFO - Downloading functools32-3.2.3-2.tar.gz 17:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:23:20 INFO - warning: no files found matching '*.txt' 17:23:20 INFO - no previously-included directories found matching 'build' 17:23:20 INFO - no previously-included directories found matching 'dist' 17:23:20 INFO - no previously-included directories found matching '.git*' 17:23:20 INFO - Installing collected packages: jsonschema, functools32 17:23:20 INFO - Running setup.py install for functools32 17:23:20 INFO - warning: no files found matching '*.txt' 17:23:20 INFO - no previously-included directories found matching 'build' 17:23:20 INFO - no previously-included directories found matching 'dist' 17:23:20 INFO - no previously-included directories found matching '.git*' 17:23:20 INFO - Successfully installed jsonschema functools32 17:23:20 INFO - Cleaning up... 17:23:20 INFO - Return code: 0 17:23:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:20 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 0x7fcb13b58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, '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': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:23:20 INFO - Using env: {'DISPLAY': ':0', 17:23:20 INFO - 'HOME': '/home/cltbld', 17:23:20 INFO - 'LANG': 'en_US.UTF-8', 17:23:20 INFO - 'LANGUAGE': 'en_US:en', 17:23:20 INFO - 'LOGNAME': 'cltbld', 17:23:20 INFO - 'MAIL': '/var/mail/cltbld', 17:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:20 INFO - 'MOZ_NO_REMOTE': '1', 17:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:20 INFO - 'NO_EM_RESTART': '1', 17:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:20 INFO - 'PWD': '/builds/slave/test', 17:23:20 INFO - 'SHELL': '/bin/bash', 17:23:20 INFO - 'SHLVL': '1', 17:23:20 INFO - 'TERM': 'linux', 17:23:20 INFO - 'TMOUT': '86400', 17:23:20 INFO - 'USER': 'cltbld', 17:23:20 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:20 INFO - '_': '/tools/buildbot/bin/python'} 17:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:20 INFO - Downloading/unpacking flake8 17:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:23:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:23:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:23:23 INFO - no previously-included directories found matching 'docs/_build' 17:23:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:23:23 INFO - Running setup.py install for pep8 17:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:23:23 INFO - no previously-included directories found matching 'docs/_build' 17:23:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:23:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:23:23 INFO - Cleaning up... 17:23:23 INFO - Return code: 0 17:23:23 INFO - Running post-action listener: _resource_record_post_action 17:23:23 INFO - Running post-action listener: _start_resource_monitoring 17:23:23 INFO - Starting resource monitoring. 17:23:23 INFO - ##### 17:23:23 INFO - ##### Running install step. 17:23:23 INFO - ##### 17:23:23 INFO - Running pre-action listener: _resource_record_pre_action 17:23:23 INFO - Running main action method: install 17:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:24 INFO - Reading from file tmpfile_stdout 17:23:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:24 INFO - Reading from file tmpfile_stdout 17:23:24 INFO - Output received: 17:23:24 INFO - Usage: mozinstall [options] installer 17:23:24 INFO - Options: 17:23:24 INFO - -h, --help show this help message and exit 17:23:24 INFO - -d DEST, --destination=DEST 17:23:24 INFO - Directory to install application into. [default: 17:23:24 INFO - "/builds/slave/test"] 17:23:24 INFO - --app=APP Application being installed. [default: firefox] 17:23:24 INFO - mkdir: /builds/slave/test/build/application 17:23:24 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'] 17:23:24 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 17:23:40 INFO - Reading from file tmpfile_stdout 17:23:40 INFO - Output received: 17:23:40 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:40 INFO - Running post-action listener: _resource_record_post_action 17:23:40 INFO - ##### 17:23:40 INFO - ##### Running run-tests step. 17:23:40 INFO - ##### 17:23:40 INFO - Running pre-action listener: _resource_record_pre_action 17:23:40 INFO - Running main action method: run_tests 17:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:40 INFO - Python 2.7.3 17:23:40 INFO - Return code: 0 17:23:40 INFO - grabbing minidump binary from tooltool 17:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:40 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 0x2641810>, '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 0x2642710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2642ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:23:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:23:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:40 INFO - Return code: 0 17:23:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:23:41 INFO - Return code: 0 17:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:23:41 INFO - Using env: {'DISPLAY': ':0', 17:23:41 INFO - 'HOME': '/home/cltbld', 17:23:41 INFO - 'LANG': 'en_US.UTF-8', 17:23:41 INFO - 'LANGUAGE': 'en_US:en', 17:23:41 INFO - 'LOGNAME': 'cltbld', 17:23:41 INFO - 'MAIL': '/var/mail/cltbld', 17:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:41 INFO - 'MOZ_NO_REMOTE': '1', 17:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:41 INFO - 'NO_EM_RESTART': '1', 17:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:41 INFO - 'PWD': '/builds/slave/test', 17:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:41 INFO - 'SHELL': '/bin/bash', 17:23:41 INFO - 'SHLVL': '1', 17:23:41 INFO - 'TERM': 'linux', 17:23:41 INFO - 'TMOUT': '86400', 17:23:41 INFO - 'USER': 'cltbld', 17:23:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009', 17:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:41 INFO - '_': '/tools/buildbot/bin/python'} 17:23:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:23:41 INFO - mozversion application_buildid: 20160426143018 17:23:41 INFO - mozversion application_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 17:23:41 INFO - mozversion application_display_name: Nightly 17:23:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:41 INFO - mozversion application_name: Firefox 17:23:41 INFO - mozversion application_remotingname: firefox 17:23:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:23:41 INFO - mozversion application_vendor: Mozilla 17:23:41 INFO - mozversion application_version: 49.0a1 17:23:41 INFO - mozversion platform_buildid: 20160426143018 17:23:41 INFO - mozversion platform_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 17:23:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:23:41 INFO - mozversion platform_version: 49.0a1 17:23:41 INFO - using testdate: 1461716621 17:23:41 INFO - actual date: 1461716621 17:23:41 INFO - starting webserver on 'localhost:50415' 17:23:41 INFO - SUITE-START | Running 2 tests 17:23:41 INFO - TEST-START | dromaeo_css 17:23:41 INFO - operating with platform_type : linux_ 17:23:41 INFO - Initialising browser for dromaeo_css test... 17:23:41 INFO - TEST-INFO | started process 13065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqCGZDd/profile http://localhost:50415/getInfo.html) 17:23:45 INFO - PROCESS | 13065 | __metrics Screen width/height:1600/1200 17:23:45 INFO - PROCESS | 13065 | colorDepth:24 17:23:45 INFO - PROCESS | 13065 | Browser inner width/height: 1024/697 17:23:45 INFO - PROCESS | 13065 | __metrics 17:23:47 ERROR - PROCESS | 13065 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:23:47 INFO - TEST-INFO | 13065: exit 0 17:23:47 INFO - Browser initialized. 17:23:47 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:47 INFO - TEST-INFO | started process 13148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqCGZDd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:59 INFO - PROCESS | 13148 | RSS: Main: 154521600 17:23:59 INFO - PROCESS | 13148 | 17:24:51 INFO - PROCESS | 13148 | 1461716691397 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:26:58 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:50415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50415/tests/dromaeo/cssquery-ext.html) 17:26:59 INFO - PROCESS | 13148 | RSS: Main: 245411840 17:26:59 INFO - PROCESS | 13148 | 17:30:01 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:50415/tests/dromaeo/cssquery-ext.html (next: http://localhost:50415/tests/dromaeo/cssquery-jquery.html) 17:30:02 INFO - PROCESS | 13148 | RSS: Main: 231333888 17:30:02 INFO - PROCESS | 13148 | 17:33:04 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:50415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50415/tests/dromaeo/cssquery-mootools.html) 17:33:04 INFO - PROCESS | 13148 | RSS: Main: 232099840 17:33:04 INFO - PROCESS | 13148 | 17:36:06 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:50415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50415/tests/dromaeo/cssquery-prototype.html) 17:36:07 INFO - PROCESS | 13148 | RSS: Main: 230686720 17:36:07 INFO - PROCESS | 13148 | 17:39:09 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:50415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50415/tests/dromaeo/cssquery-yui.html) 17:39:10 INFO - PROCESS | 13148 | RSS: Main: 204955648 17:39:10 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:50415/tests/dromaeo/cssquery-yui.html (next: http://localhost:50415/tests/dromaeo/cssquery-dojo.html) 17:42:13 INFO - PROCESS | 13148 | RSS: Main: 255709184 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | __start_tp_report 17:42:13 INFO - PROCESS | 13148 | _x_x_mozilla_page_load 17:42:13 INFO - PROCESS | 13148 | _x_x_mozilla_page_load_details 17:42:13 INFO - PROCESS | 13148 | |i|pagename|runs| 17:42:13 INFO - PROCESS | 13148 | |0;dojo.html;3045.9390812183756;3088.2125058110178;3150.4014237294896;3153.810771353719;3160.273137178449;5144.61415393846;5176.974115129424;5180.792768289273;5213.843584692456;5222.556082732963;5070.214116811891;5136.845894623168;5197.948020519793;5210.921836172461;5233.398159211692;4619.69971951822;4624.190766615837;4631.8147274109;4708.7645617719145;4773.021530586221;4714.811407543694;4716.292556116576;4728.432588089417;4733.431988161426;4773.498782627827;4662.766861656921;4726.1020406122725;4736.881577960544;4743.881402964919;4744.691595046328;4695.248760198386;4700.341952126705;4701.811927522895;4706.552877476634;4707.270373092176;4650.25595904657;4661.160991021615;4666.953330466686;4668.36977008103;4670.579647831712;4998.325226094467;5080.1363768159135;5098.388193416777;5118.897622047538;5121.180611102243;5385.676859388449;5390.407055223922;5404.675719456806;5407.351117865842;5411.945880541183;5409.702466364349;5451.48210919962;5455.1271796512765;5510.834674959718;5514.062609356419;5131.102057140023;5206.036883176586;5206.713630750345;5242.895142097137;5245.423003469616;5511.283533140666;5550.750216240279;5556.833295001156;5567.192757050286;5568.6101972862325;5313.920291195635;5335.0663633863915;5337.919931201035;5348.224507446398;5348.224507446476;5453.536449401766;5474.890502189934;5483.4516548344845;5491.835244942658;5518.144687573433;5459.481349271813;5471.781128754806;5474.069408200616;5486.067368547357;5488.094464413407;5339.839804805784;5443.129099344165;5471.124620060771;5504.394516603171;5538.141588053858;4184.644305234089;4188.8115034822895;4198.223328684142;4223.450951376363;4234.153169366139;3761.9435708464393;3776.4335349697767;3783.05423644089;3815.3704638734853;3818;5042.546170844642;5103.362079740033;5142.6914385137015;5153.871153221125;5175.534201921845;5468.562514998791;5483.287172667528;5500.532454741392;5503.862403439866;5514.310711161105;5127.87180320495;5137.346813116957;5141.228815677603;5178.741062946838;5201.817936372285;4651.162790697707;4736.360591320196;4751.952480475151;4837.467878533358;4842.443119041285;5692.1461780733225;5703;5705.258316418839;5722.799702010493;5729.914051289234;5502.257195278587;5530.281063461724;5543.473370029841;5567.109262517978;5604.971975140098;5452.482014208644;5620.606557541097;5631;5690.5163061140265;5703.173039909273;5338.839834804962;5342.519173274424;5345.518903298722;5349.545288650508;5361.892762144657;5421.701806400528;5422.945770542244;5424.213489044146;5424.755885985219;5481.205225242397;5265.2365407015;5303.549198318186;5331.626786125089;5359.490848369399;5367.570594352521;5326.280952071421;5334.546563542142;5336.985972665181;5337.54630856366;5383.031054410244;5114.181730923035;5149.665271757323;5206.687598744087;5210.452902445189;5213.530782229617;5456.508914197741;5457.61796674229;5486.6982315973;5497.752601133038;5553.361363443256;5370.060239458001;5380.973095134499;5382.165764306539;5386.811461598825;5410.48600382963 17:42:13 INFO - PROCESS | 13148 | |1;ext.html;608.9878202435951;636.9012803015532;646.589415721017;652.2368828470688;669.88277051516;28873.27816804581;29432.41135177298;34646.30707385854;36232.27535449289;36245.818770906175;36300;36940.44589331155;36979.4453083204;37014.81492592533;37045;7659.578723170252;8279.461834980722;8479.788005299886;8481.067082620906;8486.236238738513;9670.4197748135;9950.203983681324;9951.402915825074;9960.701178964606;9961.35251208669;9878.308518403715;10041.246906482043;10063.04401081896;10063.29556931015;10066.396016239049;9839.950800245988;9963.252756043326;9973.601055957753;9977.551010204557;9980.351277166998;9802.068803463659;9897.851532227023;9917.851232231522;9933.75165620858;10204.38773673582;37037.44443833345;37433;37441.43837842435;37534;37544.06139846498;3361.025302662225;3443.104792753877;3581.08682286018;3812.6568608825337;3831;26714.86642566794;27441.451170976667;28925;29529.557056644167;29956.850215748782;3715.4598553219244;3808.3906574947873;4065.695072869517;4225.218334608107;4228.830846766125;232600;232893;233112;233942;234119;54604.18093728597;54726.72636636791;54922.72538637281;54973.45026549763;54974.17538736922;51133.954641813914;51624;52269.47730522722;52486;52616;16425.425110121087;16684.24920878539;16693;16693.415730449375;16707;10195.898041019644;11831.526738930519;12247.387630618434;12268.386580670931;12272.263664180178;17584;17766.822331776777;17770.5557361067;17790.37733679315;17841;5777.6133727905;6771.830704232335;6787.490938179656;6893.827654308582;7259.201487836333;1063.9787204256027;1088.2491081153978;1151.6026970695098;1164.6855349055706;1233.0690328801697;28365.290867728472;28500;28894.566581501294;29069.709302907122;29240.26899327534;1127.768807394482;1140.2189500192394;1183.402381797187;1232.2969476722571;1243.776120298355;15368.923155384151;16153.919230403773;16322.75515867263;16486.83513164853;16551.91724041372;331312;337652;338661;338672;339210;51801.7409912948;52504.73747631237;52593.47406525962;52632.73683631558;52673.473265267625;1357.382391012087;1397.084909384355;1407.5214427094836;1423.4306277489088;1432.4198699526708;27214.183574492796;27393.863030685516;28237.57643635306;28575.856965721137;28925;39544.80227598843;39564.60435395609;39876;39908.401373978835;39945.80027099846;192446;193526;193881;193882;194979;22439.551208976056;24318.635220471355;24869.62695559532;25060.874695626404;25102;38989.415158773205;39067.6093239064;39188.80405597954;40008.399874001334;40119;33240;33383.33233335368;33862.83068584641;34225.82887085548;34560;33783.83108084444;34677.65322346845;36433.81783091067;36738;37242.62757372392;36623.26753464969;37186.25627487489;37692;37864.62135378721;38050.2389952205;32251;33129;33389.33221335511;33536;33599;25723.614145788204;25774;25864.353391165372;26266.212013639622;26482 17:42:13 INFO - PROCESS | 13148 | |2;jquery.html;392.72901697828496;392.9685625149987;395.08340649692724;408.2855003743449;411.86614350336146;16946.74579881301;17349.653006939854;17500.824991750094;17514.73727894081;18700.06499675014;14689.118652880834;16682.749758753627;17455.207166853306;17560.736588951175;17896.463106106807;5349.438308977569;5552.194931734896;5566.721663916808;5568.693721845297;5579.776808927659;5308.893822123555;5468.070428027225;5499.642523235977;5520.889582208353;5527.39198688144;5379.515843574078;5503.422140675211;5543.6119471637;5549.750261238234;5553.750081246333;5382.138857782775;5589.105743081128;5606.046972014747;5619.269494965649;5625.831225063254;5473.480019398191;5498.780048798083;5504.256925315111;5507.008738427082;5507.091329930557;12545.74908501834;12814.871851281554;12879.935600322033;12942.870571294261;12988.350582470934;2149.365937048559;2420.47959688666;2860.8426536540483;2923.269182704324;2940.7206315400003;9961.501924903798;10039.498025098716;12179.086568507397;13539.458421663121;13813.447462101503;1921.2411097616503;1964.5481539245911;2087.123408168573;2088.4152437317575;2157.244964262511;61849;63189.05216421803;63203.367966320206;65029.349706502806;66124;10669.46652667379;10732.248742587944;10897.291676041032;10902.563897444172;11031.172662050378;14290.857091428952;14493.637659058608;14557.41770329175;14579.489717859824;14588.197649129188;6552.672366381662;7586.582737949356;7731.884021739678;7817.726379576688;7956.602169891598;7320.560766354036;7456.291652293024;7505.812354691067;7593.240675932362;7650.73222437212;4671.789769460383;4796.544328288807;4807.927881081787;4839.540243676845;4851.151048566487;1939.4957311099215;1989.552350721105;1997.3708281891159;2006.1273346094495;2013.3456626596414;932.8227636748996;1001.3941565353002;1017.2370721958531;1083.4474418046852;1148.5176225985106;17617.559561011076;17872;18161.818381816014;18205.362812301504;18313.816861831478;1029.1252435429824;1034.3483605328595;1079.0180935348951;1107.1143085531703;1137.2778285788584;10053.145482633912;10392.480375981171;10433.478326083665;10442.895571044191;10504.054635082726;418751;420682;437246;444867;446429;71564.64217678983;72288.27711722921;72785.6360718193;75935.62032189804;76143;1006.7785087280787;1029.6602121299952;1032.3805716569998;1045.5713157605346;1116.5757012335423;15654.686906262039;15658.843411565738;15803;15837.604059898595;16435.72492933141;34718.82640586781;34720.131996700286;35408;35658.46512302266;36951.076223094635;34493;44624.776876115415;45905.31142032939;46587.068258635314;48182.5181748178;8255.958720206601;8378.706745263886;8397.622107005322;8594.011688655884;8594.871076933976;8858.512781797062;9293.070692930653;9880;11887.346195959306;13313.46746130144;11393.658190254306;11505.36720480348;11590.826137608112;11647.475863585989;11752.58865939688;11345.149113816662;11376.260543064674;11450.713732156762;11454.541818327507;11528.884711152781;11485.942570287096;11517.078633709116;11662.300261984308;11662.591809286634;11677.124215683687;8099.473534220257;8315.085340612406;8396.496210227406;8637.654493820177;8736.301095912439;8581.914180858112;10904.672859814218;10936.507857146607;11163.832542512031;11512.079033677453 17:42:13 INFO - PROCESS | 13148 | |3;mootools.html;1324.324998130188;1477.431188992238;1526.3665578784805;1615.8222595514492;1783.6611043901657;7204.603746793924;7826.373890088794;8039.598020099001;8049.114597394297;8050.194980501947;7819.921800781991;7970.442069055169;7975.521468711881;7985.321247693953;8041.91958080419;1948.3083505355607;2195.791399817023;2203.3610253026645;2260.570491606598;2274.80664143548;2306.285051633999;2306.538692261546;2316.2587971849016;2324.140068174769;2326.8952897119584;2154.924577639783;2198.373463562885;2203.0967303405605;2203.283932721864;2204.3386983904843;1913.5885784556317;2197.5934452126326;2269.1830940861278;2271.9204827830945;2272.5682120397237;2174.3911704722545;2177.9782202178094;2187.0923566719794;2189.6168170570086;2227.164813195052;7859.174786647434;7933.761987140338;7937.047554293464;7950.801229969239;7991.520508769434;4933.777979990909;5127.7948882044675;5134.0502007128425;5138.537531622172;5221.034108689904;3320.518524813913;3332;3418.060033490785;3455.4989526518766;3464.566929133858;1005.4218824176128;1026.0252759878147;1052.6841947415821;1076.924615276931;1094.8029354716148;10892.40091794951;10924.617638382699;10924.726881827859;10975.341479511255;11049.447527623586;4295.076558539867;4324.545922678073;4420.049689316812;4433.556644335606;4444.755538445352;9293.95353023244;9298;9313.580888860017;9321.906780932239;9362.765930851783;4488.079943611552;4973.975130124399;5089.185730283137;5098.796048158032;5103.132467480537;4247.638950689165;4263.296556068276;4271.807768650418;4479.55204479556;4677.579017888338;3721.423179407142;3807.8286477108595;3864.787436691009;3865.1303456722576;3872.3029854625875;1209.661294837447;1220.9511619535297;1234.3581337704343;1245.620085873799;1257.1891130221138;1009.3792317724547;1030.0883717909553;1033.2199189611945;1036.2073014144187;1048.1352883870836;5729.312482502127;5748.109043098327;5779.739911703983;5780.21967034445;6019.367966363557;982.5725809272989;1023.5291765787672;1024.4314405505015;1036.124474818777;1041.1046500009986;3783.0731470789833;3952.2293152834923;3998.6204759357975;4040.393940908887;4041.5150181977765;9664.75838104039;9914.752131196778;10085.798284034277;10096.798064038825;10145;9955.30312878106;9968.80062398748;10093.848592271122;10102.898971010196;10111.443870587042;7221;7520.511166774142;7604;7637.312641862148;7700.807479812937;5595.104783234663;5649.446402239417;5755.827325180251;5819.388964158702;5835.387284335084;8527.317814574695;8837.248833848938;9100.089991000847;9151.359404841598;9173.31200160004;8964.103589640983;9003.504807235666;9200.309976751636;9258.490783006999;9283.071692830934;6576.145101136822;6764.661766911733;7037.788866334018;7059.364657180673;7170.96414517945;7806.609669516388;7873.803154920944;7931.405144614292;7933.523988560705;7956;6998.405135563534;7078.044463997295;7109.893351599833;7209.891851622335;7291;7064.399526040344;7101.360877521048;7106.715731370894;7180.102487189101;7183.568985860656;6594.439472644879;6726.327367263235;6873.725050998104;6890.8621827564175;6904.27505111956;5134.075866344094;5147.510986456281;5161.948380516147;5163.66436181647;5186.974065129651;5105.157648987875;5138;5148.330717006766;5219.243209734491;5307.097793375058 17:42:13 INFO - PROCESS | 13148 | |4;prototype.html;326.1422458933006;335.1403649638677;337.0512008695522;342.3649130862251;343.77826302035203;5197.818076367328;5249;5302.840914772563;5349.144136938091;5362.168863826103;5311.336082989626;5380.139177731564;5399;5409.540189083923;5422.240886275915;4196.097838964622;4197.916041679165;4201.6218540331365;4206.242876282268;4235.555266696999;3955.3671412573995;3987.7607343559334;4186.818018306094;4213.536510983789;4240.957590424087;4106;4140.648044916185;4178.080822219107;4188.329867221245;4189.727667701605;4131.211432283212;4147;4159.147374788161;4162.188373267214;4182.707210495267;3431.3995050865997;3701.0192299040777;3712.2389910068373;3714.201446688975;3726.6273372662786;5096.159133742928;5127.8205262816;5137.768800403991;5138.922916156261;5145.794168233266;4699.177643912301;4717.561143851124;4721.3862197914395;4748.928766068511;4757.952420475785;5411.485908838654;5530.598681810698;5533.667979921218;5550.611457197998;5564.610477266593;4001.1197536541913;4004.139110091315;4005.439238506611;4009.218202450523;4014.1770936958146;5824.563157763185;5857.7949771757785;5877.147813567051;5887.234659494238;5888.499477544414;3956.2680904032845;4100.876973690794;4105.835766569364;4118.546959834416;4142.71001029925;4101.733387329814;4114.650254728322;4136.73111247768;4144.896377590584;4178.749275043507;4750.904981900343;4752.928706069411;4760.833370832004;4765.142274390643;4769.213079841857;5529.364123125892;5649.570684605577;5673.347565030074;5680.943190568041;5681.346645135863;1493.887958403124;1494.6935878144955;1494.7085318362815;1498.6178524476188;1502.8722558582424;949.6913503111379;952.3904700991371;957.3872721458272;957.712686194139;962.2061799015839;5727.570432217601;5763.2507773989955;5765.913511297334;5773.711314434261;5778.94221057784;6122.510199184144;6124.755009799647;6126.5098792097415;6183.96908015457;6221.129041934133;5511.476409741068;5687.8862422752145;5725.456081672234;5732.828015159552;5746.367899531048;3270.689284517967;3286.309874926292;3287.6547962464074;3292.37444885471;3294.9835250823594;5736.971315143398;6028.186194863637;6286.962651162598;6317.084022816666;6373.71318290678;5939.287285525765;5957.761689532457;5964.105384192406;5978.641281523122;5990.101484777319;5973.37279585646;5978.671173085522;5994.490468310242;6014.72933717975;6040.6979651018155;5638.434512296813;5803.970980145073;5816.21481100063;5828.222392170429;5862.325832529314;5674.659520428788;5702.486776190163;5723;5733;5761.798337058183;5820.82537523875;5976.760929562769;6003.309619393825;6004.609700369462;6008.489278411384;3876.961230387773;3922.5096862892137;4067.450894129373;4093.2222877653153;4114.156597897364;5778.422157784356;5780.21967034445;5806.854828629149;5807;5808.448197421239;5468.863278418072;5569.972150139223;5640.266765320482;5643.209950606836;5647.192898272678;5562.610617256753;5590.664560126405;5598.1169697604955;5601.859953501195;5635.154726791015;5418.674879507243;5450.8909821802545;5454.699991500505;5484.8354549363585;5491.341039075336;5369.919451208313;5635.577331700057;5638;5664.971675141598;5775.711214439178;5618.550515958796;5619.887602247851;5626.156076588544;5647.85880352978;5655.858603534944 17:42:13 INFO - PROCESS | 13148 | |5;yui.html;734.599643194459;802.1016461563047;831.1729828820323;860.5955201055501;883.5847151838634;14015.719685606282;14094.295285235736;14746.926265368671;15002.399904003854;15020.098794072363;13702.657433564165;13767.65580860479;13769.311534423265;13774.10468319561;13834.515791947284;706.4066184405086;724.9057622509066;727.4435057181234;727.6907314391389;816.5182542300042;851.7189327521934;859.0593300336122;859.4499520307008;859.8581234096366;859.8882145321099;898.2095755734944;901.5086777706133;902.6434558349448;902.9548522573878;903.1961554216753;731.7182884589419;869.8738682891009;889.0975659705405;897.4974014551839;898.2768871058828;653.3042309939899;653.5098675993005;653.7613770973608;659.4394764450227;664.8969409741497;14014.649633759136;14080.014398991972;14088.506902258474;14098.083624564371;14106.858931410658;12999.545015924397;13373.732525349536;13525.932370338085;13643.727125457435;13881.305934703225;11252.437378131142;11375.374354410504;11499.885001150049;11698.122640801888;11756.706082347924;4265;4334.219840428722;4386.6929314947965;4526.909461810778;4538.841140560097;46700.76649616764;47267;47461;48363;51838.481615183744;9614.423134611945;9723.951380243054;9945.104940555384;10072.697819065439;10199.643012494527;18513.166907489194;18570.164342604614;18592.628147436975;18640;19032.33386831454;7768.6629602309995;8004.759857204293;8042.798930026796;8145.755627331189;8386.412951093365;4534.478534968521;4572.108438854458;4602.953970460319;4605.516420775771;4795.832145874878;3270.198801293698;3324.1357247115925;3325.93348133036;3327.1183136468853;3333.283344081034;681.4344094401634;684.8664510420421;693.1439672005171;693.414065114977;700.9474289428314;597.6175247841385;633.3096924352478;660.7092879133166;674.5177198303237;684.8253695307765;9541.761455963517;9618.951905240428;9799.314048016571;10054.245931555017;10120.291579589359;665.0157766505503;690.002945743396;776.5301992294693;787.1577412169039;790.205843127653;4000.9399859002137;4225.281702110648;4345.261305578059;4375.190589740844;4414.602685758297;64396.678016609614;65104;65812.67093664501;66204;67341;56148.157777633365;57012.42987570154;57176.71411642998;57300.42699572951;59412;44440;44833;45200.321995170096;45814;52722.73638631859;9012.369134160546;9088.272938165062;9109.316801239802;9210.401323913924;9242.168204861595;32461.675383245863;32666.673333266364;33387.332253355286;33688.66311336855;33791;41779.37330940099;43657;44041.339379908684;44086.55913440953;46716.299255511876;12018.158728888893;12158.939205303917;12256.632301030982;12300.507979680713;12430.751384972069;13167.473301068234;14003.789943150658;14323;14573.708525829636;14849.886258530438;13452.192868427926;13486.595402137951;13906.860931390556;13942.372593233125;14325.355359009078;13136.474541018251;13382.598522044354;13865.86134138686;13917.791233131713;14121.2939353034;12909.806352904901;13042.152260103063;13305.467781289028;14093.15441073539;14113.22377269219;11055.22613417053;11127.88872111301;11232.213745037769;11394.088472922313;11559.30644161353;11169.535288258076;11474.770504589695;11519.712007199887;11566.884331156582;11617.535298587962 17:42:13 INFO - PROCESS | 13148 | __end_tp_report 17:42:13 INFO - PROCESS | 13148 | __start_cc_report 17:42:13 INFO - PROCESS | 13148 | _x_x_mozilla_cycle_collect,795 17:42:13 INFO - PROCESS | 13148 | __end_cc_report 17:42:13 INFO - PROCESS | 13148 | __startTimestamp1461717733344__endTimestamp 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | ------- Summary: start ------- 17:42:13 INFO - PROCESS | 13148 | Number of tests: 6 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | [#0] dojo.html Cycles:165 Average:5101.78 Median:5313.92 stddev:548.25 (10.3%) stddev-sans-first:525.67 17:42:13 INFO - PROCESS | 13148 | Values: 3045.9 3088.2 3150.4 3153.8 3160.3 5144.6 5177.0 5180.8 5213.8 5222.6 5070.2 5136.8 5197.9 5210.9 5233.4 4619.7 4624.2 4631.8 4708.8 4773.0 4714.8 4716.3 4728.4 4733.4 4773.5 4662.8 4726.1 4736.9 4743.9 4744.7 4695.2 4700.3 4701.8 4706.6 4707.3 4650.3 4661.2 4667.0 4668.4 4670.6 4998.3 5080.1 5098.4 5118.9 5121.2 5385.7 5390.4 5404.7 5407.4 5411.9 5409.7 5451.5 5455.1 5510.8 5514.1 5131.1 5206.0 5206.7 5242.9 5245.4 5511.3 5550.8 5556.8 5567.2 5568.6 5313.9 5335.1 5337.9 5348.2 5348.2 5453.5 5474.9 5483.5 5491.8 5518.1 5459.5 5471.8 5474.1 5486.1 5488.1 5339.8 5443.1 5471.1 5504.4 5538.1 4184.6 4188.8 4198.2 4223.5 4234.2 3761.9 3776.4 3783.1 3815.4 3818.0 5042.5 5103.4 5142.7 5153.9 5175.5 5468.6 5483.3 5500.5 5503.9 5514.3 5127.9 5137.3 5141.2 5178.7 5201.8 4651.2 4736.4 4752.0 4837.5 4842.4 5692.1 5703.0 5705.3 5722.8 5729.9 5502.3 5530.3 5543.5 5567.1 5605.0 5452.5 5620.6 5631.0 5690.5 5703.2 5338.8 5342.5 5345.5 5349.5 5361.9 5421.7 5422.9 5424.2 5424.8 5481.2 5265.2 5303.5 5331.6 5359.5 5367.6 5326.3 5334.5 5337.0 5337.5 5383.0 5114.2 5149.7 5206.7 5210.5 5213.5 5456.5 5457.6 5486.7 5497.8 5553.4 5370.1 5381.0 5382.2 5386.8 5410.5 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | [#1] ext.html Cycles:180 Average:42090.29 Median:338941.00 stddev:68400.31 (20.2%) stddev-sans-first:68521.28 17:42:13 INFO - PROCESS | 13148 | Values: 609.0 636.9 646.6 652.2 669.9 28873.3 29432.4 34646.3 36232.3 36245.8 36300.0 36940.4 36979.4 37014.8 37045.0 7659.6 8279.5 8479.8 8481.1 8486.2 9670.4 9950.2 9951.4 9960.7 9961.4 9878.3 10041.2 10063.0 10063.3 10066.4 9840.0 9963.3 9973.6 9977.6 9980.4 9802.1 9897.9 9917.9 9933.8 10204.4 37037.4 37433.0 37441.4 37534.0 37544.1 3361.0 3443.1 3581.1 3812.7 3831.0 26714.9 27441.5 28925.0 29529.6 29956.9 3715.5 3808.4 4065.7 4225.2 4228.8 232600.0 232893.0 233112.0 233942.0 234119.0 54604.2 54726.7 54922.7 54973.5 54974.2 51134.0 51624.0 52269.5 52486.0 52616.0 16425.4 16684.2 16693.0 16693.4 16707.0 10195.9 11831.5 12247.4 12268.4 12272.3 17584.0 17766.8 17770.6 17790.4 17841.0 5777.6 6771.8 6787.5 6893.8 7259.2 1064.0 1088.2 1151.6 1164.7 1233.1 28365.3 28500.0 28894.6 29069.7 29240.3 1127.8 1140.2 1183.4 1232.3 1243.8 15368.9 16153.9 16322.8 16486.8 16551.9 331312.0 337652.0 338661.0 338672.0 339210.0 51801.7 52504.7 52593.5 52632.7 52673.5 1357.4 1397.1 1407.5 1423.4 1432.4 27214.2 27393.9 28237.6 28575.9 28925.0 39544.8 39564.6 39876.0 39908.4 39945.8 192446.0 193526.0 193881.0 193882.0 194979.0 22439.6 24318.6 24869.6 25060.9 25102.0 38989.4 39067.6 39188.8 40008.4 40119.0 33240.0 33383.3 33862.8 34225.8 34560.0 33783.8 34677.7 36433.8 36738.0 37242.6 36623.3 37186.3 37692.0 37864.6 38050.2 32251.0 33129.0 33389.3 33536.0 33599.0 25723.6 25774.0 25864.4 26266.2 26482.0 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | [#2] jquery.html Cycles:180 Average:25274.66 Median:2640.66 stddev:71081.76 (2691.8%) stddev-sans-first:71256.61 17:42:13 INFO - PROCESS | 13148 | Values: 392.7 393.0 395.1 408.3 411.9 16946.7 17349.7 17500.8 17514.7 18700.1 14689.1 16682.7 17455.2 17560.7 17896.5 5349.4 5552.2 5566.7 5568.7 5579.8 5308.9 5468.1 5499.6 5520.9 5527.4 5379.5 5503.4 5543.6 5549.8 5553.8 5382.1 5589.1 5606.0 5619.3 5625.8 5473.5 5498.8 5504.3 5507.0 5507.1 12545.7 12814.9 12879.9 12942.9 12988.4 2149.4 2420.5 2860.8 2923.3 2940.7 9961.5 10039.5 12179.1 13539.5 13813.4 1921.2 1964.5 2087.1 2088.4 2157.2 61849.0 63189.1 63203.4 65029.3 66124.0 10669.5 10732.2 10897.3 10902.6 11031.2 14290.9 14493.6 14557.4 14579.5 14588.2 6552.7 7586.6 7731.9 7817.7 7956.6 7320.6 7456.3 7505.8 7593.2 7650.7 4671.8 4796.5 4807.9 4839.5 4851.2 1939.5 1989.6 1997.4 2006.1 2013.3 932.8 1001.4 1017.2 1083.4 1148.5 17617.6 17872.0 18161.8 18205.4 18313.8 1029.1 1034.3 1079.0 1107.1 1137.3 10053.1 10392.5 10433.5 10442.9 10504.1 418751.0 420682.0 437246.0 444867.0 446429.0 71564.6 72288.3 72785.6 75935.6 76143.0 1006.8 1029.7 1032.4 1045.6 1116.6 15654.7 15658.8 15803.0 15837.6 16435.7 34718.8 34720.1 35408.0 35658.5 36951.1 34493.0 44624.8 45905.3 46587.1 48182.5 8256.0 8378.7 8397.6 8594.0 8594.9 8858.5 9293.1 9880.0 11887.3 13313.5 11393.7 11505.4 11590.8 11647.5 11752.6 11345.1 11376.3 11450.7 11454.5 11528.9 11485.9 11517.1 11662.3 11662.6 11677.1 8099.5 8315.1 8396.5 8637.7 8736.3 8581.9 10904.7 10936.5 11163.8 11512.1 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | [#3] mootools.html Cycles:180 Average:5399.94 Median:5104.15 stddev:2930.42 (57.4%) stddev-sans-first:2922.63 17:42:13 INFO - PROCESS | 13148 | Values: 1324.3 1477.4 1526.4 1615.8 1783.7 7204.6 7826.4 8039.6 8049.1 8050.2 7819.9 7970.4 7975.5 7985.3 8041.9 1948.3 2195.8 2203.4 2260.6 2274.8 2306.3 2306.5 2316.3 2324.1 2326.9 2154.9 2198.4 2203.1 2203.3 2204.3 1913.6 2197.6 2269.2 2271.9 2272.6 2174.4 2178.0 2187.1 2189.6 2227.2 7859.2 7933.8 7937.0 7950.8 7991.5 4933.8 5127.8 5134.1 5138.5 5221.0 3320.5 3332.0 3418.1 3455.5 3464.6 1005.4 1026.0 1052.7 1076.9 1094.8 10892.4 10924.6 10924.7 10975.3 11049.4 4295.1 4324.5 4420.0 4433.6 4444.8 9294.0 9298.0 9313.6 9321.9 9362.8 4488.1 4974.0 5089.2 5098.8 5103.1 4247.6 4263.3 4271.8 4479.6 4677.6 3721.4 3807.8 3864.8 3865.1 3872.3 1209.7 1221.0 1234.4 1245.6 1257.2 1009.4 1030.1 1033.2 1036.2 1048.1 5729.3 5748.1 5779.7 5780.2 6019.4 982.6 1023.5 1024.4 1036.1 1041.1 3783.1 3952.2 3998.6 4040.4 4041.5 9664.8 9914.8 10085.8 10096.8 10145.0 9955.3 9968.8 10093.8 10102.9 10111.4 7221.0 7520.5 7604.0 7637.3 7700.8 5595.1 5649.4 5755.8 5819.4 5835.4 8527.3 8837.2 9100.1 9151.4 9173.3 8964.1 9003.5 9200.3 9258.5 9283.1 6576.1 6764.7 7037.8 7059.4 7171.0 7806.6 7873.8 7931.4 7933.5 7956.0 6998.4 7078.0 7109.9 7209.9 7291.0 7064.4 7101.4 7106.7 7180.1 7183.6 6594.4 6726.3 6873.7 6890.9 6904.3 5134.1 5147.5 5161.9 5163.7 5187.0 5105.2 5138.0 5148.3 5219.2 5307.1 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | [#4] prototype.html Cycles:180 Average:4772.86 Median:5476.85 stddev:1414.53 (25.8%) stddev-sans-first:1378.56 17:42:13 INFO - PROCESS | 13148 | Values: 326.1 335.1 337.1 342.4 343.8 5197.8 5249.0 5302.8 5349.1 5362.2 5311.3 5380.1 5399.0 5409.5 5422.2 4196.1 4197.9 4201.6 4206.2 4235.6 3955.4 3987.8 4186.8 4213.5 4241.0 4106.0 4140.6 4178.1 4188.3 4189.7 4131.2 4147.0 4159.1 4162.2 4182.7 3431.4 3701.0 3712.2 3714.2 3726.6 5096.2 5127.8 5137.8 5138.9 5145.8 4699.2 4717.6 4721.4 4748.9 4758.0 5411.5 5530.6 5533.7 5550.6 5564.6 4001.1 4004.1 4005.4 4009.2 4014.2 5824.6 5857.8 5877.1 5887.2 5888.5 3956.3 4100.9 4105.8 4118.5 4142.7 4101.7 4114.7 4136.7 4144.9 4178.7 4750.9 4752.9 4760.8 4765.1 4769.2 5529.4 5649.6 5673.3 5680.9 5681.3 1493.9 1494.7 1494.7 1498.6 1502.9 949.7 952.4 957.4 957.7 962.2 5727.6 5763.3 5765.9 5773.7 5778.9 6122.5 6124.8 6126.5 6184.0 6221.1 5511.5 5687.9 5725.5 5732.8 5746.4 3270.7 3286.3 3287.7 3292.4 3295.0 5737.0 6028.2 6287.0 6317.1 6373.7 5939.3 5957.8 5964.1 5978.6 5990.1 5973.4 5978.7 5994.5 6014.7 6040.7 5638.4 5804.0 5816.2 5828.2 5862.3 5674.7 5702.5 5723.0 5733.0 5761.8 5820.8 5976.8 6003.3 6004.6 6008.5 3877.0 3922.5 4067.5 4093.2 4114.2 5778.4 5780.2 5806.9 5807.0 5808.4 5468.9 5570.0 5640.3 5643.2 5647.2 5562.6 5590.7 5598.1 5601.9 5635.2 5418.7 5450.9 5454.7 5484.8 5491.3 5369.9 5635.6 5638.0 5665.0 5775.7 5618.6 5619.9 5626.2 5647.9 5655.9 17:42:13 INFO - PROCESS | 13148 | 17:42:13 INFO - PROCESS | 13148 | [#5] yui.html Cycles:180 Average:14780.56 Median:24427.30 stddev:16861.75 (69.0%) stddev-sans-first:16876.06 17:42:13 INFO - PROCESS | 13148 | Values: 734.6 802.1 831.2 860.6 883.6 14015.7 14094.3 14746.9 15002.4 15020.1 13702.7 13767.7 13769.3 13774.1 13834.5 706.4 724.9 727.4 727.7 816.5 851.7 859.1 859.4 859.9 859.9 898.2 901.5 902.6 903.0 903.2 731.7 869.9 889.1 897.5 898.3 653.3 653.5 653.8 659.4 664.9 14014.6 14080.0 14088.5 14098.1 14106.9 12999.5 13373.7 13525.9 13643.7 13881.3 11252.4 11375.4 11499.9 11698.1 11756.7 4265.0 4334.2 4386.7 4526.9 4538.8 46700.8 47267.0 47461.0 48363.0 51838.5 9614.4 9724.0 9945.1 10072.7 10199.6 18513.2 18570.2 18592.6 18640.0 19032.3 7768.7 8004.8 8042.8 8145.8 8386.4 4534.5 4572.1 4603.0 4605.5 4795.8 3270.2 3324.1 3325.9 3327.1 3333.3 681.4 684.9 693.1 693.4 700.9 597.6 633.3 660.7 674.5 684.8 9541.8 9619.0 9799.3 10054.2 10120.3 665.0 690.0 776.5 787.2 790.2 4000.9 4225.3 4345.3 4375.2 4414.6 64396.7 65104.0 65812.7 66204.0 67341.0 56148.2 57012.4 57176.7 57300.4 59412.0 44440.0 44833.0 45200.3 45814.0 52722.7 9012.4 9088.3 9109.3 9210.4 9242.2 32461.7 32666.7 33387.3 33688.7 33791.0 41779.4 43657.0 44041.3 44086.6 46716.3 12018.2 12158.9 12256.6 12300.5 12430.8 13167.5 14003.8 14323.0 14573.7 14849.9 13452.2 13486.6 13906.9 13942.4 14325.4 13136.5 13382.6 13865.9 13917.8 14121.3 12909.8 13042.2 13305.5 14093.2 14113.2 11055.2 11127.9 11232.2 11394.1 11559.3 11169.5 11474.8 11519.7 11566.9 11617.5 17:42:13 INFO - PROCESS | 13148 | -------- Summary: end -------- 17:42:13 INFO - PROCESS | 13148 | 17:42:14 INFO - TEST-INFO | 13148: exit 0 17:42:14 INFO - TEST-OK | dromaeo_css | took 1112178ms 17:42:14 INFO - TEST-START | kraken 17:42:14 INFO - operating with platform_type : linux_ 17:42:14 INFO - Initialising browser for kraken test... 17:42:14 INFO - TEST-INFO | started process 13329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdrJe9m/profile http://localhost:50415/getInfo.html) 17:42:18 INFO - PROCESS | 13329 | __metrics Screen width/height:1600/1200 17:42:18 INFO - PROCESS | 13329 | colorDepth:24 17:42:18 INFO - PROCESS | 13329 | Browser inner width/height: 1024/697 17:42:18 INFO - PROCESS | 13329 | __metrics 17:42:19 ERROR - PROCESS | 13329 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:42:19 INFO - TEST-INFO | 13329: exit 0 17:42:19 INFO - Browser initialized. 17:42:19 INFO - Running cycle 1/1 for kraken test... 17:42:19 INFO - TEST-INFO | started process 13411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdrJe9m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:31 INFO - PROCESS | 13411 | RSS: Main: 154419200 17:42:31 INFO - PROCESS | 13411 | 17:42:34 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50415/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:35 INFO - PROCESS | 13411 | RSS: Main: 209543168 17:42:35 INFO - PROCESS | 13411 | 17:42:37 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50415/tests/kraken/driver.html?testName=audio-dft) 17:42:38 INFO - PROCESS | 13411 | RSS: Main: 194715648 17:42:38 INFO - PROCESS | 13411 | 17:42:41 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50415/tests/kraken/driver.html?testName=audio-fft) 17:42:42 INFO - PROCESS | 13411 | RSS: Main: 266739712 17:42:42 INFO - PROCESS | 13411 | 17:42:44 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50415/tests/kraken/driver.html?testName=audio-oscillator) 17:42:44 INFO - PROCESS | 13411 | RSS: Main: 174383104 17:42:44 INFO - PROCESS | 13411 | 17:42:46 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:47 INFO - PROCESS | 13411 | RSS: Main: 178331648 17:42:47 INFO - PROCESS | 13411 | 17:42:50 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50415/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:51 INFO - PROCESS | 13411 | RSS: Main: 214859776 17:42:51 INFO - PROCESS | 13411 | 17:42:54 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50415/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:54 INFO - PROCESS | 13411 | RSS: Main: 215457792 17:42:54 INFO - PROCESS | 13411 | 17:42:57 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50415/tests/kraken/driver.html?testName=json-parse-financial) 17:42:58 INFO - PROCESS | 13411 | RSS: Main: 215371776 17:42:58 INFO - PROCESS | 13411 | 17:42:59 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:43:00 INFO - PROCESS | 13411 | RSS: Main: 203980800 17:43:00 INFO - PROCESS | 13411 | 17:43:02 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:43:02 INFO - PROCESS | 13411 | RSS: Main: 203472896 17:43:02 INFO - PROCESS | 13411 | 17:43:04 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:43:05 INFO - PROCESS | 13411 | RSS: Main: 216039424 17:43:05 INFO - PROCESS | 13411 | 17:43:08 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:43:08 INFO - PROCESS | 13411 | RSS: Main: 222560256 17:43:08 INFO - PROCESS | 13411 | 17:43:11 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:43:12 INFO - PROCESS | 13411 | RSS: Main: 218382336 17:43:12 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | Cycle 1(1): loaded http://localhost:50415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50415/tests/kraken/driver.html?testName=ai-astar) 17:43:14 INFO - PROCESS | 13411 | RSS: Main: 282468352 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | __start_tp_report 17:43:14 INFO - PROCESS | 13411 | _x_x_mozilla_page_load 17:43:14 INFO - PROCESS | 13411 | _x_x_mozilla_page_load_details 17:43:14 INFO - PROCESS | 13411 | |i|pagename|runs| 17:43:14 INFO - PROCESS | 13411 | |0;ai-astar;110;111;105;109;112;109;102;111;111;109 17:43:14 INFO - PROCESS | 13411 | |1;audio-beat-detection;153;128;155;194;129;161;156;135;187;126 17:43:14 INFO - PROCESS | 13411 | |2;audio-dft;161;161;161;161;162;161;161;162;160;161 17:43:14 INFO - PROCESS | 13411 | |3;audio-fft;73;76;118;115;76;73;77;112;104;74 17:43:14 INFO - PROCESS | 13411 | |4;audio-oscillator;94;92;149;92;92;93;149;93;93;153 17:43:14 INFO - PROCESS | 13411 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;118;116;116 17:43:14 INFO - PROCESS | 13411 | |6;imaging-darkroom;146;145;145;145;145;145;145;147;145;146 17:43:14 INFO - PROCESS | 13411 | |7;imaging-desaturate;95;94;95;95;95;94;94;94;95;94 17:43:14 INFO - PROCESS | 13411 | |8;json-parse-financial;57;57;58;57;58;58;58;75;56;55 17:43:14 INFO - PROCESS | 13411 | |9;json-stringify-tinderbox;61;61;61;61;61;61;63;61;61;61 17:43:14 INFO - PROCESS | 13411 | |10;stanford-crypto-aes;76;75;84;76;78;78;77;76;82;82 17:43:14 INFO - PROCESS | 13411 | |11;stanford-crypto-ccm;141;128;126;126;125;124;126;128;159;135 17:43:14 INFO - PROCESS | 13411 | |12;stanford-crypto-pbkdf2;204;198;201;203;204;200;202;201;221;204 17:43:14 INFO - PROCESS | 13411 | |13;stanford-crypto-sha256-iterative;72;70;71;71;68;68;67;68;76;67 17:43:14 INFO - PROCESS | 13411 | __end_tp_report 17:43:14 INFO - PROCESS | 13411 | __start_cc_report 17:43:14 INFO - PROCESS | 13411 | _x_x_mozilla_cycle_collect,1614 17:43:14 INFO - PROCESS | 13411 | __end_cc_report 17:43:14 INFO - PROCESS | 13411 | __startTimestamp1461717794423__endTimestamp 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | ------- Summary: start ------- 17:43:14 INFO - PROCESS | 13411 | Number of tests: 14 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.11 (2.8%) stddev-sans-first:3.27 17:43:14 INFO - PROCESS | 13411 | Values: 110.0 111.0 105.0 109.0 112.0 109.0 102.0 111.0 111.0 109.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:155.50 stddev:23.95 (15.4%) stddev-sans-first:25.41 17:43:14 INFO - PROCESS | 13411 | Values: 153.0 128.0 155.0 194.0 129.0 161.0 156.0 135.0 187.0 126.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:43:14 INFO - PROCESS | 13411 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 160.0 161.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#3] audio-fft Cycles:10 Average:89.80 Median:73.50 stddev:19.67 (26.8%) stddev-sans-first:19.91 17:43:14 INFO - PROCESS | 13411 | Values: 73.0 76.0 118.0 115.0 76.0 73.0 77.0 112.0 104.0 74.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.50 stddev:27.86 (30.1%) stddev-sans-first:28.94 17:43:14 INFO - PROCESS | 13411 | Values: 94.0 92.0 149.0 92.0 92.0 93.0 149.0 93.0 93.0 153.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 17:43:14 INFO - PROCESS | 13411 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 116.0 116.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 17:43:14 INFO - PROCESS | 13411 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 146.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 17:43:14 INFO - PROCESS | 13411 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.00 stddev:5.74 (9.9%) stddev-sans-first:6.05 17:43:14 INFO - PROCESS | 13411 | Values: 57.0 57.0 58.0 57.0 58.0 58.0 58.0 75.0 56.0 55.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:43:14 INFO - PROCESS | 13411 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 63.0 61.0 61.0 61.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:3.13 (4.0%) stddev-sans-first:3.20 17:43:14 INFO - PROCESS | 13411 | Values: 76.0 75.0 84.0 76.0 78.0 78.0 77.0 76.0 82.0 82.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:128.00 stddev:10.91 (8.5%) stddev-sans-first:11.05 17:43:14 INFO - PROCESS | 13411 | Values: 141.0 128.0 126.0 126.0 125.0 124.0 126.0 128.0 159.0 135.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.80 Median:203.50 stddev:6.36 (3.1%) stddev-sans-first:6.74 17:43:14 INFO - PROCESS | 13411 | Values: 204.0 198.0 201.0 203.0 204.0 200.0 202.0 201.0 221.0 204.0 17:43:14 INFO - PROCESS | 13411 | 17:43:14 INFO - PROCESS | 13411 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:2.82 (4.0%) stddev-sans-first:2.88 17:43:14 INFO - PROCESS | 13411 | Values: 72.0 70.0 71.0 71.0 68.0 68.0 67.0 68.0 76.0 67.0 17:43:14 INFO - PROCESS | 13411 | -------- Summary: end -------- 17:43:14 INFO - PROCESS | 13411 | 17:43:15 INFO - TEST-INFO | 13411: exit 0 17:43:15 INFO - TEST-OK | kraken | took 61302ms 17:43:15 INFO - SUITE-END | took 1173s 17:43:15 INFO - Completed test suite (00:19:33) 17:43:15 INFO - javascript benchmark 17:43:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.9390812183756, 3088.2125058110178, 3150.4014237294896, 3153.810771353719, 3160.273137178449, 5144.61415393846, 5176.974115129424, 5180.792768289273, 5213.843584692456, 5222.556082732963, 5070.214116811891, 5136.845894623168, 5197.948020519793, 5210.921836172461, 5233.398159211692, 4619.69971951822, 4624.190766615837, 4631.8147274109, 4708.7645617719145, 4773.021530586221, 4714.811407543694, 4716.292556116576, 4728.432588089417, 4733.431988161426, 4773.498782627827, 4662.766861656921, 4726.1020406122725, 4736.881577960544, 4743.881402964919, 4744.691595046328, 4695.248760198386, 4700.341952126705, 4701.811927522895, 4706.552877476634, 4707.270373092176, 4650.25595904657, 4661.160991021615, 4666.953330466686, 4668.36977008103, 4670.579647831712, 4998.325226094467, 5080.1363768159135, 5098.388193416777, 5118.897622047538, 5121.180611102243, 5385.676859388449, 5390.407055223922, 5404.675719456806, 5407.351117865842, 5411.945880541183, 5409.702466364349, 5451.48210919962, 5455.1271796512765, 5510.834674959718, 5514.062609356419, 5131.102057140023, 5206.036883176586, 5206.713630750345, 5242.895142097137, 5245.423003469616, 5511.283533140666, 5550.750216240279, 5556.833295001156, 5567.192757050286, 5568.6101972862325, 5313.920291195635, 5335.0663633863915, 5337.919931201035, 5348.224507446398, 5348.224507446476, 5453.536449401766, 5474.890502189934, 5483.4516548344845, 5491.835244942658, 5518.144687573433, 5459.481349271813, 5471.781128754806, 5474.069408200616, 5486.067368547357, 5488.094464413407, 5339.839804805784, 5443.129099344165, 5471.124620060771, 5504.394516603171, 5538.141588053858, 4184.644305234089, 4188.8115034822895, 4198.223328684142, 4223.450951376363, 4234.153169366139, 3761.9435708464393, 3776.4335349697767, 3783.05423644089, 3815.3704638734853, 3818.0, 5042.546170844642, 5103.362079740033, 5142.6914385137015, 5153.871153221125, 5175.534201921845, 5468.562514998791, 5483.287172667528, 5500.532454741392, 5503.862403439866, 5514.310711161105, 5127.87180320495, 5137.346813116957, 5141.228815677603, 5178.741062946838, 5201.817936372285, 4651.162790697707, 4736.360591320196, 4751.952480475151, 4837.467878533358, 4842.443119041285, 5692.1461780733225, 5703.0, 5705.258316418839, 5722.799702010493, 5729.914051289234, 5502.257195278587, 5530.281063461724, 5543.473370029841, 5567.109262517978, 5604.971975140098, 5452.482014208644, 5620.606557541097, 5631.0, 5690.5163061140265, 5703.173039909273, 5338.839834804962, 5342.519173274424, 5345.518903298722, 5349.545288650508, 5361.892762144657, 5421.701806400528, 5422.945770542244, 5424.213489044146, 5424.755885985219, 5481.205225242397, 5265.2365407015, 5303.549198318186, 5331.626786125089, 5359.490848369399, 5367.570594352521, 5326.280952071421, 5334.546563542142, 5336.985972665181, 5337.54630856366, 5383.031054410244, 5114.181730923035, 5149.665271757323, 5206.687598744087, 5210.452902445189, 5213.530782229617, 5456.508914197741, 5457.61796674229, 5486.6982315973, 5497.752601133038, 5553.361363443256, 5370.060239458001, 5380.973095134499, 5382.165764306539, 5386.811461598825, 5410.48600382963], "value": 5067.263171996656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.9878202435951, 636.9012803015532, 646.589415721017, 652.2368828470688, 669.88277051516, 28873.27816804581, 29432.41135177298, 34646.30707385854, 36232.27535449289, 36245.818770906175, 36300.0, 36940.44589331155, 36979.4453083204, 37014.81492592533, 37045.0, 7659.578723170252, 8279.461834980722, 8479.788005299886, 8481.067082620906, 8486.236238738513, 9670.4197748135, 9950.203983681324, 9951.402915825074, 9960.701178964606, 9961.35251208669, 9878.308518403715, 10041.246906482043, 10063.04401081896, 10063.29556931015, 10066.396016239049, 9839.950800245988, 9963.252756043326, 9973.601055957753, 9977.551010204557, 9980.351277166998, 9802.068803463659, 9897.851532227023, 9917.851232231522, 9933.75165620858, 10204.38773673582, 37037.44443833345, 37433.0, 37441.43837842435, 37534.0, 37544.06139846498, 3361.025302662225, 3443.104792753877, 3581.08682286018, 3812.6568608825337, 3831.0, 26714.86642566794, 27441.451170976667, 28925.0, 29529.557056644167, 29956.850215748782, 3715.4598553219244, 3808.3906574947873, 4065.695072869517, 4225.218334608107, 4228.830846766125, 232600.0, 232893.0, 233112.0, 233942.0, 234119.0, 54604.18093728597, 54726.72636636791, 54922.72538637281, 54973.45026549763, 54974.17538736922, 51133.954641813914, 51624.0, 52269.47730522722, 52486.0, 52616.0, 16425.425110121087, 16684.24920878539, 16693.0, 16693.415730449375, 16707.0, 10195.898041019644, 11831.526738930519, 12247.387630618434, 12268.386580670931, 12272.263664180178, 17584.0, 17766.822331776777, 17770.5557361067, 17790.37733679315, 17841.0, 5777.6133727905, 6771.830704232335, 6787.490938179656, 6893.827654308582, 7259.201487836333, 1063.9787204256027, 1088.2491081153978, 1151.6026970695098, 1164.6855349055706, 1233.0690328801697, 28365.290867728472, 28500.0, 28894.566581501294, 29069.709302907122, 29240.26899327534, 1127.768807394482, 1140.2189500192394, 1183.402381797187, 1232.2969476722571, 1243.776120298355, 15368.923155384151, 16153.919230403773, 16322.75515867263, 16486.83513164853, 16551.91724041372, 331312.0, 337652.0, 338661.0, 338672.0, 339210.0, 51801.7409912948, 52504.73747631237, 52593.47406525962, 52632.73683631558, 52673.473265267625, 1357.382391012087, 1397.084909384355, 1407.5214427094836, 1423.4306277489088, 1432.4198699526708, 27214.183574492796, 27393.863030685516, 28237.57643635306, 28575.856965721137, 28925.0, 39544.80227598843, 39564.60435395609, 39876.0, 39908.401373978835, 39945.80027099846, 192446.0, 193526.0, 193881.0, 193882.0, 194979.0, 22439.551208976056, 24318.635220471355, 24869.62695559532, 25060.874695626404, 25102.0, 38989.415158773205, 39067.6093239064, 39188.80405597954, 40008.399874001334, 40119.0, 33240.0, 33383.33233335368, 33862.83068584641, 34225.82887085548, 34560.0, 33783.83108084444, 34677.65322346845, 36433.81783091067, 36738.0, 37242.62757372392, 36623.26753464969, 37186.25627487489, 37692.0, 37864.62135378721, 38050.2389952205, 32251.0, 33129.0, 33389.33221335511, 33536.0, 33599.0, 25723.614145788204, 25774.0, 25864.353391165372, 26266.212013639622, 26482.0], "value": 18115.00898175023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.72901697828496, 392.9685625149987, 395.08340649692724, 408.2855003743449, 411.86614350336146, 16946.74579881301, 17349.653006939854, 17500.824991750094, 17514.73727894081, 18700.06499675014, 14689.118652880834, 16682.749758753627, 17455.207166853306, 17560.736588951175, 17896.463106106807, 5349.438308977569, 5552.194931734896, 5566.721663916808, 5568.693721845297, 5579.776808927659, 5308.893822123555, 5468.070428027225, 5499.642523235977, 5520.889582208353, 5527.39198688144, 5379.515843574078, 5503.422140675211, 5543.6119471637, 5549.750261238234, 5553.750081246333, 5382.138857782775, 5589.105743081128, 5606.046972014747, 5619.269494965649, 5625.831225063254, 5473.480019398191, 5498.780048798083, 5504.256925315111, 5507.008738427082, 5507.091329930557, 12545.74908501834, 12814.871851281554, 12879.935600322033, 12942.870571294261, 12988.350582470934, 2149.365937048559, 2420.47959688666, 2860.8426536540483, 2923.269182704324, 2940.7206315400003, 9961.501924903798, 10039.498025098716, 12179.086568507397, 13539.458421663121, 13813.447462101503, 1921.2411097616503, 1964.5481539245911, 2087.123408168573, 2088.4152437317575, 2157.244964262511, 61849.0, 63189.05216421803, 63203.367966320206, 65029.349706502806, 66124.0, 10669.46652667379, 10732.248742587944, 10897.291676041032, 10902.563897444172, 11031.172662050378, 14290.857091428952, 14493.637659058608, 14557.41770329175, 14579.489717859824, 14588.197649129188, 6552.672366381662, 7586.582737949356, 7731.884021739678, 7817.726379576688, 7956.602169891598, 7320.560766354036, 7456.291652293024, 7505.812354691067, 7593.240675932362, 7650.73222437212, 4671.789769460383, 4796.544328288807, 4807.927881081787, 4839.540243676845, 4851.151048566487, 1939.4957311099215, 1989.552350721105, 1997.3708281891159, 2006.1273346094495, 2013.3456626596414, 932.8227636748996, 1001.3941565353002, 1017.2370721958531, 1083.4474418046852, 1148.5176225985106, 17617.559561011076, 17872.0, 18161.818381816014, 18205.362812301504, 18313.816861831478, 1029.1252435429824, 1034.3483605328595, 1079.0180935348951, 1107.1143085531703, 1137.2778285788584, 10053.145482633912, 10392.480375981171, 10433.478326083665, 10442.895571044191, 10504.054635082726, 418751.0, 420682.0, 437246.0, 444867.0, 446429.0, 71564.64217678983, 72288.27711722921, 72785.6360718193, 75935.62032189804, 76143.0, 1006.7785087280787, 1029.6602121299952, 1032.3805716569998, 1045.5713157605346, 1116.5757012335423, 15654.686906262039, 15658.843411565738, 15803.0, 15837.604059898595, 16435.72492933141, 34718.82640586781, 34720.131996700286, 35408.0, 35658.46512302266, 36951.076223094635, 34493.0, 44624.776876115415, 45905.31142032939, 46587.068258635314, 48182.5181748178, 8255.958720206601, 8378.706745263886, 8397.622107005322, 8594.011688655884, 8594.871076933976, 8858.512781797062, 9293.070692930653, 9880.0, 11887.346195959306, 13313.46746130144, 11393.658190254306, 11505.36720480348, 11590.826137608112, 11647.475863585989, 11752.58865939688, 11345.149113816662, 11376.260543064674, 11450.713732156762, 11454.541818327507, 11528.884711152781, 11485.942570287096, 11517.078633709116, 11662.300261984308, 11662.591809286634, 11677.124215683687, 8099.473534220257, 8315.085340612406, 8396.496210227406, 8637.654493820177, 8736.301095912439, 8581.914180858112, 10904.672859814218, 10936.507857146607, 11163.832542512031, 11512.079033677453], "value": 8668.706951683667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.324998130188, 1477.431188992238, 1526.3665578784805, 1615.8222595514492, 1783.6611043901657, 7204.603746793924, 7826.373890088794, 8039.598020099001, 8049.114597394297, 8050.194980501947, 7819.921800781991, 7970.442069055169, 7975.521468711881, 7985.321247693953, 8041.91958080419, 1948.3083505355607, 2195.791399817023, 2203.3610253026645, 2260.570491606598, 2274.80664143548, 2306.285051633999, 2306.538692261546, 2316.2587971849016, 2324.140068174769, 2326.8952897119584, 2154.924577639783, 2198.373463562885, 2203.0967303405605, 2203.283932721864, 2204.3386983904843, 1913.5885784556317, 2197.5934452126326, 2269.1830940861278, 2271.9204827830945, 2272.5682120397237, 2174.3911704722545, 2177.9782202178094, 2187.0923566719794, 2189.6168170570086, 2227.164813195052, 7859.174786647434, 7933.761987140338, 7937.047554293464, 7950.801229969239, 7991.520508769434, 4933.777979990909, 5127.7948882044675, 5134.0502007128425, 5138.537531622172, 5221.034108689904, 3320.518524813913, 3332.0, 3418.060033490785, 3455.4989526518766, 3464.566929133858, 1005.4218824176128, 1026.0252759878147, 1052.6841947415821, 1076.924615276931, 1094.8029354716148, 10892.40091794951, 10924.617638382699, 10924.726881827859, 10975.341479511255, 11049.447527623586, 4295.076558539867, 4324.545922678073, 4420.049689316812, 4433.556644335606, 4444.755538445352, 9293.95353023244, 9298.0, 9313.580888860017, 9321.906780932239, 9362.765930851783, 4488.079943611552, 4973.975130124399, 5089.185730283137, 5098.796048158032, 5103.132467480537, 4247.638950689165, 4263.296556068276, 4271.807768650418, 4479.55204479556, 4677.579017888338, 3721.423179407142, 3807.8286477108595, 3864.787436691009, 3865.1303456722576, 3872.3029854625875, 1209.661294837447, 1220.9511619535297, 1234.3581337704343, 1245.620085873799, 1257.1891130221138, 1009.3792317724547, 1030.0883717909553, 1033.2199189611945, 1036.2073014144187, 1048.1352883870836, 5729.312482502127, 5748.109043098327, 5779.739911703983, 5780.21967034445, 6019.367966363557, 982.5725809272989, 1023.5291765787672, 1024.4314405505015, 1036.124474818777, 1041.1046500009986, 3783.0731470789833, 3952.2293152834923, 3998.6204759357975, 4040.393940908887, 4041.5150181977765, 9664.75838104039, 9914.752131196778, 10085.798284034277, 10096.798064038825, 10145.0, 9955.30312878106, 9968.80062398748, 10093.848592271122, 10102.898971010196, 10111.443870587042, 7221.0, 7520.511166774142, 7604.0, 7637.312641862148, 7700.807479812937, 5595.104783234663, 5649.446402239417, 5755.827325180251, 5819.388964158702, 5835.387284335084, 8527.317814574695, 8837.248833848938, 9100.089991000847, 9151.359404841598, 9173.31200160004, 8964.103589640983, 9003.504807235666, 9200.309976751636, 9258.490783006999, 9283.071692830934, 6576.145101136822, 6764.661766911733, 7037.788866334018, 7059.364657180673, 7170.96414517945, 7806.609669516388, 7873.803154920944, 7931.405144614292, 7933.523988560705, 7956.0, 6998.405135563534, 7078.044463997295, 7109.893351599833, 7209.891851622335, 7291.0, 7064.399526040344, 7101.360877521048, 7106.715731370894, 7180.102487189101, 7183.568985860656, 6594.439472644879, 6726.327367263235, 6873.725050998104, 6890.8621827564175, 6904.27505111956, 5134.075866344094, 5147.510986456281, 5161.948380516147, 5163.66436181647, 5186.974065129651, 5105.157648987875, 5138.0, 5148.330717006766, 5219.243209734491, 5307.097793375058], "value": 4401.59375191606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.1422458933006, 335.1403649638677, 337.0512008695522, 342.3649130862251, 343.77826302035203, 5197.818076367328, 5249.0, 5302.840914772563, 5349.144136938091, 5362.168863826103, 5311.336082989626, 5380.139177731564, 5399.0, 5409.540189083923, 5422.240886275915, 4196.097838964622, 4197.916041679165, 4201.6218540331365, 4206.242876282268, 4235.555266696999, 3955.3671412573995, 3987.7607343559334, 4186.818018306094, 4213.536510983789, 4240.957590424087, 4106.0, 4140.648044916185, 4178.080822219107, 4188.329867221245, 4189.727667701605, 4131.211432283212, 4147.0, 4159.147374788161, 4162.188373267214, 4182.707210495267, 3431.3995050865997, 3701.0192299040777, 3712.2389910068373, 3714.201446688975, 3726.6273372662786, 5096.159133742928, 5127.8205262816, 5137.768800403991, 5138.922916156261, 5145.794168233266, 4699.177643912301, 4717.561143851124, 4721.3862197914395, 4748.928766068511, 4757.952420475785, 5411.485908838654, 5530.598681810698, 5533.667979921218, 5550.611457197998, 5564.610477266593, 4001.1197536541913, 4004.139110091315, 4005.439238506611, 4009.218202450523, 4014.1770936958146, 5824.563157763185, 5857.7949771757785, 5877.147813567051, 5887.234659494238, 5888.499477544414, 3956.2680904032845, 4100.876973690794, 4105.835766569364, 4118.546959834416, 4142.71001029925, 4101.733387329814, 4114.650254728322, 4136.73111247768, 4144.896377590584, 4178.749275043507, 4750.904981900343, 4752.928706069411, 4760.833370832004, 4765.142274390643, 4769.213079841857, 5529.364123125892, 5649.570684605577, 5673.347565030074, 5680.943190568041, 5681.346645135863, 1493.887958403124, 1494.6935878144955, 1494.7085318362815, 1498.6178524476188, 1502.8722558582424, 949.6913503111379, 952.3904700991371, 957.3872721458272, 957.712686194139, 962.2061799015839, 5727.570432217601, 5763.2507773989955, 5765.913511297334, 5773.711314434261, 5778.94221057784, 6122.510199184144, 6124.755009799647, 6126.5098792097415, 6183.96908015457, 6221.129041934133, 5511.476409741068, 5687.8862422752145, 5725.456081672234, 5732.828015159552, 5746.367899531048, 3270.689284517967, 3286.309874926292, 3287.6547962464074, 3292.37444885471, 3294.9835250823594, 5736.971315143398, 6028.186194863637, 6286.962651162598, 6317.084022816666, 6373.71318290678, 5939.287285525765, 5957.761689532457, 5964.105384192406, 5978.641281523122, 5990.101484777319, 5973.37279585646, 5978.671173085522, 5994.490468310242, 6014.72933717975, 6040.6979651018155, 5638.434512296813, 5803.970980145073, 5816.21481100063, 5828.222392170429, 5862.325832529314, 5674.659520428788, 5702.486776190163, 5723.0, 5733.0, 5761.798337058183, 5820.82537523875, 5976.760929562769, 6003.309619393825, 6004.609700369462, 6008.489278411384, 3876.961230387773, 3922.5096862892137, 4067.450894129373, 4093.2222877653153, 4114.156597897364, 5778.422157784356, 5780.21967034445, 5806.854828629149, 5807.0, 5808.448197421239, 5468.863278418072, 5569.972150139223, 5640.266765320482, 5643.209950606836, 5647.192898272678, 5562.610617256753, 5590.664560126405, 5598.1169697604955, 5601.859953501195, 5635.154726791015, 5418.674879507243, 5450.8909821802545, 5454.699991500505, 5484.8354549363585, 5491.341039075336, 5369.919451208313, 5635.577331700057, 5638.0, 5664.971675141598, 5775.711214439178, 5618.550515958796, 5619.887602247851, 5626.156076588544, 5647.85880352978, 5655.858603534944], "value": 4324.1635733009625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.599643194459, 802.1016461563047, 831.1729828820323, 860.5955201055501, 883.5847151838634, 14015.719685606282, 14094.295285235736, 14746.926265368671, 15002.399904003854, 15020.098794072363, 13702.657433564165, 13767.65580860479, 13769.311534423265, 13774.10468319561, 13834.515791947284, 706.4066184405086, 724.9057622509066, 727.4435057181234, 727.6907314391389, 816.5182542300042, 851.7189327521934, 859.0593300336122, 859.4499520307008, 859.8581234096366, 859.8882145321099, 898.2095755734944, 901.5086777706133, 902.6434558349448, 902.9548522573878, 903.1961554216753, 731.7182884589419, 869.8738682891009, 889.0975659705405, 897.4974014551839, 898.2768871058828, 653.3042309939899, 653.5098675993005, 653.7613770973608, 659.4394764450227, 664.8969409741497, 14014.649633759136, 14080.014398991972, 14088.506902258474, 14098.083624564371, 14106.858931410658, 12999.545015924397, 13373.732525349536, 13525.932370338085, 13643.727125457435, 13881.305934703225, 11252.437378131142, 11375.374354410504, 11499.885001150049, 11698.122640801888, 11756.706082347924, 4265.0, 4334.219840428722, 4386.6929314947965, 4526.909461810778, 4538.841140560097, 46700.76649616764, 47267.0, 47461.0, 48363.0, 51838.481615183744, 9614.423134611945, 9723.951380243054, 9945.104940555384, 10072.697819065439, 10199.643012494527, 18513.166907489194, 18570.164342604614, 18592.628147436975, 18640.0, 19032.33386831454, 7768.6629602309995, 8004.759857204293, 8042.798930026796, 8145.755627331189, 8386.412951093365, 4534.478534968521, 4572.108438854458, 4602.953970460319, 4605.516420775771, 4795.832145874878, 3270.198801293698, 3324.1357247115925, 3325.93348133036, 3327.1183136468853, 3333.283344081034, 681.4344094401634, 684.8664510420421, 693.1439672005171, 693.414065114977, 700.9474289428314, 597.6175247841385, 633.3096924352478, 660.7092879133166, 674.5177198303237, 684.8253695307765, 9541.761455963517, 9618.951905240428, 9799.314048016571, 10054.245931555017, 10120.291579589359, 665.0157766505503, 690.002945743396, 776.5301992294693, 787.1577412169039, 790.205843127653, 4000.9399859002137, 4225.281702110648, 4345.261305578059, 4375.190589740844, 4414.602685758297, 64396.678016609614, 65104.0, 65812.67093664501, 66204.0, 67341.0, 56148.157777633365, 57012.42987570154, 57176.71411642998, 57300.42699572951, 59412.0, 44440.0, 44833.0, 45200.321995170096, 45814.0, 52722.73638631859, 9012.369134160546, 9088.272938165062, 9109.316801239802, 9210.401323913924, 9242.168204861595, 32461.675383245863, 32666.673333266364, 33387.332253355286, 33688.66311336855, 33791.0, 41779.37330940099, 43657.0, 44041.339379908684, 44086.55913440953, 46716.299255511876, 12018.158728888893, 12158.939205303917, 12256.632301030982, 12300.507979680713, 12430.751384972069, 13167.473301068234, 14003.789943150658, 14323.0, 14573.708525829636, 14849.886258530438, 13452.192868427926, 13486.595402137951, 13906.860931390556, 13942.372593233125, 14325.355359009078, 13136.474541018251, 13382.598522044354, 13865.86134138686, 13917.791233131713, 14121.2939353034, 12909.806352904901, 13042.152260103063, 13305.467781289028, 14093.15441073539, 14113.22377269219, 11055.22613417053, 11127.88872111301, 11232.213745037769, 11394.088472922313, 11559.30644161353, 11169.535288258076, 11474.770504589695, 11519.712007199887, 11566.884331156582, 11617.535298587962], "value": 6827.3593219830145, "unit": "score"}], "name": "dromaeo_css", "value": 6851.130146617179, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 105.0, 109.0, 112.0, 109.0, 102.0, 111.0, 111.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 155.0, 194.0, 129.0, 161.0, 156.0, 135.0, 187.0, 126.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 118.0, 115.0, 76.0, 73.0, 77.0, 112.0, 104.0, 74.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 149.0, 92.0, 92.0, 93.0, 149.0, 93.0, 93.0, 153.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 75.0, 56.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 76.0, 78.0, 78.0, 77.0, 76.0, 82.0, 82.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 128.0, 126.0, 126.0, 125.0, 124.0, 126.0, 128.0, 159.0, 135.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 198.0, 201.0, 203.0, 204.0, 200.0, 202.0, 201.0, 221.0, 204.0], "value": 203.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 71.0, 68.0, 68.0, 67.0, 68.0, 76.0, 67.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1582.7, "alertThreshold": 2.0}]} 17:43:15 INFO - Return code: 0 17:43:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:43:15 ERROR - # TBPL SUCCESS # 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - Running post-run listener: _resource_record_post_run 17:43:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535302144; Read time: 16; Write time: 495704 17:43:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244363264; Read time: 0; Write time: 222672 17:43:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290766848; Read time: 16; Write time: 273004 17:43:16 INFO - Running post-run listener: _upload_blobber_files 17:43:16 INFO - Blob upload gear active. 17:43:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:43:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:43:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:43:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:43:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:17 INFO - (blobuploader) - INFO - Done attempting. 17:43:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:43:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:18 INFO - (blobuploader) - INFO - Done attempting. 17:43:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:18 INFO - Return code: 0 17:43:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f5331c4fbd76d996611f2e4e7496ebba675d9500d151cf1ab98cdc9fe1f73d7df78830de62bda03a3720fde9d78c779b3fe7ccf8cdbc24e120b45806a8f4efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1e7307d7e6aca0d368dcdf23b2f8cbc112cba3a3bebc4a6f411c3a3f242b993d2cdb296d6ec8e81673e99e74c5ac1bb939f8c0f03d892091c6e7a2c19ee162"} 17:43:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:18 INFO - Contents: 17:43:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f5331c4fbd76d996611f2e4e7496ebba675d9500d151cf1ab98cdc9fe1f73d7df78830de62bda03a3720fde9d78c779b3fe7ccf8cdbc24e120b45806a8f4efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1e7307d7e6aca0d368dcdf23b2f8cbc112cba3a3bebc4a6f411c3a3f242b993d2cdb296d6ec8e81673e99e74c5ac1bb939f8c0f03d892091c6e7a2c19ee162"} 17:43:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:18 INFO - Copying logs to upload dir... 17:43:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.682099 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-26 17:43:18.250078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:18.253502) ========= 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=920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f5331c4fbd76d996611f2e4e7496ebba675d9500d151cf1ab98cdc9fe1f73d7df78830de62bda03a3720fde9d78c779b3fe7ccf8cdbc24e120b45806a8f4efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1e7307d7e6aca0d368dcdf23b2f8cbc112cba3a3bebc4a6f411c3a3f242b993d2cdb296d6ec8e81673e99e74c5ac1bb939f8c0f03d892091c6e7a2c19ee162"} build_url:https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/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/sha512/2f5331c4fbd76d996611f2e4e7496ebba675d9500d151cf1ab98cdc9fe1f73d7df78830de62bda03a3720fde9d78c779b3fe7ccf8cdbc24e120b45806a8f4efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1e7307d7e6aca0d368dcdf23b2f8cbc112cba3a3bebc4a6f411c3a3f242b993d2cdb296d6ec8e81673e99e74c5ac1bb939f8c0f03d892091c6e7a2c19ee162"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:18.278343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:18.278740) ========= 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=920470bf432669ad7e3a5387000001ca-1461716493.148509-542925009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:18.363440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 17:43:18.363767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 17:43:18.364062) ========= ========= Total master_lag: 0.16 =========